builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1486043465.57 results: success (0) revision: dd7cce059626e9787537bf9ba7863a6ad8ac06a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.573395) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.573951) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.574440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.591232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.591534) ========= 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=af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-02 05:51:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-02-02 05:51:06 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.729975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.730350) ========= 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=af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.780584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:05.780916) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd7cce059626e9787537bf9ba7863a6ad8ac06a1 --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 dd7cce059626e9787537bf9ba7863a6ad8ac06a1 --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=af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-02 05:51:06,218 truncating revision to first 12 chars 2017-02-02 05:51:06,218 Setting DEBUG logging. 2017-02-02 05:51:06,218 attempt 1/10 2017-02-02 05:51:06,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd7cce059626?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 05:51:06,763 unpacking tar archive at: mozilla-central-dd7cce059626/testing/mozharness/ program finished with exit code 0 elapsedTime=0.839586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:06.633420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:06.633752) ========= script_repo_revision: dd7cce059626e9787537bf9ba7863a6ad8ac06a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:06.634125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:06.634387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 05:51:06.642318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-02-02 05:51:06.642597) ========= /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=af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:51:07 INFO - MultiFileLogger online at 20170202 05:51:07 in /builds/slave/test 05:51:07 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 05:51:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:07 INFO - {'append_to_log': False, 05:51:07 INFO - 'base_work_dir': '/builds/slave/test', 05:51:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:51:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:07 INFO - 'branch': 'Firefox-Non-PGO', 05:51:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:07 INFO - 'config_files': ('talos/linux_config.py',), 05:51:07 INFO - 'default_actions': ('clobber', 05:51:07 INFO - 'read-buildbot-config', 05:51:07 INFO - 'download-and-extract', 05:51:07 INFO - 'populate-webroot', 05:51:07 INFO - 'create-virtualenv', 05:51:07 INFO - 'install', 05:51:07 INFO - 'run-tests'), 05:51:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:07 INFO - 'download_minidump_stackwalk': True, 05:51:07 INFO - 'download_symbols': 'ondemand', 05:51:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:07 INFO - 'installer_path': 'installer.exe', 05:51:07 INFO - 'log_level': 'info', 05:51:07 INFO - 'log_name': 'talos', 05:51:07 INFO - 'log_to_console': True, 05:51:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:51:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:51:07 INFO - 'opt_config_files': (), 05:51:07 INFO - 'pip_index': False, 05:51:07 INFO - 'sps_profile': False, 05:51:07 INFO - 'sps_profile_interval': 0, 05:51:07 INFO - 'suite': 'dromaeojs', 05:51:07 INFO - 'system_bits': '32', 05:51:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:07 INFO - 'title': 'talos-linux64-ix-020', 05:51:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:07 INFO - 'use_talos_json': True, 05:51:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:07 INFO - 'work_dir': 'build'} 05:51:07 INFO - [mozharness: 2017-02-02 13:51:07.173143Z] Running clobber step. 05:51:07 INFO - Running pre-action listener: _resource_record_pre_action 05:51:07 INFO - Running main action method: clobber 05:51:07 INFO - rmtree: /builds/slave/test/build 05:51:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:08 INFO - Running post-action listener: _resource_record_post_action 05:51:08 INFO - [mozharness: 2017-02-02 13:51:08.152197Z] Finished clobber step (success) 05:51:08 INFO - [mozharness: 2017-02-02 13:51:08.152296Z] Running read-buildbot-config step. 05:51:08 INFO - Running pre-action listener: _resource_record_pre_action 05:51:08 INFO - Running main action method: read_buildbot_config 05:51:08 INFO - Using buildbot properties: 05:51:08 INFO - { 05:51:08 INFO - "project": "", 05:51:08 INFO - "product": "firefox", 05:51:08 INFO - "who": "cbook@mozilla.com", 05:51:08 INFO - "installer_path": "public/build/target.tar.bz2", 05:51:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:51:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:51:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:51:08 INFO - "stage_platform": "linux64", 05:51:08 INFO - "basedir": "/builds/slave/test", 05:51:08 INFO - "buildnumber": 424, 05:51:08 INFO - "platform": "ubuntu64_hw", 05:51:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:51:08 INFO - "slavebuilddir": "test", 05:51:08 INFO - "taskId": "HFSSbsHXRi6c-arTSncEvQ", 05:51:08 INFO - "branch": "mozilla-central", 05:51:08 INFO - "script_repo_revision": "production", 05:51:08 INFO - "revision": "dd7cce059626e9787537bf9ba7863a6ad8ac06a1", 05:51:08 INFO - "slavename": "talos-linux64-ix-020", 05:51:08 INFO - "repo_path": "mozilla-central" 05:51:08 INFO - } 05:51:08 INFO - Finding installer, test and symbols from parent task. 05:51:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HFSSbsHXRi6c-arTSncEvQ'}, attempt #1 05:51:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HFSSbsHXRi6c-arTSncEvQ'}, attempt #1 05:51:09 INFO - Task dependencies: Gh0ltQ5GQSGu3uxPKS4k5A 05:51:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A'}, attempt #1 05:51:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.tar.bz2 05:51:09 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/test_packages.json 05:51:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.crashreporter-symbols.zip 05:51:09 INFO - Running post-action listener: _resource_record_post_action 05:51:09 INFO - [mozharness: 2017-02-02 13:51:09.547803Z] Finished read-buildbot-config step (success) 05:51:09 INFO - [mozharness: 2017-02-02 13:51:09.548021Z] Running download-and-extract step. 05:51:09 INFO - Running pre-action listener: _resource_record_pre_action 05:51:09 INFO - Running main action method: download_and_extract 05:51:09 INFO - mkdir: /builds/slave/test/build/tests 05:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:09 INFO - trying https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.test_packages.json 05:51:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:51:10 INFO - Downloaded 896 bytes. 05:51:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:51:10 INFO - Using the following test package requirements: 05:51:10 INFO - {u'common': [u'target.common.tests.zip'], 05:51:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:51:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:51:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:51:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:51:10 INFO - u'mozbase': [u'target.common.tests.zip'], 05:51:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:51:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:51:10 INFO - u'web-platform': [u'target.common.tests.zip', 05:51:10 INFO - u'target.web-platform.tests.zip'], 05:51:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:51:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:51:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.common.tests.zip 05:51:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:51:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.common.tests.zip into memory 05:51:11 INFO - Expected file size: 39899640 05:51:11 INFO - Obtained file size: 39899640 05:51:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:51:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.common.tests.zip 05:51:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:51:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.common.tests.zip into memory 05:51:16 INFO - Expected file size: 39899640 05:51:16 INFO - Obtained file size: 39899640 05:51:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.talos.tests.zip 05:51:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:51:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.talos.tests.zip into memory 05:51:21 INFO - Expected file size: 14403454 05:51:21 INFO - Obtained file size: 14403454 05:51:22 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')]} 05:51:22 INFO - trying https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.tar.bz2 05:51:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:51:23 INFO - Downloaded 56286507 bytes. 05:51:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.tar.bz2 05:51:23 INFO - mkdir: /builds/slave/test/properties 05:51:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:23 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:23 INFO - Contents: 05:51:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.tar.bz2 05:51:23 INFO - Running post-action listener: _resource_record_post_action 05:51:23 INFO - Running post-action listener: set_extra_try_arguments 05:51:23 INFO - [mozharness: 2017-02-02 13:51:23.157865Z] Finished download-and-extract step (success) 05:51:23 INFO - [mozharness: 2017-02-02 13:51:23.157962Z] Running populate-webroot step. 05:51:23 INFO - Running pre-action listener: _resource_record_pre_action 05:51:23 INFO - Running main action method: populate_webroot 05:51:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:23 INFO - '--tppagecycles', 05:51:23 INFO - '7'], 05:51:23 INFO - 'tests': ['tsvgm']}}, 05:51:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:51:23 INFO - 'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:51:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:51:23 INFO - 'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['damp', 'tps']}, 05:51:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:51:23 INFO - 'tests': ['damp', 'tps']}, 05:51:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['dromaeo_dom']}, 05:51:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['basic_compositor_video']}, 05:51:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:51:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['a11yr', 05:51:23 INFO - 'ts_paint', 05:51:23 INFO - 'tpaint', 05:51:23 INFO - 'sessionrestore', 05:51:23 INFO - 'sessionrestore_no_auto_restore', 05:51:23 INFO - 'tabpaint']}, 05:51:23 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:23 INFO - 'ts_paint', 05:51:23 INFO - 'tpaint', 05:51:23 INFO - 'sessionrestore', 05:51:23 INFO - 'sessionrestore_no_auto_restore', 05:51:23 INFO - 'tabpaint']}, 05:51:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:51:23 INFO - 'ts_paint', 05:51:23 INFO - 'tpaint', 05:51:23 INFO - 'sessionrestore', 05:51:23 INFO - 'sessionrestore_no_auto_restore', 05:51:23 INFO - 'tabpaint']}, 05:51:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:51:23 INFO - 'ts_paint', 05:51:23 INFO - 'tpaint', 05:51:23 INFO - 'sessionrestore', 05:51:23 INFO - 'sessionrestore_no_auto_restore', 05:51:23 INFO - 'tabpaint']}, 05:51:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['a11yr', 05:51:23 INFO - 'ts_paint', 05:51:23 INFO - 'tpaint', 05:51:23 INFO - 'sessionrestore', 05:51:23 INFO - 'sessionrestore_no_auto_restore', 05:51:23 INFO - 'tabpaint']}, 05:51:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['a11yr', 05:51:23 INFO - 'ts_paint', 05:51:23 INFO - 'tpaint', 05:51:23 INFO - 'sessionrestore', 05:51:23 INFO - 'sessionrestore_no_auto_restore', 05:51:23 INFO - 'tabpaint']}, 05:51:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['tsvgx', 05:51:23 INFO - 'tsvgr_opacity', 05:51:23 INFO - 'tart', 05:51:23 INFO - 'tscrollx', 05:51:23 INFO - 'cart', 05:51:23 INFO - 'tsvg_static']}, 05:51:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:23 INFO - 'tsvgr_opacity', 05:51:23 INFO - 'tart', 05:51:23 INFO - 'tscrollx', 05:51:23 INFO - 'cart', 05:51:23 INFO - 'tsvg_static']}, 05:51:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:51:23 INFO - 'talos_options': ['--disable-e10s'], 05:51:23 INFO - 'tests': ['tp5o']}, 05:51:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:51:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:51:23 INFO - 'talos_options': ['--disable-e10s', 05:51:23 INFO - '--xperf_path', 05:51:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:23 INFO - 'tests': ['tp5n']}, 05:51:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:51:23 INFO - 'talos_options': ['--xperf_path', 05:51:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:23 INFO - 'tests': ['tp5n']}}, 05:51:23 INFO - 'talos.zip': {'path': '', 05:51:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:23 INFO - Running post-action listener: _resource_record_post_action 05:51:23 INFO - [mozharness: 2017-02-02 13:51:23.171045Z] Finished populate-webroot step (success) 05:51:23 INFO - [mozharness: 2017-02-02 13:51:23.171138Z] Running create-virtualenv step. 05:51:23 INFO - Running pre-action listener: _resource_record_pre_action 05:51:23 INFO - Running main action method: create_virtualenv 05:51:23 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:23 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 05:51:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:23 INFO - Using real prefix '/usr' 05:51:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:25 INFO - Installing pip.................done. 05:51:25 INFO - Return code: 0 05:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:51:25 INFO - Reading from file tmpfile_stdout 05:51:25 INFO - Output received: 05:51:25 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) 05:51:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51:25 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')]} 05:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:25 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')]} 05:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:25 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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51:25 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 05:51:25 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 05:51:25 INFO - Using env: {'DISPLAY': ':0', 05:51:25 INFO - 'HOME': '/home/cltbld', 05:51:25 INFO - 'LANG': 'en_US.UTF-8', 05:51:25 INFO - 'LANGUAGE': 'en_US:en', 05:51:25 INFO - 'LOGNAME': 'cltbld', 05:51:25 INFO - 'MAIL': '/var/mail/cltbld', 05:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:25 INFO - 'MOZ_NO_REMOTE': '1', 05:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:25 INFO - 'NO_EM_RESTART': '1', 05:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:25 INFO - 'PWD': '/builds/slave/test', 05:51:25 INFO - 'SHELL': '/bin/bash', 05:51:25 INFO - 'SHLVL': '1', 05:51:25 INFO - 'TERM': 'linux', 05:51:25 INFO - 'TMOUT': '86400', 05:51:25 INFO - 'USER': 'cltbld', 05:51:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:26 INFO - '_': '/tools/buildbot/bin/python'} 05:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:26 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 05:51:26 INFO - Cleaning up... 05:51:26 INFO - Return code: 0 05:51:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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', '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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:51: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 psutil>=3.1.1 05:51:26 INFO - Using env: {'DISPLAY': ':0', 05:51:26 INFO - 'HOME': '/home/cltbld', 05:51:26 INFO - 'LANG': 'en_US.UTF-8', 05:51:26 INFO - 'LANGUAGE': 'en_US:en', 05:51:26 INFO - 'LOGNAME': 'cltbld', 05:51:26 INFO - 'MAIL': '/var/mail/cltbld', 05:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:26 INFO - 'MOZ_NO_REMOTE': '1', 05:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:26 INFO - 'NO_EM_RESTART': '1', 05:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:26 INFO - 'PWD': '/builds/slave/test', 05:51:26 INFO - 'SHELL': '/bin/bash', 05:51:26 INFO - 'SHLVL': '1', 05:51:26 INFO - 'TERM': 'linux', 05:51:26 INFO - 'TMOUT': '86400', 05:51:26 INFO - 'USER': 'cltbld', 05:51:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:26 INFO - '_': '/tools/buildbot/bin/python'} 05:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:26 INFO - Downloading/unpacking psutil>=3.1.1 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:28 INFO - Installing collected packages: psutil 05:51:28 INFO - Running setup.py install for psutil 05:51:28 INFO - building 'psutil._psutil_linux' extension 05:51:28 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 05:51:28 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 05:51:28 INFO - building 'psutil._psutil_posix' extension 05:51:28 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 05:51:28 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 05:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:29 INFO - Successfully installed psutil 05:51:29 INFO - Cleaning up... 05:51:29 INFO - Return code: 0 05:51:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:51: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 mozsystemmonitor==0.3 05:51:29 INFO - Using env: {'DISPLAY': ':0', 05:51:29 INFO - 'HOME': '/home/cltbld', 05:51:29 INFO - 'LANG': 'en_US.UTF-8', 05:51:29 INFO - 'LANGUAGE': 'en_US:en', 05:51:29 INFO - 'LOGNAME': 'cltbld', 05:51:29 INFO - 'MAIL': '/var/mail/cltbld', 05:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:29 INFO - 'MOZ_NO_REMOTE': '1', 05:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:29 INFO - 'NO_EM_RESTART': '1', 05:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:29 INFO - 'PWD': '/builds/slave/test', 05:51:29 INFO - 'SHELL': '/bin/bash', 05:51:29 INFO - 'SHLVL': '1', 05:51:29 INFO - 'TERM': 'linux', 05:51:29 INFO - 'TMOUT': '86400', 05:51:29 INFO - 'USER': 'cltbld', 05:51:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:29 INFO - '_': '/tools/buildbot/bin/python'} 05:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:51:31 INFO - Installing collected packages: mozsystemmonitor 05:51:31 INFO - Running setup.py install for mozsystemmonitor 05:51:31 INFO - Successfully installed mozsystemmonitor 05:51:31 INFO - Cleaning up... 05:51:31 INFO - Return code: 0 05:51:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:51:31 INFO - Using env: {'DISPLAY': ':0', 05:51:31 INFO - 'HOME': '/home/cltbld', 05:51:31 INFO - 'LANG': 'en_US.UTF-8', 05:51:31 INFO - 'LANGUAGE': 'en_US:en', 05:51:31 INFO - 'LOGNAME': 'cltbld', 05:51:31 INFO - 'MAIL': '/var/mail/cltbld', 05:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:31 INFO - 'MOZ_NO_REMOTE': '1', 05:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:31 INFO - 'NO_EM_RESTART': '1', 05:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:31 INFO - 'PWD': '/builds/slave/test', 05:51:31 INFO - 'SHELL': '/bin/bash', 05:51:31 INFO - 'SHLVL': '1', 05:51:31 INFO - 'TERM': 'linux', 05:51:31 INFO - 'TMOUT': '86400', 05:51:31 INFO - 'USER': 'cltbld', 05:51:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:31 INFO - '_': '/tools/buildbot/bin/python'} 05:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:34 INFO - warning: no files found matching '*.txt' 05:51:34 INFO - no previously-included directories found matching 'build' 05:51:34 INFO - no previously-included directories found matching 'dist' 05:51:34 INFO - no previously-included directories found matching '.git*' 05:51:34 INFO - Installing collected packages: jsonschema, functools32 05:51:34 INFO - Running setup.py install for functools32 05:51:34 INFO - warning: no files found matching '*.txt' 05:51:34 INFO - no previously-included directories found matching 'build' 05:51:34 INFO - no previously-included directories found matching 'dist' 05:51:34 INFO - no previously-included directories found matching '.git*' 05:51:34 INFO - Successfully installed jsonschema functools32 05:51:34 INFO - Cleaning up... 05:51:34 INFO - Return code: 0 05:51:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:51:34 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')]} 05:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:34 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')]} 05:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:34 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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51:34 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 05:51:34 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 05:51:34 INFO - Using env: {'DISPLAY': ':0', 05:51:34 INFO - 'HOME': '/home/cltbld', 05:51:34 INFO - 'LANG': 'en_US.UTF-8', 05:51:34 INFO - 'LANGUAGE': 'en_US:en', 05:51:34 INFO - 'LOGNAME': 'cltbld', 05:51:34 INFO - 'MAIL': '/var/mail/cltbld', 05:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:34 INFO - 'MOZ_NO_REMOTE': '1', 05:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:34 INFO - 'NO_EM_RESTART': '1', 05:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:34 INFO - 'PWD': '/builds/slave/test', 05:51:34 INFO - 'SHELL': '/bin/bash', 05:51:34 INFO - 'SHLVL': '1', 05:51:34 INFO - 'TERM': 'linux', 05:51:34 INFO - 'TMOUT': '86400', 05:51:34 INFO - 'USER': 'cltbld', 05:51:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:34 INFO - '_': '/tools/buildbot/bin/python'} 05:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:51:34 INFO - Cleaning up... 05:51:34 INFO - Return code: 0 05:51:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:34 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')]} 05:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:34 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')]} 05:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:34 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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51:34 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 05:51:34 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 05:51:34 INFO - Using env: {'DISPLAY': ':0', 05:51:34 INFO - 'HOME': '/home/cltbld', 05:51:34 INFO - 'LANG': 'en_US.UTF-8', 05:51:34 INFO - 'LANGUAGE': 'en_US:en', 05:51:34 INFO - 'LOGNAME': 'cltbld', 05:51:34 INFO - 'MAIL': '/var/mail/cltbld', 05:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:34 INFO - 'MOZ_NO_REMOTE': '1', 05:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:34 INFO - 'NO_EM_RESTART': '1', 05:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:34 INFO - 'PWD': '/builds/slave/test', 05:51:34 INFO - 'SHELL': '/bin/bash', 05:51:34 INFO - 'SHLVL': '1', 05:51:34 INFO - 'TERM': 'linux', 05:51:34 INFO - 'TMOUT': '86400', 05:51:34 INFO - 'USER': 'cltbld', 05:51:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:34 INFO - '_': '/tools/buildbot/bin/python'} 05:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51:36 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 05:51:36 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 05:51:36 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 05:51:36 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 05:51:36 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 05:51:36 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 05:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:37 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 05:51:37 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 05:51:37 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 05:51:37 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 05:51:37 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 05:51:37 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 05:51:37 INFO - Downloading docopt-0.6.1.tar.gz 05:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:37 INFO - Running setup.py install for blobuploader 05:51:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:37 INFO - Running setup.py install for requests 05:51:37 INFO - Running setup.py install for docopt 05:51:38 INFO - Successfully installed blobuploader requests docopt 05:51:38 INFO - Cleaning up... 05:51:38 INFO - Return code: 0 05:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:38 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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51:38 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 05:51:38 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 05:51:38 INFO - Using env: {'DISPLAY': ':0', 05:51:38 INFO - 'HOME': '/home/cltbld', 05:51:38 INFO - 'LANG': 'en_US.UTF-8', 05:51:38 INFO - 'LANGUAGE': 'en_US:en', 05:51:38 INFO - 'LOGNAME': 'cltbld', 05:51:38 INFO - 'MAIL': '/var/mail/cltbld', 05:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:38 INFO - 'MOZ_NO_REMOTE': '1', 05:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:38 INFO - 'NO_EM_RESTART': '1', 05:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:38 INFO - 'PWD': '/builds/slave/test', 05:51:38 INFO - 'SHELL': '/bin/bash', 05:51:38 INFO - 'SHLVL': '1', 05:51:38 INFO - 'TERM': 'linux', 05:51:38 INFO - 'TMOUT': '86400', 05:51:38 INFO - 'USER': 'cltbld', 05:51:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:38 INFO - '_': '/tools/buildbot/bin/python'} 05:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:38 INFO - Running setup.py (path:/tmp/pip-xVjgy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:38 INFO - Running setup.py (path:/tmp/pip-S6oEH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:38 INFO - Running setup.py (path:/tmp/pip-QAiL4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:38 INFO - Running setup.py (path:/tmp/pip-lVOMej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:38 INFO - Running setup.py (path:/tmp/pip-NpExoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:38 INFO - Running setup.py (path:/tmp/pip-stF74x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:38 INFO - Running setup.py (path:/tmp/pip-B6ySdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:38 INFO - Running setup.py (path:/tmp/pip-_lPlR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:38 INFO - Running setup.py (path:/tmp/pip-qyuhTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:39 INFO - Running setup.py (path:/tmp/pip-W7_8EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:39 INFO - Running setup.py (path:/tmp/pip-FsL023-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:39 INFO - Running setup.py (path:/tmp/pip-w4mzQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:39 INFO - Running setup.py (path:/tmp/pip-_m4N09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:39 INFO - Running setup.py (path:/tmp/pip-k0HhB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:39 INFO - Running setup.py (path:/tmp/pip-DyeN_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:39 INFO - Running setup.py (path:/tmp/pip-rkvR37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:39 INFO - Running setup.py (path:/tmp/pip-c5BtTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:39 INFO - Running setup.py install for manifestparser 05:51:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:39 INFO - Running setup.py install for mozcrash 05:51:39 INFO - Running setup.py install for mozdebug 05:51:39 INFO - Running setup.py install for mozdevice 05:51:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for mozfile 05:51:40 INFO - Running setup.py install for mozhttpd 05:51:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for mozinfo 05:51:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for mozInstall 05:51:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for mozleak 05:51:40 INFO - Running setup.py install for mozlog 05:51:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for moznetwork 05:51:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for mozprocess 05:51:40 INFO - Running setup.py install for mozprofile 05:51:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for mozrunner 05:51:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Running setup.py install for mozscreenshot 05:51:41 INFO - Running setup.py install for moztest 05:51:41 INFO - Running setup.py install for mozversion 05:51:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:41 INFO - Cleaning up... 05:51:41 INFO - Return code: 0 05:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:41 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')]} 05:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:41 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')]} 05:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:41 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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51:41 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 05:51:41 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 05:51:41 INFO - Using env: {'DISPLAY': ':0', 05:51:41 INFO - 'HOME': '/home/cltbld', 05:51:41 INFO - 'LANG': 'en_US.UTF-8', 05:51:41 INFO - 'LANGUAGE': 'en_US:en', 05:51:41 INFO - 'LOGNAME': 'cltbld', 05:51:41 INFO - 'MAIL': '/var/mail/cltbld', 05:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:41 INFO - 'MOZ_NO_REMOTE': '1', 05:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:41 INFO - 'NO_EM_RESTART': '1', 05:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:41 INFO - 'PWD': '/builds/slave/test', 05:51:41 INFO - 'SHELL': '/bin/bash', 05:51:41 INFO - 'SHLVL': '1', 05:51:41 INFO - 'TERM': 'linux', 05:51:41 INFO - 'TMOUT': '86400', 05:51:41 INFO - 'USER': 'cltbld', 05:51:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:41 INFO - '_': '/tools/buildbot/bin/python'} 05:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:41 INFO - Running setup.py (path:/tmp/pip-PsJyLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:41 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)) 05:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:41 INFO - Running setup.py (path:/tmp/pip-IwwUaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:41 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)) 05:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:41 INFO - Running setup.py (path:/tmp/pip-afC8KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:41 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)) 05:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:41 INFO - Running setup.py (path:/tmp/pip-vSKN64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:41 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)) 05:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:41 INFO - Running setup.py (path:/tmp/pip-niGj0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:42 INFO - Running setup.py (path:/tmp/pip-KiSDF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:42 INFO - Running setup.py (path:/tmp/pip-Dz5qhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:42 INFO - Running setup.py (path:/tmp/pip-nGAEAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:42 INFO - Running setup.py (path:/tmp/pip-HGfjnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:42 INFO - Running setup.py (path:/tmp/pip-RKOtpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:42 INFO - Running setup.py (path:/tmp/pip-qeR77C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:42 INFO - Running setup.py (path:/tmp/pip-T76dQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:42 INFO - Running setup.py (path:/tmp/pip-fWzikH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:42 INFO - Running setup.py (path:/tmp/pip-gHpI7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:42 INFO - Running setup.py (path:/tmp/pip-vmQ6dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:42 INFO - Running setup.py (path:/tmp/pip-W94teD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:42 INFO - Running setup.py (path:/tmp/pip-IOIdl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:42 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)) 05:51:42 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)) 05:51:42 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)) 05:51:42 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)) 05:51:42 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)) 05:51:42 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)) 05:51:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51:42 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 05:51:42 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 05:51:42 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 05:51:42 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 05:51:42 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 05:51:42 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 05:51:44 INFO - Downloading blessings-1.6.tar.gz 05:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:44 INFO - Installing collected packages: blessings 05:51:44 INFO - Running setup.py install for blessings 05:51:45 INFO - Successfully installed blessings 05:51:45 INFO - Cleaning up... 05:51:45 INFO - Return code: 0 05:51:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:45 INFO - Reading from file tmpfile_stdout 05:51:45 INFO - Current package versions: 05:51:45 INFO - argparse == 1.2.1 05:51:45 INFO - blessings == 1.6 05:51:45 INFO - blobuploader == 1.2.4 05:51:45 INFO - docopt == 0.6.1 05:51:45 INFO - functools32 == 3.2.3-2 05:51:45 INFO - jsonschema == 2.5.1 05:51:45 INFO - manifestparser == 1.1 05:51:45 INFO - mozInstall == 1.12 05:51:45 INFO - mozcrash == 1.0 05:51:45 INFO - mozdebug == 0.1 05:51:45 INFO - mozdevice == 0.49 05:51:45 INFO - mozfile == 1.2 05:51:45 INFO - mozhttpd == 0.7 05:51:45 INFO - mozinfo == 0.9 05:51:45 INFO - mozleak == 0.1 05:51:45 INFO - mozlog == 3.4 05:51:45 INFO - moznetwork == 0.27 05:51:45 INFO - mozprocess == 0.24 05:51:45 INFO - mozprofile == 0.28 05:51:45 INFO - mozrunner == 6.13 05:51:45 INFO - mozscreenshot == 0.1 05:51:45 INFO - mozsystemmonitor == 0.3 05:51:45 INFO - moztest == 0.8 05:51:45 INFO - mozversion == 1.4 05:51:45 INFO - psutil == 3.1.1 05:51:45 INFO - requests == 1.2.3 05:51:45 INFO - wsgiref == 0.1.2 05:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:45 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')]} 05:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:45 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')]} 05:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:45 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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51:45 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 05:51:45 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 05:51:45 INFO - Using env: {'DISPLAY': ':0', 05:51:45 INFO - 'HOME': '/home/cltbld', 05:51:45 INFO - 'LANG': 'en_US.UTF-8', 05:51:45 INFO - 'LANGUAGE': 'en_US:en', 05:51:45 INFO - 'LOGNAME': 'cltbld', 05:51:45 INFO - 'MAIL': '/var/mail/cltbld', 05:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:45 INFO - 'MOZ_NO_REMOTE': '1', 05:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:45 INFO - 'NO_EM_RESTART': '1', 05:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:45 INFO - 'PWD': '/builds/slave/test', 05:51:45 INFO - 'SHELL': '/bin/bash', 05:51:45 INFO - 'SHLVL': '1', 05:51:45 INFO - 'TERM': 'linux', 05:51:45 INFO - 'TMOUT': '86400', 05:51:45 INFO - 'USER': 'cltbld', 05:51:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:45 INFO - '_': '/tools/buildbot/bin/python'} 05:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 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)) 05:51:45 INFO - Cleaning up... 05:51:45 INFO - Return code: 0 05:51:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:45 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')]} 05:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:45 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')]} 05:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:45 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 0x25f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', '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 05:51:45 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 05:51:45 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 05:51:45 INFO - Using env: {'DISPLAY': ':0', 05:51:45 INFO - 'HOME': '/home/cltbld', 05:51:45 INFO - 'LANG': 'en_US.UTF-8', 05:51:45 INFO - 'LANGUAGE': 'en_US:en', 05:51:45 INFO - 'LOGNAME': 'cltbld', 05:51:45 INFO - 'MAIL': '/var/mail/cltbld', 05:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:45 INFO - 'MOZ_NO_REMOTE': '1', 05:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:45 INFO - 'NO_EM_RESTART': '1', 05:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:45 INFO - 'PWD': '/builds/slave/test', 05:51:45 INFO - 'SHELL': '/bin/bash', 05:51:45 INFO - 'SHLVL': '1', 05:51:45 INFO - 'TERM': 'linux', 05:51:45 INFO - 'TMOUT': '86400', 05:51:45 INFO - 'USER': 'cltbld', 05:51:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:45 INFO - '_': '/tools/buildbot/bin/python'} 05:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:51:45 INFO - Cleaning up... 05:51:45 INFO - Return code: 0 05:51:45 INFO - Running post-action listener: _resource_record_post_action 05:51:45 INFO - Running post-action listener: _start_resource_monitoring 05:51:45 INFO - Starting resource monitoring. 05:51:45 INFO - [mozharness: 2017-02-02 13:51:45.839809Z] Finished create-virtualenv step (success) 05:51:45 INFO - [mozharness: 2017-02-02 13:51:45.840311Z] Running install step. 05:51:45 INFO - Running pre-action listener: _resource_record_pre_action 05:51:45 INFO - Running main action method: install 05:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:46 INFO - Reading from file tmpfile_stdout 05:51:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:46 INFO - Reading from file tmpfile_stdout 05:51:46 INFO - Output received: 05:51:46 INFO - Usage: mozinstall [options] installer 05:51:46 INFO - Options: 05:51:46 INFO - -h, --help show this help message and exit 05:51:46 INFO - -d DEST, --destination=DEST 05:51:46 INFO - Directory to install application into. [default: 05:51:46 INFO - "/builds/slave/test"] 05:51:46 INFO - --app=APP Application being installed. [default: firefox] 05:51:46 INFO - mkdir: /builds/slave/test/build/application 05:51:46 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'] 05:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:52:02 INFO - Reading from file tmpfile_stdout 05:52:02 INFO - Output received: 05:52:02 INFO - /builds/slave/test/build/application/firefox/firefox 05:52:02 INFO - Running post-action listener: _resource_record_post_action 05:52:02 INFO - [mozharness: 2017-02-02 13:52:02.368366Z] Finished install step (success) 05:52:02 INFO - [mozharness: 2017-02-02 13:52:02.368496Z] Running run-tests step. 05:52:02 INFO - Running pre-action listener: _resource_record_pre_action 05:52:02 INFO - Running main action method: run_tests 05:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:02 INFO - Python 2.7.3 05:52:02 INFO - Return code: 0 05:52:02 INFO - grabbing minidump binary from tooltool 05:52:02 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')]} 05:52:02 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 0x29eb850>, '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 0x29606d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:02 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 05:52:02 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 05:52:02 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 05:52:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:02 INFO - Return code: 0 05:52:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:52:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:52:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:02 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/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:52:02 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/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 05:52:02 INFO - Using env: {'DISPLAY': ':0', 05:52:02 INFO - 'HOME': '/home/cltbld', 05:52:02 INFO - 'LANG': 'en_US.UTF-8', 05:52:02 INFO - 'LANGUAGE': 'en_US:en', 05:52:02 INFO - 'LOGNAME': 'cltbld', 05:52:02 INFO - 'MAIL': '/var/mail/cltbld', 05:52:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:02 INFO - 'MOZ_NO_REMOTE': '1', 05:52:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:02 INFO - 'NO_EM_RESTART': '1', 05:52:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:02 INFO - 'PWD': '/builds/slave/test', 05:52:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:02 INFO - 'SHELL': '/bin/bash', 05:52:02 INFO - 'SHLVL': '1', 05:52:02 INFO - 'TERM': 'linux', 05:52:02 INFO - 'TMOUT': '86400', 05:52:02 INFO - 'USER': 'cltbld', 05:52:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539', 05:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:02 INFO - '_': '/tools/buildbot/bin/python'} 05:52:02 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/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:52:02 INFO - mozversion application_buildid: 20170202131905 05:52:02 INFO - mozversion application_changeset: dd7cce059626e9787537bf9ba7863a6ad8ac06a1 05:52:02 INFO - mozversion application_display_name: Nightly 05:52:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:02 INFO - mozversion application_name: Firefox 05:52:02 INFO - mozversion application_remotingname: firefox 05:52:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:52:02 INFO - mozversion application_vendor: Mozilla 05:52:02 INFO - mozversion application_version: 54.0a1 05:52:02 INFO - mozversion platform_buildid: 20170202131905 05:52:02 INFO - mozversion platform_changeset: dd7cce059626e9787537bf9ba7863a6ad8ac06a1 05:52:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:52:02 INFO - mozversion platform_version: 54.0a1 05:52:02 INFO - using testdate: 1486043522 05:52:02 INFO - actual date: 1486043522 05:52:02 INFO - starting webserver on 'localhost:60660' 05:52:02 INFO - SUITE-START | Running 2 tests 05:52:02 INFO - TEST-START | dromaeo_css 05:52:02 INFO - operating with platform_type : linux_ 05:52:02 INFO - Initialising browser for dromaeo_css test... 05:52:02 INFO - TEST-INFO | started process 5921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLBlMO/profile http://localhost:60660/getInfo.html) 05:52:06 INFO - PROCESS | 5921 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:52:06 INFO - PROCESS | 5921 | __metrics Screen width/height:1600/1200 05:52:06 INFO - PROCESS | 5921 | colorDepth:24 05:52:06 INFO - PROCESS | 5921 | Browser inner width/height: 1024/697 05:52:06 INFO - PROCESS | 5921 | __metrics 05:52:07 INFO - PROCESS | 5921 | 1486043527406 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:52:07 INFO - PROCESS | 5921 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:52:07 INFO - PROCESS | 5921 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:08 INFO - PROCESS | 5921 | console.error: PushService: 05:52:08 INFO - PROCESS | 5921 | stateChangeProcessEnqueue: Error transitioning state 05:52:08 INFO - PROCESS | 5921 | UnknownError 05:52:08 INFO - TEST-INFO | 5921: exit 0 05:52:08 INFO - Browser initialized. 05:52:08 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:08 INFO - TEST-INFO | started process 6004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLBlMO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:20 INFO - PROCESS | 6004 | RSS: Main: 154382336 05:52:20 INFO - PROCESS | 6004 | 05:55:25 INFO - PROCESS | 6004 | Cycle 1(1): loaded http://localhost:60660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60660/tests/dromaeo/cssquery-ext.html) 05:55:27 INFO - PROCESS | 6004 | RSS: Main: 290418688 05:55:27 INFO - PROCESS | 6004 | 05:57:11 INFO - PROCESS | 6004 | ************************* 05:57:11 INFO - PROCESS | 6004 | A coding exception was thrown and uncaught in a Task. 05:57:11 INFO - PROCESS | 6004 | 05:57:11 ERROR - PROCESS | 6004 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:57:11 INFO - PROCESS | 6004 | Full stack: 05:57:11 INFO - PROCESS | 6004 | ************************* 05:58:30 INFO - PROCESS | 6004 | Cycle 1(1): loaded http://localhost:60660/tests/dromaeo/cssquery-ext.html (next: http://localhost:60660/tests/dromaeo/cssquery-jquery.html) 05:58:30 INFO - PROCESS | 6004 | RSS: Main: 247410688 05:58:30 INFO - PROCESS | 6004 | 06:01:33 INFO - PROCESS | 6004 | Cycle 1(1): loaded http://localhost:60660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60660/tests/dromaeo/cssquery-mootools.html) 06:01:33 INFO - PROCESS | 6004 | RSS: Main: 188043264 06:01:33 INFO - PROCESS | 6004 | 06:04:35 INFO - PROCESS | 6004 | Cycle 1(1): loaded http://localhost:60660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60660/tests/dromaeo/cssquery-prototype.html) 06:04:36 INFO - PROCESS | 6004 | RSS: Main: 193056768 06:04:36 INFO - PROCESS | 6004 | 06:07:39 INFO - PROCESS | 6004 | Cycle 1(1): loaded http://localhost:60660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60660/tests/dromaeo/cssquery-yui.html) 06:07:40 INFO - PROCESS | 6004 | RSS: Main: 186609664 06:07:40 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | Cycle 1(1): loaded http://localhost:60660/tests/dromaeo/cssquery-yui.html (next: http://localhost:60660/tests/dromaeo/cssquery-dojo.html) 06:10:43 INFO - PROCESS | 6004 | RSS: Main: 280399872 06:10:43 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | __start_tp_report 06:10:43 INFO - PROCESS | 6004 | _x_x_mozilla_page_load 06:10:43 INFO - PROCESS | 6004 | _x_x_mozilla_page_load_details 06:10:43 INFO - PROCESS | 6004 | |i|pagename|runs| 06:10:43 INFO - PROCESS | 6004 | |0;dojo.html;2540.9872950635245;2554.8211625186245;2565.486902619476;2588.184721812629;2595.0528057259085;4514.255147900592;4616.907661846761;4716.033213191292;4735.834245801398;4739.3127996440535;4653.9534604653945;4674.252119660855;4701.177293973549;4733.360996265503;4787.71273723576;4302.139572085595;4347.630451411634;4348.826046958118;4365.061511774968;4375.321825117112;4401.031773009932;4420.093880754438;4423.601875831175;4450.933236001446;4472.97763511182;4395.211009904111;4396.120775844812;4432.534583868695;4445.466544014706;4470.888227794315;4272.551382104865;4283.507396649363;4288.742675439453;4309.84915527955;4316.395704601358;4276.18752437036;4284.443022407098;4292.635126014293;4320.567943205654;4340.240457919851;4641.930371044437;4647.581717645428;4668.416447944007;4671.696339737906;4681.297805329194;4952.257161425815;4983.07813054586;5012.072766538202;5023.171176755831;5059.671121377099;5103.795848166069;5105.642605017651;5110.182370820651;5116.897662046776;5119;4775.450823155312;4780.545848144421;4782.067496838153;4783.402074740658;4831.903361932812;5030.0945829751;5039.596832253411;5046.596272298208;5222.869428264324;5274.156135018456;4913.361263035854;4918.213085906238;4920.188168952154;4920.6555541111775;4922.75386230687;4928.088303663762;4975.900481990412;4981.302617633534;4986.725730084808;4988.27669987857;4962.330085438492;4963;4963.429205641325;4965.329680493087;4966.478519755446;4859.3682821233015;4942.332785074041;4953.876153096129;4978.10394129053;5038.420581633086;4306.332518459643;4321.8703438896255;4330.978345108318;4365.672574556921;4377.058932329564;3735.7945313008045;3740.0836794985403;3744.962550374516;3776.4901738264984;3797.487339209227;4329.285667864767;4366.737995720204;4367.978160109179;4373.278409062469;4412.558744125562;5107.259447380109;5109.182530795055;5110.361204849394;5132.076226279306;5149.845504634867;4376.321670141133;4379.671524635602;4395.934060989088;4415.668824838086;4466.9553304466535;4437.06821567468;4455.688101832905;4474.619657329164;4580.175568397721;4607.976960115178;4728.621710263102;4742.739149346819;4764.976175119103;4835.178019736723;4836.516348365276;5117.437081920912;5128.1794912813775;5133.358330208724;5145.253938178868;5182.429932707475;4767.6662633615315;4768.618510519081;4774.7851346688785;4781.808727650855;4820.3492528509605;4827.758612069312;4855.6601037927;4942.406911170682;4969.701817890938;4972.328735620645;4852.56326930578;5062.114130027304;5062.493750624908;5093.388793344822;5107.540321371094;4761.500042495488;4803.855884323476;4809.831655892027;4810.446798618063;4814.446338670958;4775.880602984953;4777.0684716479955;4794.472608013186;4797.376341075777;4821.590164835888;4756.9762151189025;4768.499307572655;4768.785404656868;4773.856784296477;4778.95221047799;4840.636952228527;4844.951550484591;4849.345338379415;4849.4908034655855;4850.248211527219;4765.4996225395835;4768.356271903387;4777.163996300703;4823.0353929215;4866.878328041827 06:10:43 INFO - PROCESS | 6004 | |1;ext.html;544.4718622935752;561.539537579185;563.5041163775877;592.7451195985724;608.7399083896333;29890.701092989064;31887.52168717471;31889.202769930762;31994.680053199518;31995.68004319959;31855.68144318556;40778.184436311254;42690.359644605356;42921.35617965733;46087.308690369675;7506.249375062491;7636.923630763705;7642.159362470124;7642.923570764305;7650.61746912655;7738.380929525624;7822.5306481611;7826.3738900888075;7836.177201393857;7839.882401763978;7485.5134416263045;7643.847123057535;10049.89950100497;10306.690799275997;10316.690499284996;10060.899391006069;10127.037931396542;10133.341332813417;10135.89864101357;10143.64497242593;9924.603015879356;10010.399376037461;10010.49947502622;10011.299209055369;10012.649557265533;30466.695333046828;30943.845280773454;37938.24123517514;38663;38730.61269387298;3559.839807208682;3640.5995340512522;3688.243909998471;3702.38910579754;3751.681107105899;24812.3796905077;26118.608220876704;26137.215883523335;26225.213243602724;27079.593806092926;3445.913852153691;3508.3684936711384;3512.824358782076;3521.6830485256196;3570.125319296763;171419;171797;172014;172278;172569;43180.3522947156;43338.78330608327;43378.132437351705;43406.7829660856;43464.78267608642;49024.509754902705;49058.075353971595;49196;49198.75400622974;49221.50778492241;13932.651683707785;14122.43510259578;14127.15237085778;14131.505397311044;14134.787978180335;10974.615888443866;11077.058450031676;11092.168087393478;11095;11096.278741881752;14628.634284142981;15205.923970380078;16752.41366552165;16818.15909204535;16829.158542072848;5815.505682016991;6720.663966801738;6855.6572171391235;6947.79156625302;7175.13898332193;788.5465857132172;797.7487091566138;816.979575510617;829.0714399872181;830.4933990265932;27058.458830823274;27553.86223068872;27647.723522764514;28286.575701364494;28349.57475637867;891.2068259249273;940.9153176214037;965.6427121964778;972.9902700973041;987.2151639446514;14198.432062717582;15065.54803355879;15113.244337783068;15250.847491525165;15304.387824486896;338986;340909;341956.2239398466;342137;344844;49327.753361232964;49821.501784982414;49866.50133498691;49927.25109123366;49929.50070499248;1163.3702895359565;1216.173002358387;1216.4525963316366;1219.8719134490927;1240.9007279417624;25536.489270214865;26760.59859102154;26995.86502067477;27269;27331.59002615002;42610.36084458797;43248.783756081015;43387.78306108449;43395;43498;275798;276227;276825;277769;278867;25510;25878.22365329043;25882.87058564695;25883.741162588132;25915.740842592088;40771.1845763089;41279.174416512105;41282.38076428796;41388.586114138474;42557.57442425536;35719.82140089387;36017.27965440729;36122.63877361193;36165.63834361728;36262.8186859064;34822.30355392928;34894.12764680904;35048.47427288542;35138.29723405466;35149.824250878584;34294.48558271678;34406.48390274198;34500.82749586236;35018.29963400667;35155.296894062485;29189.7081029187;31776.523352150198;31809.681903180674;31831.84084079565;32091.67908320887;23277.41806454852;24042.398940025938;24067.398315041562;24540.50918981646;24645.137420190207 06:10:43 INFO - PROCESS | 6004 | |2;jquery.html;366.34972923061576;378.2265267527905;385.16995873891756;387.7227782135772;400.2954799552786;13412.91502954321;16655.66688666226;17153.742693859585;18198.272069117218;18348.633027339478;16871.2285210053;17035;17051;17202.913985430056;17209.225584848682;4743.573078422941;5050.267711181877;5092.032513822362;5096.643234973553;5096.770645320969;3745.3632882410056;3901.902452438683;5009.6242781791325;5010.473900240477;5059.772310246048;5489.204065410513;5719.399463056381;5747.741351639165;5857.297124345085;5865.178874957509;5705.087186050254;5819.447152520525;5844.386339434383;5858.414158584129;5902.173695682608;5196.272521846944;5201.505856943584;5202.193659982709;5202.401723801773;5208.2968799212;17259.48221553343;21574.029168687448;21697.240596579202;21755.021024053956;21830.345089647177;2506.912258070977;2563.525747736656;2573.39525211577;2614.0850702254247;2621.17828109464;13084.803727944089;13425.530106446227;13686.247256400893;13857.514986975408;14075.788863167061;1629.1772654809363;1685.875796496411;1694.2375930831174;1701.4215166843333;1711.6063305439693;68933.65533172301;79568.60215698884;80727.19272807315;82593.58703206506;82979.58510207411;8221.630026648816;8493.915060849436;8623.482591044558;8768.85163135036;9059.139381758723;11675.781601495688;11728.765424691459;11743.236689615147;11762.235454695418;11764.764704706029;6762.729490820312;6899.6205208713;6946.583205007716;7107.75122870697;7123.608201548965;6878.518503704793;6889.621070841052;7089.539179953286;7100.822479438056;7106.680199391039;3502.2295095079044;3620.1854582719207;3648.1791596891017;3872.5740168581433;4009.4787677602308;1706.9231884565224;1728.3000384844158;1742.9302827886995;1757.5166829122093;1799.1543974332044;809.5345176523523;817.3992115794886;820.2535692519779;829.8049958259804;841.4362377207286;16758.91620541914;16935.32258709638;17488.650226995644;17732.645347092985;17920.462386128438;800.3757069485811;809.6194788449419;809.6923169195668;812.5327936436572;833.6373677450329;9332.39339442934;9341.766455838522;9620.518974051409;9710.465924374228;9824.968378320316;523280;525461;529349;529654;537716;86854.56572717096;88719.55640221758;95901;96179;101756;725.1334655087226;751.6617522115071;765.058977457719;766.0692258905457;768.2240936654019;14913.140134579604;14952;15288.923555382153;15541.922290388477;15636.765448518508;41361.379579305736;41910;41929.79035104805;42012.15975680408;42697;56071.75712971599;56543.71728141333;57766;57854.132188018055;57955;7129.536580122275;7263.891041634274;7325.267473252632;7428.182899881117;7613.08642962848;9655.372400793925;10581.841272380767;11210.495527701436;11296.548138074386;11517.769644607228;9439.716808495756;9492.667756628485;9746.951265243628;9924.354916930377;10069.89930100719;9620.13418792312;9709.417434953926;9779.80440391174;9800.705978820646;9935.65225217114;9675.080867317594;9947.801043979225;9950.555934532878;9963.601455941971;10280.434576098087;7024.578525288499;7126.35862772353;7159.603877243888;7257.165425976081;7469.887951680837;8038.437309388287;9362.578683959102;9381.671641492516;9483.66807161746;9779.902200977898 06:10:43 INFO - PROCESS | 6004 | |3;mootools.html;1301.5965050834243;1314.8093526438668;1320.0561598457114;1320.8150858879758;1321.0356439798948;6687.431568316692;7067.257937916522;7091.184513780917;7092.78721638351;7094.361507464334;6082.057281121433;6290.993441049433;6618.834529136774;6842.794716158511;6884.208316043657;1944.455552445314;1967.842572594189;1968.468513501361;1977.0510155125548;1977.7428934238528;1989.8905560194185;2069.6481598128353;2073.5438203595186;2086.155107181594;2095.067694875781;1707.1378953628462;1759.5689056181254;1919.7696276446845;1972.3984184823623;2052.384284714587;1960.3824795189469;1960.892150931698;1961.6076784643128;1967.3212741604123;1970.6945423459388;1974.2004488182308;1998.7701414337391;2091.98954005229;2099.0344441556904;2099.538101617657;7121.8219544511285;7186.640667966633;7194.244604316524;7196.208417074117;7196.640167991632;4093.7953102345064;4227.3447615619625;4227.450431443924;4239.27932251518;4244.808983595745;2684.3020814588153;2822.3649678822308;2838.4879381747096;2858.2711408590885;2861.8139820911574;1051.1118105201092;1070.464767616192;1110.6667999600088;1119.3955264157346;1126.1553834624033;9096.408733432372;9147.496887671176;9148.176664100196;9148.222401095914;9155.13026262504;3641.9453708194396;3890.6109389060866;3923.195744872294;3933.370660694275;3949.19041596472;7998.4001199910235;8001.919980800234;8011.639476223584;8011.679532818622;8013.599320033975;4272.615464608138;4282.272013757669;4282.379055037064;4285.421468101767;4285.571442855752;3813.694904407641;3862.3820188769664;3917.334053210961;3921.9607803922167;3928.175083232496;3260.1523603863166;3307;3352.6312105668358;3377.459606462954;3384.1201287665385;1138.163449864349;1152.6081132414852;1168.2114572663588;1176.3647630279554;1181.7754626620915;673.5117040145855;687.8383579858729;700.5411455496658;708.0936401406208;726.3100054947821;4635.675502714777;4654.627629789677;4705.858824235278;4763.499832517536;4839.782209800567;533.3413234655197;533.8398480455847;534.5910378560404;542.7991643092003;545.6017107511539;3003.1591154476782;3058.388322335542;3071.585335979659;3117.628243572821;3167.857446414917;7947.721829736047;8010.479318844256;8125.065617454068;8252.381071419668;8253.95873020631;8087.676492940216;8195.385346098947;8196.262336389635;8204.753857384288;8210;6487.351264873475;6496.512761542903;6571.83570410734;6610.471162307004;6610.933890661032;4778.068276686013;4786.521347865186;4799.760011999316;4829.855104346875;4852.053849499313;7466.514676546007;7556.8488630228185;7692.34615057704;7725.22747725223;7772.68909243624;7586.431017673807;7790.961045194737;7855.567943763148;7856.135825059125;7878.369730421437;5995.5803093783015;6049.969750151221;6066.605670631395;6078.571535689021;6128.754849806136;6551.80344589663;6677.899831502628;6678.298778628368;6686.398224159849;6686.598804071771;6006.759729610767;6149.969250153899;6158.661273629993;6193.4425901669065;6205.348438413902;5821.592488525763;5864;5922.407759224043;5934.495567876779;5953.761849526144;5371.865703357447;5490.5882058844945;5495.560355171497;5497.917531236954;5501.724913754377;4263.93604095945;4302.397664327059;4397;4420.624246939046;4497.662675299301;3741.457488664074;3800.5439347278502;3814.256220037066;3844.3272427325664;3946.6645335146836 06:10:43 INFO - PROCESS | 6004 | |4;prototype.html;348.84302064071164;355.05024060637805;355.18485076748857;356.5596488336904;362.98548058077694;4829.710217386955;4875.731834749087;4879.804807807684;4889.43771466281;4923.704577725339;4890.21756518957;4893.877653058676;4894;4894.167991441454;4898.8775280618;3445.758796884219;3703.90740231495;3819.3316169670197;3909.843606255746;3983.3270026588757;3891.9027024324478;3904.4728961590104;3909.159530700899;3911.159100793329;3913.4716813230134;3904.746191497558;3905;3916.9804150979207;3922.293987082324;3927.5483319418345;3894.824732887027;3907.2185562887394;3907.9804600976813;3913.66733827625;3917.5298964124204;3415.84628691707;3464.272502774395;3473.1838018065732;3490.581130264359;3533.469979503069;4746.928796068062;4757.595604373632;4760.285957106427;4764.4282686077895;4769.189237829577;4468.50846406895;4479.387420528607;4481.2381895077915;4486.237339652267;4491.169133710274;4893.437254715682;5092.6180536459915;5130.53825155734;5137.17805151174;5146.408163061258;3839.404892241707;3849.9230015399817;3854.9807250963845;3857.324968130566;3866.420036994445;5094.541491265767;5296.496832800878;5302.640325055352;5316.3620365556;5320.441353657849;3786.1670432504807;3789.1853251550497;3798.3352913240074;3799.8410484802403;3907.628775266345;3961.92076158481;3980;3987.481627388479;3993.1414745829784;3999.900002499961;4405.933910991338;4415.448068991376;4419.270820314612;4426.955730442719;4434.645228381722;4858.3441235432765;5035.345405097314;5065.341505604248;5071.18860982241;5105.9744701276995;1325.6743256743257;1341.2019848190312;1347.595721283611;1349.8785109340206;1350.1898860683511;929.1823195587839;963.0754475703263;970.1171933540444;977.7702239973601;978.7846673731767;4309.245881970643;4315.8489452869;4325.7620830853975;4327.2643650579475;4333.328334108218;5033.245013248042;5036.370453693288;5039.899202015939;5044.814468599876;5104.329538472256;4174.373843923436;4314.309710446376;4323.827046918151;4333.328334108218;4358.65130789536;2645.6692913385828;2688.2472907585907;2696.2743843939893;2700.770434513049;2713.5386984212337;4708.411448568929;4709.799001254727;4715.764211789466;4717.410323709536;4730.438955144794;4871.878203044952;5124.897502050013;5133.204353325241;5138.794448222029;5222.858627962517;4740.103958416661;4747.928781068355;4762.285657151455;4772.976135119372;4776.447654512228;4982.501749824988;5009.348784657971;5045.722485263345;5095.54776888585;5100.719460429712;4896.485868983706;4957.355543779286;4994.425641051181;4996;5007.746514068756;4632;4806.591439727523;4861.270809378621;4873.220284754422;4903.975480122576;3623.4021386470936;3690.446433035066;3696.944545831761;3701.1487357908372;3702.9259414811013;5230.947690523046;5232.555232805102;5236.921446178387;5242.711650859239;5246.554042906396;4919.4834542373965;5037.697738135724;5044.646874718735;5066.923996139987;5069.822556210515;5031.345925029723;5048.949510504848;5060.468650791761;5068.7972481101815;5069.822556210515;4987.576056035277;4993.575546078624;5000.699958002531;5006.4743201963265;5006.799728010838;4883.804647814048;5055.974720126376;5067.809064869826;5070.138076526926;5094.0830650481785;4988.925166122439;4989.451160372283;4990.675606085593;4994.750262486788;4998.2256299013325 06:10:43 INFO - PROCESS | 6004 | |5;yui.html;701.62112459272;739.0503203383653;767.7850201943456;782.9334506566939;790.928816406524;13003.284819334945;13657.453701851939;13666.726665466686;13691.110077844933;13728.244946527937;13535.187888726683;13554.186748795055;13577.389017494212;13698.109622874506;13767.380467878944;658.0491190230119;674.3223060823865;787.1616728184493;796.474326944217;826.4710585225461;820.2699597358326;827.962741676623;829.8630725930215;833.4624167412015;833.5957060825494;864.5936409887374;865.9740207793744;872.9345299102561;875.0287181228831;875.1598465473154;694.1115372323434;709.925457826931;843.439112989861;861.1388611388611;862.5687156421789;629.1663545801786;641.935806419359;642.3319747462633;642.3640595810161;642.4282388674084;14480.710385792225;14502.98479106463;14561.417543298256;14574.052686575338;14579.92710036443;12354.876451235552;12443.440045197898;12486.625401237978;12541.372931353395;12836.935815320958;12157.817632735516;12211.877881221162;12334.629961101182;12630.81053784194;13159.934200328937;4153.875383738493;4268.935965960513;4359.84740534083;4430.778461076933;4480.103979204139;68463.65768171127;69319.65340173266;70605.64697176481;70857.29142708611;70919;10370.948145259226;10418.11446027081;10752.731181720519;11081.944590276997;11295;20775.480612984495;20910.37268881936;21048.368548943556;21172;21185.894070529856;6775.457963362919;6842.384185423336;6871.106756121772;6900.378965892994;6981.092457980531;3501.1597216667815;3659.798711070917;3663.2124093320062;3672.5225720656676;3770.4155855842387;2799.720027997225;2834.291427143214;2849.6722876869426;2854.4005758790886;2864.957025644617;478.3207844860307;479.439056304125;491.5109466081272;491.71971975974066;491.85981995131215;565.8557067947729;599.8800239951939;602.807101727443;605.0772571827997;606.754264522869;8445;8605.569721513899;8777.648894044294;8802.471851688919;9184.8622270666;539.164295342218;549.7333793110338;568.8265079150899;605.948494377974;615.9260888693385;4024.939625905614;4071.42999980003;4156.958430415718;4204.096119334296;4281.443412356373;66046;66365;66520.66739666367;67436;67495.3250467489;58508;58596.70701646464;59045;59683.104753428735;62012;54220.204585679414;54431.45568544422;54785.72607136939;54955.725221373636;55242.72378638081;7600.46796724224;7615.390768738598;7968.760937171663;8187.590620469072;8291.83416331682;31136.377272454876;31464;31995.040148795575;34359;39903.2019359617;45243.32135017912;45615.31577026281;46895.531044690484;47181.52818471771;48567.757161213965;11473.942630286796;11553.364564949008;11867.703307417038;11973.461194246105;12188.817167742314;11360.659180224606;11487;13153.60539183826;13194.736105278032;13234.933825331196;9552.761180970254;9925.950370248103;11306.533919102074;11855.703607409883;12099.516019359478;12333.260004399406;12861.549845755353;13063.150895191782;13309;13401.932990334986;12011.399430028288;12386.442610082748;12417.379131043592;12908.16096953695;13184.736305274033;10359.844602331123;10470.371777693363;10664.626738064131;11067.391293478613;11365.886341136484;9381.624735010522;9528.428294302365;10279.932143692175;10404;10509.474526273503 06:10:43 INFO - PROCESS | 6004 | __end_tp_report 06:10:43 INFO - PROCESS | 6004 | __start_cc_report 06:10:43 INFO - PROCESS | 6004 | _x_x_mozilla_cycle_collect,1557 06:10:43 INFO - PROCESS | 6004 | __end_cc_report 06:10:43 INFO - PROCESS | 6004 | __startTimestamp1486044643827__endTimestamp 06:10:43 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | ------- Summary: start ------- 06:10:43 INFO - PROCESS | 6004 | Number of tests: 6 06:10:43 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | [#0] dojo.html Cycles:165 Average:4649.27 Median:4775.45 stddev:483.17 (10.1%) stddev-sans-first:455.47 06:10:43 INFO - PROCESS | 6004 | Values: 2541.0 2554.8 2565.5 2588.2 2595.1 4514.3 4616.9 4716.0 4735.8 4739.3 4654.0 4674.3 4701.2 4733.4 4787.7 4302.1 4347.6 4348.8 4365.1 4375.3 4401.0 4420.1 4423.6 4450.9 4473.0 4395.2 4396.1 4432.5 4445.5 4470.9 4272.6 4283.5 4288.7 4309.8 4316.4 4276.2 4284.4 4292.6 4320.6 4340.2 4641.9 4647.6 4668.4 4671.7 4681.3 4952.3 4983.1 5012.1 5023.2 5059.7 5103.8 5105.6 5110.2 5116.9 5119.0 4775.5 4780.5 4782.1 4783.4 4831.9 5030.1 5039.6 5046.6 5222.9 5274.2 4913.4 4918.2 4920.2 4920.7 4922.8 4928.1 4975.9 4981.3 4986.7 4988.3 4962.3 4963.0 4963.4 4965.3 4966.5 4859.4 4942.3 4953.9 4978.1 5038.4 4306.3 4321.9 4331.0 4365.7 4377.1 3735.8 3740.1 3745.0 3776.5 3797.5 4329.3 4366.7 4368.0 4373.3 4412.6 5107.3 5109.2 5110.4 5132.1 5149.8 4376.3 4379.7 4395.9 4415.7 4467.0 4437.1 4455.7 4474.6 4580.2 4608.0 4728.6 4742.7 4765.0 4835.2 4836.5 5117.4 5128.2 5133.4 5145.3 5182.4 4767.7 4768.6 4774.8 4781.8 4820.3 4827.8 4855.7 4942.4 4969.7 4972.3 4852.6 5062.1 5062.5 5093.4 5107.5 4761.5 4803.9 4809.8 4810.4 4814.4 4775.9 4777.1 4794.5 4797.4 4821.6 4757.0 4768.5 4768.8 4773.9 4779.0 4840.6 4845.0 4849.3 4849.5 4850.2 4765.5 4768.4 4777.2 4823.0 4866.9 06:10:43 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | [#1] ext.html Cycles:180 Average:41987.44 Median:18926.20 stddev:71582.73 (378.2%) stddev-sans-first:71715.91 06:10:43 INFO - PROCESS | 6004 | Values: 544.5 561.5 563.5 592.7 608.7 29890.7 31887.5 31889.2 31994.7 31995.7 31855.7 40778.2 42690.4 42921.4 46087.3 7506.2 7636.9 7642.2 7642.9 7650.6 7738.4 7822.5 7826.4 7836.2 7839.9 7485.5 7643.8 10049.9 10306.7 10316.7 10060.9 10127.0 10133.3 10135.9 10143.6 9924.6 10010.4 10010.5 10011.3 10012.6 30466.7 30943.8 37938.2 38663.0 38730.6 3559.8 3640.6 3688.2 3702.4 3751.7 24812.4 26118.6 26137.2 26225.2 27079.6 3445.9 3508.4 3512.8 3521.7 3570.1 171419.0 171797.0 172014.0 172278.0 172569.0 43180.4 43338.8 43378.1 43406.8 43464.8 49024.5 49058.1 49196.0 49198.8 49221.5 13932.7 14122.4 14127.2 14131.5 14134.8 10974.6 11077.1 11092.2 11095.0 11096.3 14628.6 15205.9 16752.4 16818.2 16829.2 5815.5 6720.7 6855.7 6947.8 7175.1 788.5 797.7 817.0 829.1 830.5 27058.5 27553.9 27647.7 28286.6 28349.6 891.2 940.9 965.6 973.0 987.2 14198.4 15065.5 15113.2 15250.8 15304.4 338986.0 340909.0 341956.2 342137.0 344844.0 49327.8 49821.5 49866.5 49927.3 49929.5 1163.4 1216.2 1216.5 1219.9 1240.9 25536.5 26760.6 26995.9 27269.0 27331.6 42610.4 43248.8 43387.8 43395.0 43498.0 275798.0 276227.0 276825.0 277769.0 278867.0 25510.0 25878.2 25882.9 25883.7 25915.7 40771.2 41279.2 41282.4 41388.6 42557.6 35719.8 36017.3 36122.6 36165.6 36262.8 34822.3 34894.1 35048.5 35138.3 35149.8 34294.5 34406.5 34500.8 35018.3 35155.3 29189.7 31776.5 31809.7 31831.8 32091.7 23277.4 24042.4 24067.4 24540.5 24645.1 06:10:43 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | [#2] jquery.html Cycles:180 Average:29136.33 Median:533685.00 stddev:87236.90 (16.3%) stddev-sans-first:87454.87 06:10:43 INFO - PROCESS | 6004 | Values: 366.3 378.2 385.2 387.7 400.3 13412.9 16655.7 17153.7 18198.3 18348.6 16871.2 17035.0 17051.0 17202.9 17209.2 4743.6 5050.3 5092.0 5096.6 5096.8 3745.4 3901.9 5009.6 5010.5 5059.8 5489.2 5719.4 5747.7 5857.3 5865.2 5705.1 5819.4 5844.4 5858.4 5902.2 5196.3 5201.5 5202.2 5202.4 5208.3 17259.5 21574.0 21697.2 21755.0 21830.3 2506.9 2563.5 2573.4 2614.1 2621.2 13084.8 13425.5 13686.2 13857.5 14075.8 1629.2 1685.9 1694.2 1701.4 1711.6 68933.7 79568.6 80727.2 82593.6 82979.6 8221.6 8493.9 8623.5 8768.9 9059.1 11675.8 11728.8 11743.2 11762.2 11764.8 6762.7 6899.6 6946.6 7107.8 7123.6 6878.5 6889.6 7089.5 7100.8 7106.7 3502.2 3620.2 3648.2 3872.6 4009.5 1706.9 1728.3 1742.9 1757.5 1799.2 809.5 817.4 820.3 829.8 841.4 16758.9 16935.3 17488.7 17732.6 17920.5 800.4 809.6 809.7 812.5 833.6 9332.4 9341.8 9620.5 9710.5 9825.0 523280.0 525461.0 529349.0 529654.0 537716.0 86854.6 88719.6 95901.0 96179.0 101756.0 725.1 751.7 765.1 766.1 768.2 14913.1 14952.0 15288.9 15541.9 15636.8 41361.4 41910.0 41929.8 42012.2 42697.0 56071.8 56543.7 57766.0 57854.1 57955.0 7129.5 7263.9 7325.3 7428.2 7613.1 9655.4 10581.8 11210.5 11296.5 11517.8 9439.7 9492.7 9747.0 9924.4 10069.9 9620.1 9709.4 9779.8 9800.7 9935.7 9675.1 9947.8 9950.6 9963.6 10280.4 7024.6 7126.4 7159.6 7257.2 7469.9 8038.4 9362.6 9381.7 9483.7 9779.9 06:10:43 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | [#3] mootools.html Cycles:180 Average:4565.32 Median:4793.14 stddev:2468.70 (51.5%) stddev-sans-first:2463.44 06:10:43 INFO - PROCESS | 6004 | Values: 1301.6 1314.8 1320.1 1320.8 1321.0 6687.4 7067.3 7091.2 7092.8 7094.4 6082.1 6291.0 6618.8 6842.8 6884.2 1944.5 1967.8 1968.5 1977.1 1977.7 1989.9 2069.6 2073.5 2086.2 2095.1 1707.1 1759.6 1919.8 1972.4 2052.4 1960.4 1960.9 1961.6 1967.3 1970.7 1974.2 1998.8 2092.0 2099.0 2099.5 7121.8 7186.6 7194.2 7196.2 7196.6 4093.8 4227.3 4227.5 4239.3 4244.8 2684.3 2822.4 2838.5 2858.3 2861.8 1051.1 1070.5 1110.7 1119.4 1126.2 9096.4 9147.5 9148.2 9148.2 9155.1 3641.9 3890.6 3923.2 3933.4 3949.2 7998.4 8001.9 8011.6 8011.7 8013.6 4272.6 4282.3 4282.4 4285.4 4285.6 3813.7 3862.4 3917.3 3922.0 3928.2 3260.2 3307.0 3352.6 3377.5 3384.1 1138.2 1152.6 1168.2 1176.4 1181.8 673.5 687.8 700.5 708.1 726.3 4635.7 4654.6 4705.9 4763.5 4839.8 533.3 533.8 534.6 542.8 545.6 3003.2 3058.4 3071.6 3117.6 3167.9 7947.7 8010.5 8125.1 8252.4 8254.0 8087.7 8195.4 8196.3 8204.8 8210.0 6487.4 6496.5 6571.8 6610.5 6610.9 4778.1 4786.5 4799.8 4829.9 4852.1 7466.5 7556.8 7692.3 7725.2 7772.7 7586.4 7791.0 7855.6 7856.1 7878.4 5995.6 6050.0 6066.6 6078.6 6128.8 6551.8 6677.9 6678.3 6686.4 6686.6 6006.8 6150.0 6158.7 6193.4 6205.3 5821.6 5864.0 5922.4 5934.5 5953.8 5371.9 5490.6 5495.6 5497.9 5501.7 4263.9 4302.4 4397.0 4420.6 4497.7 3741.5 3800.5 3814.3 3844.3 3946.7 06:10:43 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | [#4] prototype.html Cycles:180 Average:4219.56 Median:4761.29 stddev:1177.04 (24.7%) stddev-sans-first:1143.93 06:10:43 INFO - PROCESS | 6004 | Values: 348.8 355.1 355.2 356.6 363.0 4829.7 4875.7 4879.8 4889.4 4923.7 4890.2 4893.9 4894.0 4894.2 4898.9 3445.8 3703.9 3819.3 3909.8 3983.3 3891.9 3904.5 3909.2 3911.2 3913.5 3904.7 3905.0 3917.0 3922.3 3927.5 3894.8 3907.2 3908.0 3913.7 3917.5 3415.8 3464.3 3473.2 3490.6 3533.5 4746.9 4757.6 4760.3 4764.4 4769.2 4468.5 4479.4 4481.2 4486.2 4491.2 4893.4 5092.6 5130.5 5137.2 5146.4 3839.4 3849.9 3855.0 3857.3 3866.4 5094.5 5296.5 5302.6 5316.4 5320.4 3786.2 3789.2 3798.3 3799.8 3907.6 3961.9 3980.0 3987.5 3993.1 3999.9 4405.9 4415.4 4419.3 4427.0 4434.6 4858.3 5035.3 5065.3 5071.2 5106.0 1325.7 1341.2 1347.6 1349.9 1350.2 929.2 963.1 970.1 977.8 978.8 4309.2 4315.8 4325.8 4327.3 4333.3 5033.2 5036.4 5039.9 5044.8 5104.3 4174.4 4314.3 4323.8 4333.3 4358.7 2645.7 2688.2 2696.3 2700.8 2713.5 4708.4 4709.8 4715.8 4717.4 4730.4 4871.9 5124.9 5133.2 5138.8 5222.9 4740.1 4747.9 4762.3 4773.0 4776.4 4982.5 5009.3 5045.7 5095.5 5100.7 4896.5 4957.4 4994.4 4996.0 5007.7 4632.0 4806.6 4861.3 4873.2 4904.0 3623.4 3690.4 3696.9 3701.1 3702.9 5230.9 5232.6 5236.9 5242.7 5246.6 4919.5 5037.7 5044.6 5066.9 5069.8 5031.3 5048.9 5060.5 5068.8 5069.8 4987.6 4993.6 5000.7 5006.5 5006.8 4883.8 5056.0 5067.8 5070.1 5094.1 4988.9 4989.5 4990.7 4994.8 4998.2 06:10:43 INFO - PROCESS | 6004 | 06:10:43 INFO - PROCESS | 6004 | [#5] yui.html Cycles:180 Average:15461.07 Median:24861.71 stddev:19275.33 (77.5%) stddev-sans-first:19297.53 06:10:43 INFO - PROCESS | 6004 | Values: 701.6 739.1 767.8 782.9 790.9 13003.3 13657.5 13666.7 13691.1 13728.2 13535.2 13554.2 13577.4 13698.1 13767.4 658.0 674.3 787.2 796.5 826.5 820.3 828.0 829.9 833.5 833.6 864.6 866.0 872.9 875.0 875.2 694.1 709.9 843.4 861.1 862.6 629.2 641.9 642.3 642.4 642.4 14480.7 14503.0 14561.4 14574.1 14579.9 12354.9 12443.4 12486.6 12541.4 12836.9 12157.8 12211.9 12334.6 12630.8 13159.9 4153.9 4268.9 4359.8 4430.8 4480.1 68463.7 69319.7 70605.6 70857.3 70919.0 10370.9 10418.1 10752.7 11081.9 11295.0 20775.5 20910.4 21048.4 21172.0 21185.9 6775.5 6842.4 6871.1 6900.4 6981.1 3501.2 3659.8 3663.2 3672.5 3770.4 2799.7 2834.3 2849.7 2854.4 2865.0 478.3 479.4 491.5 491.7 491.9 565.9 599.9 602.8 605.1 606.8 8445.0 8605.6 8777.6 8802.5 9184.9 539.2 549.7 568.8 605.9 615.9 4024.9 4071.4 4157.0 4204.1 4281.4 66046.0 66365.0 66520.7 67436.0 67495.3 58508.0 58596.7 59045.0 59683.1 62012.0 54220.2 54431.5 54785.7 54955.7 55242.7 7600.5 7615.4 7968.8 8187.6 8291.8 31136.4 31464.0 31995.0 34359.0 39903.2 45243.3 45615.3 46895.5 47181.5 48567.8 11473.9 11553.4 11867.7 11973.5 12188.8 11360.7 11487.0 13153.6 13194.7 13234.9 9552.8 9926.0 11306.5 11855.7 12099.5 12333.3 12861.5 13063.2 13309.0 13401.9 12011.4 12386.4 12417.4 12908.2 13184.7 10359.8 10470.4 10664.6 11067.4 11365.9 9381.6 9528.4 10279.9 10404.0 10509.5 06:10:43 INFO - PROCESS | 6004 | -------- Summary: end -------- 06:10:43 INFO - PROCESS | 6004 | 06:10:44 INFO - TEST-INFO | 6004: exit 0 06:10:44 INFO - TEST-OK | dromaeo_css | took 1121984ms 06:10:44 INFO - TEST-START | kraken 06:10:44 INFO - operating with platform_type : linux_ 06:10:44 INFO - Initialising browser for kraken test... 06:10:44 INFO - TEST-INFO | started process 6308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XsGSN/profile http://localhost:60660/getInfo.html) 06:10:48 INFO - PROCESS | 6308 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 06:10:48 INFO - PROCESS | 6308 | __metrics Screen width/height:1600/1200 06:10:48 INFO - PROCESS | 6308 | colorDepth:24 06:10:48 INFO - PROCESS | 6308 | Browser inner width/height: 1024/697 06:10:48 INFO - PROCESS | 6308 | __metrics 06:10:49 INFO - PROCESS | 6308 | 1486044649223 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 06:10:49 INFO - PROCESS | 6308 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:10:49 INFO - PROCESS | 6308 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:10:49 INFO - PROCESS | 6308 | console.error: PushService: 06:10:49 INFO - PROCESS | 6308 | stateChangeProcessEnqueue: Error transitioning state 06:10:49 INFO - PROCESS | 6308 | UnknownError 06:10:50 INFO - TEST-INFO | 6308: exit 0 06:10:50 INFO - Browser initialized. 06:10:50 INFO - Running cycle 1/1 for kraken test... 06:10:50 INFO - TEST-INFO | started process 6396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XsGSN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:02 INFO - PROCESS | 6396 | RSS: Main: 154537984 06:11:02 INFO - PROCESS | 6396 | 06:11:05 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60660/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:06 INFO - PROCESS | 6396 | RSS: Main: 209018880 06:11:06 INFO - PROCESS | 6396 | 06:11:09 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60660/tests/kraken/driver.html?testName=audio-dft) 06:11:09 INFO - PROCESS | 6396 | RSS: Main: 187834368 06:11:09 INFO - PROCESS | 6396 | 06:11:12 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60660/tests/kraken/driver.html?testName=audio-fft) 06:11:13 INFO - PROCESS | 6396 | RSS: Main: 270184448 06:11:13 INFO - PROCESS | 6396 | 06:11:15 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60660/tests/kraken/driver.html?testName=audio-oscillator) 06:11:16 INFO - PROCESS | 6396 | RSS: Main: 180563968 06:11:16 INFO - PROCESS | 6396 | 06:11:18 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:19 INFO - PROCESS | 6396 | RSS: Main: 185319424 06:11:19 INFO - PROCESS | 6396 | 06:11:22 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60660/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:22 INFO - PROCESS | 6396 | RSS: Main: 224894976 06:11:22 INFO - PROCESS | 6396 | 06:11:26 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60660/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:26 INFO - PROCESS | 6396 | RSS: Main: 224313344 06:11:26 INFO - PROCESS | 6396 | 06:11:29 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60660/tests/kraken/driver.html?testName=json-parse-financial) 06:11:30 INFO - PROCESS | 6396 | RSS: Main: 223162368 06:11:30 INFO - PROCESS | 6396 | 06:11:31 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:32 INFO - PROCESS | 6396 | RSS: Main: 185364480 06:11:32 INFO - PROCESS | 6396 | 06:11:34 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60660/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:35 INFO - PROCESS | 6396 | RSS: Main: 192561152 06:11:35 INFO - PROCESS | 6396 | 06:11:37 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:11:37 INFO - PROCESS | 6396 | RSS: Main: 200126464 06:11:37 INFO - PROCESS | 6396 | 06:11:40 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:11:41 INFO - PROCESS | 6396 | RSS: Main: 209891328 06:11:41 INFO - PROCESS | 6396 | 06:11:44 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:11:45 INFO - PROCESS | 6396 | RSS: Main: 206913536 06:11:45 INFO - PROCESS | 6396 | 06:11:46 INFO - PROCESS | 6396 | Cycle 1(1): loaded http://localhost:60660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60660/tests/kraken/driver.html?testName=ai-astar) 06:11:47 INFO - PROCESS | 6396 | RSS: Main: 258457600 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | __start_tp_report 06:11:47 INFO - PROCESS | 6396 | _x_x_mozilla_page_load 06:11:47 INFO - PROCESS | 6396 | _x_x_mozilla_page_load_details 06:11:47 INFO - PROCESS | 6396 | |i|pagename|runs| 06:11:47 INFO - PROCESS | 6396 | |0;ai-astar;115;118;115;116;116;116;114;115;115;114 06:11:47 INFO - PROCESS | 6396 | |1;audio-beat-detection;155;124;123;167;126;123;124;124;156;124 06:11:47 INFO - PROCESS | 6396 | |2;audio-dft;162;160;161;162;163;161;163;161;162;162 06:11:47 INFO - PROCESS | 6396 | |3;audio-fft;75;77;77;116;76;77;77;78;102;76 06:11:47 INFO - PROCESS | 6396 | |4;audio-oscillator;85;85;103;84;84;84;103;85;84;104 06:11:47 INFO - PROCESS | 6396 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;117;117 06:11:47 INFO - PROCESS | 6396 | |6;imaging-darkroom;149;149;149;150;150;149;149;149;151;150 06:11:47 INFO - PROCESS | 6396 | |7;imaging-desaturate;95;95;95;96;97;96;95;95;96;95 06:11:47 INFO - PROCESS | 6396 | |8;json-parse-financial;61;59;60;59;61;61;62;60;60;61 06:11:47 INFO - PROCESS | 6396 | |9;json-stringify-tinderbox;68;67;67;67;68;67;67;67;67;68 06:11:47 INFO - PROCESS | 6396 | |10;stanford-crypto-aes;98;86;85;89;94;87;86;85;86;84 06:11:47 INFO - PROCESS | 6396 | |11;stanford-crypto-ccm;134;135;132;135;131;132;138;133;173;152 06:11:47 INFO - PROCESS | 6396 | |12;stanford-crypto-pbkdf2;183;182;178;178;181;179;186;182;182;177 06:11:47 INFO - PROCESS | 6396 | |13;stanford-crypto-sha256-iterative;67;68;67;67;68;66;67;67;68;71 06:11:47 INFO - PROCESS | 6396 | __end_tp_report 06:11:47 INFO - PROCESS | 6396 | __start_cc_report 06:11:47 INFO - PROCESS | 6396 | _x_x_mozilla_cycle_collect,1879 06:11:47 INFO - PROCESS | 6396 | __end_cc_report 06:11:47 INFO - PROCESS | 6396 | __startTimestamp1486044707154__endTimestamp 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | ------- Summary: start ------- 06:11:47 INFO - PROCESS | 6396 | Number of tests: 14 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.50 stddev:1.17 (1.0%) stddev-sans-first:1.24 06:11:47 INFO - PROCESS | 6396 | Values: 115.0 118.0 115.0 116.0 116.0 116.0 114.0 115.0 115.0 114.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:125.00 stddev:17.37 (13.9%) stddev-sans-first:16.79 06:11:47 INFO - PROCESS | 6396 | Values: 155.0 124.0 123.0 167.0 126.0 123.0 124.0 124.0 156.0 124.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 06:11:47 INFO - PROCESS | 6396 | Values: 162.0 160.0 161.0 162.0 163.0 161.0 163.0 161.0 162.0 162.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#3] audio-fft Cycles:10 Average:83.10 Median:77.00 stddev:14.07 (18.3%) stddev-sans-first:14.61 06:11:47 INFO - PROCESS | 6396 | Values: 75.0 77.0 77.0 116.0 76.0 77.0 77.0 78.0 102.0 76.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:9.15 (10.9%) stddev-sans-first:9.51 06:11:47 INFO - PROCESS | 6396 | Values: 85.0 85.0 103.0 84.0 84.0 84.0 103.0 85.0 84.0 104.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:11:47 INFO - PROCESS | 6396 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:11:47 INFO - PROCESS | 6396 | Values: 149.0 149.0 149.0 150.0 150.0 149.0 149.0 149.0 151.0 150.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:11:47 INFO - PROCESS | 6396 | Values: 95.0 95.0 95.0 96.0 97.0 96.0 95.0 95.0 96.0 95.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:61.00 stddev:0.97 (1.6%) stddev-sans-first:1.00 06:11:47 INFO - PROCESS | 6396 | Values: 61.0 59.0 60.0 59.0 61.0 61.0 62.0 60.0 60.0 61.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 06:11:47 INFO - PROCESS | 6396 | Values: 68.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:86.50 stddev:4.52 (5.2%) stddev-sans-first:3.02 06:11:47 INFO - PROCESS | 6396 | Values: 98.0 86.0 85.0 89.0 94.0 87.0 86.0 85.0 86.0 84.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:135.00 stddev:13.24 (9.8%) stddev-sans-first:13.90 06:11:47 INFO - PROCESS | 6396 | Values: 134.0 135.0 132.0 135.0 131.0 132.0 138.0 133.0 173.0 152.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:182.00 stddev:2.78 (1.5%) stddev-sans-first:2.83 06:11:47 INFO - PROCESS | 6396 | Values: 183.0 182.0 178.0 178.0 181.0 179.0 186.0 182.0 182.0 177.0 06:11:47 INFO - PROCESS | 6396 | 06:11:47 INFO - PROCESS | 6396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 06:11:47 INFO - PROCESS | 6396 | Values: 67.0 68.0 67.0 67.0 68.0 66.0 67.0 67.0 68.0 71.0 06:11:47 INFO - PROCESS | 6396 | -------- Summary: end -------- 06:11:47 INFO - PROCESS | 6396 | 06:11:48 INFO - TEST-INFO | 6396: exit 0 06:11:48 INFO - TEST-OK | kraken | took 63694ms 06:11:48 INFO - SUITE-END | took 1185s 06:11:48 INFO - Completed test suite (00:19:46) 06:11:48 INFO - javascript benchmark 06:11:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6270.184111553285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2540.9872950635245, 2554.8211625186245, 2565.486902619476, 2588.184721812629, 2595.0528057259085, 4514.255147900592, 4616.907661846761, 4716.033213191292, 4735.834245801398, 4739.3127996440535, 4653.9534604653945, 4674.252119660855, 4701.177293973549, 4733.360996265503, 4787.71273723576, 4302.139572085595, 4347.630451411634, 4348.826046958118, 4365.061511774968, 4375.321825117112, 4401.031773009932, 4420.093880754438, 4423.601875831175, 4450.933236001446, 4472.97763511182, 4395.211009904111, 4396.120775844812, 4432.534583868695, 4445.466544014706, 4470.888227794315, 4272.551382104865, 4283.507396649363, 4288.742675439453, 4309.84915527955, 4316.395704601358, 4276.18752437036, 4284.443022407098, 4292.635126014293, 4320.567943205654, 4340.240457919851, 4641.930371044437, 4647.581717645428, 4668.416447944007, 4671.696339737906, 4681.297805329194, 4952.257161425815, 4983.07813054586, 5012.072766538202, 5023.171176755831, 5059.671121377099, 5103.795848166069, 5105.642605017651, 5110.182370820651, 5116.897662046776, 5119.0, 4775.450823155312, 4780.545848144421, 4782.067496838153, 4783.402074740658, 4831.903361932812, 5030.0945829751, 5039.596832253411, 5046.596272298208, 5222.869428264324, 5274.156135018456, 4913.361263035854, 4918.213085906238, 4920.188168952154, 4920.6555541111775, 4922.75386230687, 4928.088303663762, 4975.900481990412, 4981.302617633534, 4986.725730084808, 4988.27669987857, 4962.330085438492, 4963.0, 4963.429205641325, 4965.329680493087, 4966.478519755446, 4859.3682821233015, 4942.332785074041, 4953.876153096129, 4978.10394129053, 5038.420581633086, 4306.332518459643, 4321.8703438896255, 4330.978345108318, 4365.672574556921, 4377.058932329564, 3735.7945313008045, 3740.0836794985403, 3744.962550374516, 3776.4901738264984, 3797.487339209227, 4329.285667864767, 4366.737995720204, 4367.978160109179, 4373.278409062469, 4412.558744125562, 5107.259447380109, 5109.182530795055, 5110.361204849394, 5132.076226279306, 5149.845504634867, 4376.321670141133, 4379.671524635602, 4395.934060989088, 4415.668824838086, 4466.9553304466535, 4437.06821567468, 4455.688101832905, 4474.619657329164, 4580.175568397721, 4607.976960115178, 4728.621710263102, 4742.739149346819, 4764.976175119103, 4835.178019736723, 4836.516348365276, 5117.437081920912, 5128.1794912813775, 5133.358330208724, 5145.253938178868, 5182.429932707475, 4767.6662633615315, 4768.618510519081, 4774.7851346688785, 4781.808727650855, 4820.3492528509605, 4827.758612069312, 4855.6601037927, 4942.406911170682, 4969.701817890938, 4972.328735620645, 4852.56326930578, 5062.114130027304, 5062.493750624908, 5093.388793344822, 5107.540321371094, 4761.500042495488, 4803.855884323476, 4809.831655892027, 4810.446798618063, 4814.446338670958, 4775.880602984953, 4777.0684716479955, 4794.472608013186, 4797.376341075777, 4821.590164835888, 4756.9762151189025, 4768.499307572655, 4768.785404656868, 4773.856784296477, 4778.95221047799, 4840.636952228527, 4844.951550484591, 4849.345338379415, 4849.4908034655855, 4850.248211527219, 4765.4996225395835, 4768.356271903387, 4777.163996300703, 4823.0353929215, 4866.878328041827], "value": 4617.999685302383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.4718622935752, 561.539537579185, 563.5041163775877, 592.7451195985724, 608.7399083896333, 29890.701092989064, 31887.52168717471, 31889.202769930762, 31994.680053199518, 31995.68004319959, 31855.68144318556, 40778.184436311254, 42690.359644605356, 42921.35617965733, 46087.308690369675, 7506.249375062491, 7636.923630763705, 7642.159362470124, 7642.923570764305, 7650.61746912655, 7738.380929525624, 7822.5306481611, 7826.3738900888075, 7836.177201393857, 7839.882401763978, 7485.5134416263045, 7643.847123057535, 10049.89950100497, 10306.690799275997, 10316.690499284996, 10060.899391006069, 10127.037931396542, 10133.341332813417, 10135.89864101357, 10143.64497242593, 9924.603015879356, 10010.399376037461, 10010.49947502622, 10011.299209055369, 10012.649557265533, 30466.695333046828, 30943.845280773454, 37938.24123517514, 38663.0, 38730.61269387298, 3559.839807208682, 3640.5995340512522, 3688.243909998471, 3702.38910579754, 3751.681107105899, 24812.3796905077, 26118.608220876704, 26137.215883523335, 26225.213243602724, 27079.593806092926, 3445.913852153691, 3508.3684936711384, 3512.824358782076, 3521.6830485256196, 3570.125319296763, 171419.0, 171797.0, 172014.0, 172278.0, 172569.0, 43180.3522947156, 43338.78330608327, 43378.132437351705, 43406.7829660856, 43464.78267608642, 49024.509754902705, 49058.075353971595, 49196.0, 49198.75400622974, 49221.50778492241, 13932.651683707785, 14122.43510259578, 14127.15237085778, 14131.505397311044, 14134.787978180335, 10974.615888443866, 11077.058450031676, 11092.168087393478, 11095.0, 11096.278741881752, 14628.634284142981, 15205.923970380078, 16752.41366552165, 16818.15909204535, 16829.158542072848, 5815.505682016991, 6720.663966801738, 6855.6572171391235, 6947.79156625302, 7175.13898332193, 788.5465857132172, 797.7487091566138, 816.979575510617, 829.0714399872181, 830.4933990265932, 27058.458830823274, 27553.86223068872, 27647.723522764514, 28286.575701364494, 28349.57475637867, 891.2068259249273, 940.9153176214037, 965.6427121964778, 972.9902700973041, 987.2151639446514, 14198.432062717582, 15065.54803355879, 15113.244337783068, 15250.847491525165, 15304.387824486896, 338986.0, 340909.0, 341956.2239398466, 342137.0, 344844.0, 49327.753361232964, 49821.501784982414, 49866.50133498691, 49927.25109123366, 49929.50070499248, 1163.3702895359565, 1216.173002358387, 1216.4525963316366, 1219.8719134490927, 1240.9007279417624, 25536.489270214865, 26760.59859102154, 26995.86502067477, 27269.0, 27331.59002615002, 42610.36084458797, 43248.783756081015, 43387.78306108449, 43395.0, 43498.0, 275798.0, 276227.0, 276825.0, 277769.0, 278867.0, 25510.0, 25878.22365329043, 25882.87058564695, 25883.741162588132, 25915.740842592088, 40771.1845763089, 41279.174416512105, 41282.38076428796, 41388.586114138474, 42557.57442425536, 35719.82140089387, 36017.27965440729, 36122.63877361193, 36165.63834361728, 36262.8186859064, 34822.30355392928, 34894.12764680904, 35048.47427288542, 35138.29723405466, 35149.824250878584, 34294.48558271678, 34406.48390274198, 34500.82749586236, 35018.29963400667, 35155.296894062485, 29189.7081029187, 31776.523352150198, 31809.681903180674, 31831.84084079565, 32091.67908320887, 23277.41806454852, 24042.398940025938, 24067.398315041562, 24540.50918981646, 24645.137420190207], "value": 17061.70895712766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.34972923061576, 378.2265267527905, 385.16995873891756, 387.7227782135772, 400.2954799552786, 13412.91502954321, 16655.66688666226, 17153.742693859585, 18198.272069117218, 18348.633027339478, 16871.2285210053, 17035.0, 17051.0, 17202.913985430056, 17209.225584848682, 4743.573078422941, 5050.267711181877, 5092.032513822362, 5096.643234973553, 5096.770645320969, 3745.3632882410056, 3901.902452438683, 5009.6242781791325, 5010.473900240477, 5059.772310246048, 5489.204065410513, 5719.399463056381, 5747.741351639165, 5857.297124345085, 5865.178874957509, 5705.087186050254, 5819.447152520525, 5844.386339434383, 5858.414158584129, 5902.173695682608, 5196.272521846944, 5201.505856943584, 5202.193659982709, 5202.401723801773, 5208.2968799212, 17259.48221553343, 21574.029168687448, 21697.240596579202, 21755.021024053956, 21830.345089647177, 2506.912258070977, 2563.525747736656, 2573.39525211577, 2614.0850702254247, 2621.17828109464, 13084.803727944089, 13425.530106446227, 13686.247256400893, 13857.514986975408, 14075.788863167061, 1629.1772654809363, 1685.875796496411, 1694.2375930831174, 1701.4215166843333, 1711.6063305439693, 68933.65533172301, 79568.60215698884, 80727.19272807315, 82593.58703206506, 82979.58510207411, 8221.630026648816, 8493.915060849436, 8623.482591044558, 8768.85163135036, 9059.139381758723, 11675.781601495688, 11728.765424691459, 11743.236689615147, 11762.235454695418, 11764.764704706029, 6762.729490820312, 6899.6205208713, 6946.583205007716, 7107.75122870697, 7123.608201548965, 6878.518503704793, 6889.621070841052, 7089.539179953286, 7100.822479438056, 7106.680199391039, 3502.2295095079044, 3620.1854582719207, 3648.1791596891017, 3872.5740168581433, 4009.4787677602308, 1706.9231884565224, 1728.3000384844158, 1742.9302827886995, 1757.5166829122093, 1799.1543974332044, 809.5345176523523, 817.3992115794886, 820.2535692519779, 829.8049958259804, 841.4362377207286, 16758.91620541914, 16935.32258709638, 17488.650226995644, 17732.645347092985, 17920.462386128438, 800.3757069485811, 809.6194788449419, 809.6923169195668, 812.5327936436572, 833.6373677450329, 9332.39339442934, 9341.766455838522, 9620.518974051409, 9710.465924374228, 9824.968378320316, 523280.0, 525461.0, 529349.0, 529654.0, 537716.0, 86854.56572717096, 88719.55640221758, 95901.0, 96179.0, 101756.0, 725.1334655087226, 751.6617522115071, 765.058977457719, 766.0692258905457, 768.2240936654019, 14913.140134579604, 14952.0, 15288.923555382153, 15541.922290388477, 15636.765448518508, 41361.379579305736, 41910.0, 41929.79035104805, 42012.15975680408, 42697.0, 56071.75712971599, 56543.71728141333, 57766.0, 57854.132188018055, 57955.0, 7129.536580122275, 7263.891041634274, 7325.267473252632, 7428.182899881117, 7613.08642962848, 9655.372400793925, 10581.841272380767, 11210.495527701436, 11296.548138074386, 11517.769644607228, 9439.716808495756, 9492.667756628485, 9746.951265243628, 9924.354916930377, 10069.89930100719, 9620.13418792312, 9709.417434953926, 9779.80440391174, 9800.705978820646, 9935.65225217114, 9675.080867317594, 9947.801043979225, 9950.555934532878, 9963.601455941971, 10280.434576098087, 7024.578525288499, 7126.35862772353, 7159.603877243888, 7257.165425976081, 7469.887951680837, 8038.437309388287, 9362.578683959102, 9381.671641492516, 9483.66807161746, 9779.902200977898], "value": 8266.326152985992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.5965050834243, 1314.8093526438668, 1320.0561598457114, 1320.8150858879758, 1321.0356439798948, 6687.431568316692, 7067.257937916522, 7091.184513780917, 7092.78721638351, 7094.361507464334, 6082.057281121433, 6290.993441049433, 6618.834529136774, 6842.794716158511, 6884.208316043657, 1944.455552445314, 1967.842572594189, 1968.468513501361, 1977.0510155125548, 1977.7428934238528, 1989.8905560194185, 2069.6481598128353, 2073.5438203595186, 2086.155107181594, 2095.067694875781, 1707.1378953628462, 1759.5689056181254, 1919.7696276446845, 1972.3984184823623, 2052.384284714587, 1960.3824795189469, 1960.892150931698, 1961.6076784643128, 1967.3212741604123, 1970.6945423459388, 1974.2004488182308, 1998.7701414337391, 2091.98954005229, 2099.0344441556904, 2099.538101617657, 7121.8219544511285, 7186.640667966633, 7194.244604316524, 7196.208417074117, 7196.640167991632, 4093.7953102345064, 4227.3447615619625, 4227.450431443924, 4239.27932251518, 4244.808983595745, 2684.3020814588153, 2822.3649678822308, 2838.4879381747096, 2858.2711408590885, 2861.8139820911574, 1051.1118105201092, 1070.464767616192, 1110.6667999600088, 1119.3955264157346, 1126.1553834624033, 9096.408733432372, 9147.496887671176, 9148.176664100196, 9148.222401095914, 9155.13026262504, 3641.9453708194396, 3890.6109389060866, 3923.195744872294, 3933.370660694275, 3949.19041596472, 7998.4001199910235, 8001.919980800234, 8011.639476223584, 8011.679532818622, 8013.599320033975, 4272.615464608138, 4282.272013757669, 4282.379055037064, 4285.421468101767, 4285.571442855752, 3813.694904407641, 3862.3820188769664, 3917.334053210961, 3921.9607803922167, 3928.175083232496, 3260.1523603863166, 3307.0, 3352.6312105668358, 3377.459606462954, 3384.1201287665385, 1138.163449864349, 1152.6081132414852, 1168.2114572663588, 1176.3647630279554, 1181.7754626620915, 673.5117040145855, 687.8383579858729, 700.5411455496658, 708.0936401406208, 726.3100054947821, 4635.675502714777, 4654.627629789677, 4705.858824235278, 4763.499832517536, 4839.782209800567, 533.3413234655197, 533.8398480455847, 534.5910378560404, 542.7991643092003, 545.6017107511539, 3003.1591154476782, 3058.388322335542, 3071.585335979659, 3117.628243572821, 3167.857446414917, 7947.721829736047, 8010.479318844256, 8125.065617454068, 8252.381071419668, 8253.95873020631, 8087.676492940216, 8195.385346098947, 8196.262336389635, 8204.753857384288, 8210.0, 6487.351264873475, 6496.512761542903, 6571.83570410734, 6610.471162307004, 6610.933890661032, 4778.068276686013, 4786.521347865186, 4799.760011999316, 4829.855104346875, 4852.053849499313, 7466.514676546007, 7556.8488630228185, 7692.34615057704, 7725.22747725223, 7772.68909243624, 7586.431017673807, 7790.961045194737, 7855.567943763148, 7856.135825059125, 7878.369730421437, 5995.5803093783015, 6049.969750151221, 6066.605670631395, 6078.571535689021, 6128.754849806136, 6551.80344589663, 6677.899831502628, 6678.298778628368, 6686.398224159849, 6686.598804071771, 6006.759729610767, 6149.969250153899, 6158.661273629993, 6193.4425901669065, 6205.348438413902, 5821.592488525763, 5864.0, 5922.407759224043, 5934.495567876779, 5953.761849526144, 5371.865703357447, 5490.5882058844945, 5495.560355171497, 5497.917531236954, 5501.724913754377, 4263.93604095945, 4302.397664327059, 4397.0, 4420.624246939046, 4497.662675299301, 3741.457488664074, 3800.5439347278502, 3814.256220037066, 3844.3272427325664, 3946.6645335146836], "value": 3701.918602400435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.84302064071164, 355.05024060637805, 355.18485076748857, 356.5596488336904, 362.98548058077694, 4829.710217386955, 4875.731834749087, 4879.804807807684, 4889.43771466281, 4923.704577725339, 4890.21756518957, 4893.877653058676, 4894.0, 4894.167991441454, 4898.8775280618, 3445.758796884219, 3703.90740231495, 3819.3316169670197, 3909.843606255746, 3983.3270026588757, 3891.9027024324478, 3904.4728961590104, 3909.159530700899, 3911.159100793329, 3913.4716813230134, 3904.746191497558, 3905.0, 3916.9804150979207, 3922.293987082324, 3927.5483319418345, 3894.824732887027, 3907.2185562887394, 3907.9804600976813, 3913.66733827625, 3917.5298964124204, 3415.84628691707, 3464.272502774395, 3473.1838018065732, 3490.581130264359, 3533.469979503069, 4746.928796068062, 4757.595604373632, 4760.285957106427, 4764.4282686077895, 4769.189237829577, 4468.50846406895, 4479.387420528607, 4481.2381895077915, 4486.237339652267, 4491.169133710274, 4893.437254715682, 5092.6180536459915, 5130.53825155734, 5137.17805151174, 5146.408163061258, 3839.404892241707, 3849.9230015399817, 3854.9807250963845, 3857.324968130566, 3866.420036994445, 5094.541491265767, 5296.496832800878, 5302.640325055352, 5316.3620365556, 5320.441353657849, 3786.1670432504807, 3789.1853251550497, 3798.3352913240074, 3799.8410484802403, 3907.628775266345, 3961.92076158481, 3980.0, 3987.481627388479, 3993.1414745829784, 3999.900002499961, 4405.933910991338, 4415.448068991376, 4419.270820314612, 4426.955730442719, 4434.645228381722, 4858.3441235432765, 5035.345405097314, 5065.341505604248, 5071.18860982241, 5105.9744701276995, 1325.6743256743257, 1341.2019848190312, 1347.595721283611, 1349.8785109340206, 1350.1898860683511, 929.1823195587839, 963.0754475703263, 970.1171933540444, 977.7702239973601, 978.7846673731767, 4309.245881970643, 4315.8489452869, 4325.7620830853975, 4327.2643650579475, 4333.328334108218, 5033.245013248042, 5036.370453693288, 5039.899202015939, 5044.814468599876, 5104.329538472256, 4174.373843923436, 4314.309710446376, 4323.827046918151, 4333.328334108218, 4358.65130789536, 2645.6692913385828, 2688.2472907585907, 2696.2743843939893, 2700.770434513049, 2713.5386984212337, 4708.411448568929, 4709.799001254727, 4715.764211789466, 4717.410323709536, 4730.438955144794, 4871.878203044952, 5124.897502050013, 5133.204353325241, 5138.794448222029, 5222.858627962517, 4740.103958416661, 4747.928781068355, 4762.285657151455, 4772.976135119372, 4776.447654512228, 4982.501749824988, 5009.348784657971, 5045.722485263345, 5095.54776888585, 5100.719460429712, 4896.485868983706, 4957.355543779286, 4994.425641051181, 4996.0, 5007.746514068756, 4632.0, 4806.591439727523, 4861.270809378621, 4873.220284754422, 4903.975480122576, 3623.4021386470936, 3690.446433035066, 3696.944545831761, 3701.1487357908372, 3702.9259414811013, 5230.947690523046, 5232.555232805102, 5236.921446178387, 5242.711650859239, 5246.554042906396, 4919.4834542373965, 5037.697738135724, 5044.646874718735, 5066.923996139987, 5069.822556210515, 5031.345925029723, 5048.949510504848, 5060.468650791761, 5068.7972481101815, 5069.822556210515, 4987.576056035277, 4993.575546078624, 5000.699958002531, 5006.4743201963265, 5006.799728010838, 4883.804647814048, 5055.974720126376, 5067.809064869826, 5070.138076526926, 5094.0830650481785, 4988.925166122439, 4989.451160372283, 4990.675606085593, 4994.750262486788, 4998.2256299013325], "value": 3865.688046785916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.62112459272, 739.0503203383653, 767.7850201943456, 782.9334506566939, 790.928816406524, 13003.284819334945, 13657.453701851939, 13666.726665466686, 13691.110077844933, 13728.244946527937, 13535.187888726683, 13554.186748795055, 13577.389017494212, 13698.109622874506, 13767.380467878944, 658.0491190230119, 674.3223060823865, 787.1616728184493, 796.474326944217, 826.4710585225461, 820.2699597358326, 827.962741676623, 829.8630725930215, 833.4624167412015, 833.5957060825494, 864.5936409887374, 865.9740207793744, 872.9345299102561, 875.0287181228831, 875.1598465473154, 694.1115372323434, 709.925457826931, 843.439112989861, 861.1388611388611, 862.5687156421789, 629.1663545801786, 641.935806419359, 642.3319747462633, 642.3640595810161, 642.4282388674084, 14480.710385792225, 14502.98479106463, 14561.417543298256, 14574.052686575338, 14579.92710036443, 12354.876451235552, 12443.440045197898, 12486.625401237978, 12541.372931353395, 12836.935815320958, 12157.817632735516, 12211.877881221162, 12334.629961101182, 12630.81053784194, 13159.934200328937, 4153.875383738493, 4268.935965960513, 4359.84740534083, 4430.778461076933, 4480.103979204139, 68463.65768171127, 69319.65340173266, 70605.64697176481, 70857.29142708611, 70919.0, 10370.948145259226, 10418.11446027081, 10752.731181720519, 11081.944590276997, 11295.0, 20775.480612984495, 20910.37268881936, 21048.368548943556, 21172.0, 21185.894070529856, 6775.457963362919, 6842.384185423336, 6871.106756121772, 6900.378965892994, 6981.092457980531, 3501.1597216667815, 3659.798711070917, 3663.2124093320062, 3672.5225720656676, 3770.4155855842387, 2799.720027997225, 2834.291427143214, 2849.6722876869426, 2854.4005758790886, 2864.957025644617, 478.3207844860307, 479.439056304125, 491.5109466081272, 491.71971975974066, 491.85981995131215, 565.8557067947729, 599.8800239951939, 602.807101727443, 605.0772571827997, 606.754264522869, 8445.0, 8605.569721513899, 8777.648894044294, 8802.471851688919, 9184.8622270666, 539.164295342218, 549.7333793110338, 568.8265079150899, 605.948494377974, 615.9260888693385, 4024.939625905614, 4071.42999980003, 4156.958430415718, 4204.096119334296, 4281.443412356373, 66046.0, 66365.0, 66520.66739666367, 67436.0, 67495.3250467489, 58508.0, 58596.70701646464, 59045.0, 59683.104753428735, 62012.0, 54220.204585679414, 54431.45568544422, 54785.72607136939, 54955.725221373636, 55242.72378638081, 7600.46796724224, 7615.390768738598, 7968.760937171663, 8187.590620469072, 8291.83416331682, 31136.377272454876, 31464.0, 31995.040148795575, 34359.0, 39903.2019359617, 45243.32135017912, 45615.31577026281, 46895.531044690484, 47181.52818471771, 48567.757161213965, 11473.942630286796, 11553.364564949008, 11867.703307417038, 11973.461194246105, 12188.817167742314, 11360.659180224606, 11487.0, 13153.60539183826, 13194.736105278032, 13234.933825331196, 9552.761180970254, 9925.950370248103, 11306.533919102074, 11855.703607409883, 12099.516019359478, 12333.260004399406, 12861.549845755353, 13063.150895191782, 13309.0, 13401.932990334986, 12011.399430028288, 12386.442610082748, 12417.379131043592, 12908.16096953695, 13184.736305274033, 10359.844602331123, 10470.371777693363, 10664.626738064131, 11067.391293478613, 11365.886341136484, 9381.624735010522, 9528.428294302365, 10279.932143692175, 10404.0, 10509.474526273503], "value": 6519.081412280193, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 115.0, 116.0, 116.0, 116.0, 114.0, 115.0, 115.0, 114.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 123.0, 167.0, 126.0, 123.0, 124.0, 124.0, 156.0, 124.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 162.0, 163.0, 161.0, 163.0, 161.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 116.0, 76.0, 77.0, 77.0, 78.0, 102.0, 76.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 103.0, 84.0, 84.0, 84.0, 103.0, 85.0, 84.0, 104.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 150.0, 149.0, 149.0, 149.0, 151.0, 150.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 59.0, 61.0, 61.0, 62.0, 60.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 86.0, 85.0, 89.0, 94.0, 87.0, 86.0, 85.0, 86.0, 84.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 132.0, 135.0, 131.0, 132.0, 138.0, 133.0, 173.0, 152.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 178.0, 178.0, 181.0, 179.0, 186.0, 182.0, 182.0, 177.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 68.0, 71.0], "value": 67.6, "unit": "score"}]}]} 06:11:48 INFO - Return code: 0 06:11:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:11:48 ERROR - # TBPL SUCCESS # 06:11:48 INFO - Running post-action listener: _resource_record_post_action 06:11:48 INFO - [mozharness: 2017-02-02 14:11:48.955105Z] Finished run-tests step (success) 06:11:48 INFO - Running post-run listener: _resource_record_post_run 06:11:49 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391753728; Read time: 12; Write time: 314044 06:11:49 INFO - TinderboxPrint: CPU usage
13.1% 06:11:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:11:49 INFO - TinderboxPrint: I/O write bytes / time
391,753,728 / 314,044 06:11:49 INFO - TinderboxPrint: CPU idle
8,344.2 (86.9%) 06:11:49 INFO - TinderboxPrint: CPU user
1,210.7 (12.6%) 06:11:49 INFO - TinderboxPrint: Swap in / out
0 / 0 06:11:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108232704; Read time: 0; Write time: 107760 06:11:49 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 283521024; Read time: 0; Write time: 206284 06:11:49 INFO - Running post-run listener: _upload_blobber_files 06:11:49 INFO - Blob upload gear active. 06:11:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:11:49 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 06:11:49 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'] 06:11:49 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 06:11:49 INFO - (blobuploader) - INFO - Open directory for files ... 06:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:53 INFO - (blobuploader) - INFO - Done attempting. 06:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:54 INFO - (blobuploader) - INFO - Done attempting. 06:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:55 INFO - (blobuploader) - INFO - Done attempting. 06:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:55 INFO - (blobuploader) - INFO - Done attempting. 06:11:55 INFO - (blobuploader) - INFO - Iteration through files over. 06:11:55 INFO - Return code: 0 06:11:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:11:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:11:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52e6f5f9ef379190b6da4fdac692df60ee936c066c8670afc31872abbf3ca907d1c0d6294f6a99799c9871dc3e1bc0d19545169b84e7209ffc84a3b979fbe52c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8bc47213d18e6e64624fc414f4a47dd7a676ac7f46ad31624922e98e2f560137d2e428fc9f554a2ca28215c77bea91bdd3f7196af2f5cc0d54496c9f5fc6aaee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76b28d22051ef9320efbab732dc5f628f233dcf31171628fa271d0581eff5eac76b7d8e82785c38f25501b851eaeb65e7160b975d8e75a130df3b0c19cc31bef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e039a81f23118f2f5a2b55b7fed8759fae2ee57194c5ce1f956c0f3a85fab6e4942a8840ce573b28ebeece088506a2727a6b7f42066e68cd3d829eac035d750a"} 06:11:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:11:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:11:55 INFO - Contents: 06:11:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52e6f5f9ef379190b6da4fdac692df60ee936c066c8670afc31872abbf3ca907d1c0d6294f6a99799c9871dc3e1bc0d19545169b84e7209ffc84a3b979fbe52c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8bc47213d18e6e64624fc414f4a47dd7a676ac7f46ad31624922e98e2f560137d2e428fc9f554a2ca28215c77bea91bdd3f7196af2f5cc0d54496c9f5fc6aaee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76b28d22051ef9320efbab732dc5f628f233dcf31171628fa271d0581eff5eac76b7d8e82785c38f25501b851eaeb65e7160b975d8e75a130df3b0c19cc31bef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e039a81f23118f2f5a2b55b7fed8759fae2ee57194c5ce1f956c0f3a85fab6e4942a8840ce573b28ebeece088506a2727a6b7f42066e68cd3d829eac035d750a"} 06:11:55 INFO - Running post-run listener: copy_logs_to_upload_dir 06:11:55 INFO - Copying logs to upload dir... 06:11:55 INFO - mkdir: /builds/slave/test/build/upload/logs 06:11:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.749140 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-02-02 06:11:55.408478) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 06:11:55.412175) ========= 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=af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539 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/52e6f5f9ef379190b6da4fdac692df60ee936c066c8670afc31872abbf3ca907d1c0d6294f6a99799c9871dc3e1bc0d19545169b84e7209ffc84a3b979fbe52c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8bc47213d18e6e64624fc414f4a47dd7a676ac7f46ad31624922e98e2f560137d2e428fc9f554a2ca28215c77bea91bdd3f7196af2f5cc0d54496c9f5fc6aaee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76b28d22051ef9320efbab732dc5f628f233dcf31171628fa271d0581eff5eac76b7d8e82785c38f25501b851eaeb65e7160b975d8e75a130df3b0c19cc31bef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e039a81f23118f2f5a2b55b7fed8759fae2ee57194c5ce1f956c0f3a85fab6e4942a8840ce573b28ebeece088506a2727a6b7f42066e68cd3d829eac035d750a"} build_url:https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/Gh0ltQ5GQSGu3uxPKS4k5A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52e6f5f9ef379190b6da4fdac692df60ee936c066c8670afc31872abbf3ca907d1c0d6294f6a99799c9871dc3e1bc0d19545169b84e7209ffc84a3b979fbe52c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8bc47213d18e6e64624fc414f4a47dd7a676ac7f46ad31624922e98e2f560137d2e428fc9f554a2ca28215c77bea91bdd3f7196af2f5cc0d54496c9f5fc6aaee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76b28d22051ef9320efbab732dc5f628f233dcf31171628fa271d0581eff5eac76b7d8e82785c38f25501b851eaeb65e7160b975d8e75a130df3b0c19cc31bef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e039a81f23118f2f5a2b55b7fed8759fae2ee57194c5ce1f956c0f3a85fab6e4942a8840ce573b28ebeece088506a2727a6b7f42066e68cd3d829eac035d750a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 06:11:55.437901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 06:11:55.438231) ========= 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=af724c981e2a0f424dbabf99000001e7-1486043465.321393-120021539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 06:11:55.522591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 06:11:55.522899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 06:11:55.523180) ========= ========= Total master_lag: 0.17 =========