builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1486649726.11 results: success (0) revision: 1419fa7ee013b44501b90487bf8f8873dbaf3727 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.111018) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.111462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.111746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.125313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.125705) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 06:15:26-- 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% 225M=0s 2017-02-09 06:15:26 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.214130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.214441) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017444 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.263340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.263696) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1419fa7ee013b44501b90487bf8f8873dbaf3727 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1419fa7ee013b44501b90487bf8f8873dbaf3727 --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=edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 06:15:26,421 truncating revision to first 12 chars 2017-02-09 06:15:26,422 Setting DEBUG logging. 2017-02-09 06:15:26,422 attempt 1/10 2017-02-09 06:15:26,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1419fa7ee013?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 06:15:26,836 unpacking tar archive at: mozilla-aurora-1419fa7ee013/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675860 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.952384) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.952717) ========= script_repo_revision: 1419fa7ee013b44501b90487bf8f8873dbaf3727 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.953132) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.953429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:26.961395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 06:15:26.961787) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-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=edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:15:27 INFO - MultiFileLogger online at 20170209 06:15:27 in /builds/slave/test 06:15:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 06:15:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:15:27 INFO - {'append_to_log': False, 06:15:27 INFO - 'base_work_dir': '/builds/slave/test', 06:15:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 06:15:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:15:27 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 06:15:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:15:27 INFO - 'config_files': ('talos/linux_config.py',), 06:15:27 INFO - 'default_actions': ('clobber', 06:15:27 INFO - 'read-buildbot-config', 06:15:27 INFO - 'download-and-extract', 06:15:27 INFO - 'populate-webroot', 06:15:27 INFO - 'create-virtualenv', 06:15:27 INFO - 'install', 06:15:27 INFO - 'run-tests'), 06:15:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:15:27 INFO - 'download_minidump_stackwalk': True, 06:15:27 INFO - 'download_symbols': 'ondemand', 06:15:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:15:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:15:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:15:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:15:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:15:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:15:27 INFO - 'installer_path': 'installer.exe', 06:15:27 INFO - 'log_level': 'info', 06:15:27 INFO - 'log_name': 'talos', 06:15:27 INFO - 'log_to_console': True, 06:15:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:15:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:15:27 INFO - 'opt_config_files': (), 06:15:27 INFO - 'pip_index': False, 06:15:27 INFO - 'sps_profile': False, 06:15:27 INFO - 'sps_profile_interval': 0, 06:15:27 INFO - 'suite': 'dromaeojs-e10s', 06:15:27 INFO - 'system_bits': '32', 06:15:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:15:27 INFO - 'title': 'talos-linux64-ix-033', 06:15:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:15:27 INFO - 'use_talos_json': True, 06:15:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:15:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:15:27 INFO - 'work_dir': 'build'} 06:15:27 INFO - [mozharness: 2017-02-09 14:15:27.225075Z] Running clobber step. 06:15:27 INFO - Running pre-action listener: _resource_record_pre_action 06:15:27 INFO - Running main action method: clobber 06:15:27 INFO - rmtree: /builds/slave/test/build 06:15:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:15:27 INFO - Running post-action listener: _resource_record_post_action 06:15:27 INFO - [mozharness: 2017-02-09 14:15:27.699277Z] Finished clobber step (success) 06:15:27 INFO - [mozharness: 2017-02-09 14:15:27.699376Z] Running read-buildbot-config step. 06:15:27 INFO - Running pre-action listener: _resource_record_pre_action 06:15:27 INFO - Running main action method: read_buildbot_config 06:15:27 INFO - Using buildbot properties: 06:15:27 INFO - { 06:15:27 INFO - "project": "", 06:15:27 INFO - "product": "firefox", 06:15:27 INFO - "who": "cbook@mozilla.com", 06:15:27 INFO - "installer_path": "public/build/target.tar.bz2", 06:15:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:15:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 06:15:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 06:15:27 INFO - "stage_platform": "linux64", 06:15:27 INFO - "basedir": "/builds/slave/test", 06:15:27 INFO - "buildnumber": 33, 06:15:27 INFO - "platform": "ubuntu64_hw", 06:15:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:15:27 INFO - "slavebuilddir": "test", 06:15:27 INFO - "taskId": "GKC15mRDQA2Zz0HIX6eNkA", 06:15:27 INFO - "branch": "mozilla-aurora", 06:15:27 INFO - "script_repo_revision": "production", 06:15:27 INFO - "revision": "1419fa7ee013b44501b90487bf8f8873dbaf3727", 06:15:27 INFO - "slavename": "talos-linux64-ix-033", 06:15:27 INFO - "repo_path": "releases/mozilla-aurora" 06:15:27 INFO - } 06:15:27 INFO - Finding installer, test and symbols from parent task. 06:15:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKC15mRDQA2Zz0HIX6eNkA'}, attempt #1 06:15:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKC15mRDQA2Zz0HIX6eNkA'}, attempt #1 06:15:28 INFO - Task dependencies: UG8Ra0dbSf2E8U_X24Zojw 06:15:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw'}, attempt #1 06:15:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 06:15:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/test_packages.json 06:15:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.crashreporter-symbols.zip 06:15:29 INFO - Running post-action listener: _resource_record_post_action 06:15:29 INFO - [mozharness: 2017-02-09 14:15:29.136924Z] Finished read-buildbot-config step (success) 06:15:29 INFO - [mozharness: 2017-02-09 14:15:29.137142Z] Running download-and-extract step. 06:15:29 INFO - Running pre-action listener: _resource_record_pre_action 06:15:29 INFO - Running main action method: download_and_extract 06:15:29 INFO - mkdir: /builds/slave/test/build/tests 06:15: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')]} 06:15:29 INFO - trying https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.test_packages.json 06:15:29 INFO - Downloading https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:15:29 INFO - Downloaded 896 bytes. 06:15:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:15:29 INFO - Using the following test package requirements: 06:15:29 INFO - {u'common': [u'target.common.tests.zip'], 06:15:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:15:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:15:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:15:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:15:29 INFO - u'mozbase': [u'target.common.tests.zip'], 06:15:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:15:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:15:29 INFO - u'web-platform': [u'target.common.tests.zip', 06:15:29 INFO - u'target.web-platform.tests.zip'], 06:15:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:15:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:15:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip 06:15:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:15:29 INFO - Fetch https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip into memory 06:15:30 INFO - Expected file size: 21858312 06:15:30 INFO - Obtained file size: 21858312 06:15:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:15:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip 06:15:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:15:34 INFO - Fetch https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip into memory 06:15:35 INFO - Expected file size: 21858312 06:15:35 INFO - Obtained file size: 21858312 06:15:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.talos.tests.zip 06:15:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:15:39 INFO - Fetch https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.talos.tests.zip into memory 06:15:40 INFO - Expected file size: 14403485 06:15:40 INFO - Obtained file size: 14403485 06:15:40 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')]} 06:15:40 INFO - trying https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 06:15:40 INFO - Downloading https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:15:41 INFO - Downloaded 66041066 bytes. 06:15:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 06:15:41 INFO - mkdir: /builds/slave/test/properties 06:15:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:15:41 INFO - Writing to file /builds/slave/test/properties/build_url 06:15:41 INFO - Contents: 06:15:41 INFO - build_url:https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 06:15:41 INFO - Running post-action listener: _resource_record_post_action 06:15:41 INFO - Running post-action listener: set_extra_try_arguments 06:15:41 INFO - [mozharness: 2017-02-09 14:15:41.950600Z] Finished download-and-extract step (success) 06:15:41 INFO - [mozharness: 2017-02-09 14:15:41.950696Z] Running populate-webroot step. 06:15:41 INFO - Running pre-action listener: _resource_record_pre_action 06:15:41 INFO - Running main action method: populate_webroot 06:15:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:15:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:15:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:15:41 INFO - '--tppagecycles', 06:15:41 INFO - '7'], 06:15:41 INFO - 'tests': ['tsvgm']}}, 06:15:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:15:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:15:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:15:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:15:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:15:41 INFO - 'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:15:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:15:41 INFO - 'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['damp', 'tps']}, 06:15:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:15:41 INFO - 'tests': ['damp', 'tps']}, 06:15:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['dromaeo_dom']}, 06:15:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:15:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['basic_compositor_video']}, 06:15:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:15:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['a11yr', 06:15:41 INFO - 'ts_paint', 06:15:41 INFO - 'tpaint', 06:15:41 INFO - 'sessionrestore', 06:15:41 INFO - 'sessionrestore_no_auto_restore', 06:15:41 INFO - 'tabpaint']}, 06:15:41 INFO - 'other-e10s': {'tests': ['a11yr', 06:15:41 INFO - 'ts_paint', 06:15:41 INFO - 'tpaint', 06:15:41 INFO - 'sessionrestore', 06:15:41 INFO - 'sessionrestore_no_auto_restore', 06:15:41 INFO - 'tabpaint']}, 06:15:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:15:41 INFO - 'ts_paint', 06:15:41 INFO - 'tpaint', 06:15:41 INFO - 'sessionrestore', 06:15:41 INFO - 'sessionrestore_no_auto_restore', 06:15:41 INFO - 'tabpaint']}, 06:15:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:15:41 INFO - 'ts_paint', 06:15:41 INFO - 'tpaint', 06:15:41 INFO - 'sessionrestore', 06:15:41 INFO - 'sessionrestore_no_auto_restore', 06:15:41 INFO - 'tabpaint']}, 06:15:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['a11yr', 06:15:41 INFO - 'ts_paint', 06:15:41 INFO - 'tpaint', 06:15:41 INFO - 'sessionrestore', 06:15:41 INFO - 'sessionrestore_no_auto_restore', 06:15:41 INFO - 'tabpaint']}, 06:15:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['a11yr', 06:15:41 INFO - 'ts_paint', 06:15:41 INFO - 'tpaint', 06:15:41 INFO - 'sessionrestore', 06:15:41 INFO - 'sessionrestore_no_auto_restore', 06:15:41 INFO - 'tabpaint']}, 06:15:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['tsvgx', 06:15:41 INFO - 'tsvgr_opacity', 06:15:41 INFO - 'tart', 06:15:41 INFO - 'tscrollx', 06:15:41 INFO - 'cart', 06:15:41 INFO - 'tsvg_static']}, 06:15:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:15:41 INFO - 'tsvgr_opacity', 06:15:41 INFO - 'tart', 06:15:41 INFO - 'tscrollx', 06:15:41 INFO - 'cart', 06:15:41 INFO - 'tsvg_static']}, 06:15:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:15:41 INFO - 'talos_options': ['--disable-e10s'], 06:15:41 INFO - 'tests': ['tp5o']}, 06:15:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:15:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:15:41 INFO - 'talos_options': ['--disable-e10s', 06:15:41 INFO - '--xperf_path', 06:15:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:41 INFO - 'tests': ['tp5n']}, 06:15:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:15:41 INFO - 'talos_options': ['--xperf_path', 06:15:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:41 INFO - 'tests': ['tp5n']}}, 06:15:41 INFO - 'talos.zip': {'path': '', 06:15:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:15:41 INFO - Running post-action listener: _resource_record_post_action 06:15:41 INFO - [mozharness: 2017-02-09 14:15:41.964137Z] Finished populate-webroot step (success) 06:15:41 INFO - [mozharness: 2017-02-09 14:15:41.964227Z] Running create-virtualenv step. 06:15:41 INFO - Running pre-action listener: _resource_record_pre_action 06:15:41 INFO - Running main action method: create_virtualenv 06:15:41 INFO - Creating virtualenv /builds/slave/test/build/venv 06:15:41 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 06:15:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:15:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:15:42 INFO - Using real prefix '/usr' 06:15:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:15:42 INFO - Installing distribute.............................................................................................................................................................................................done. 06:15:44 INFO - Installing pip.................done. 06:15:44 INFO - Return code: 0 06:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:15:44 INFO - Reading from file tmpfile_stdout 06:15:44 INFO - Output received: 06:15:44 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) 06:15:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:15:44 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')]} 06:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:44 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')]} 06:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:44 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:15:44 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 06:15:44 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 06:15:44 INFO - Using env: {'DISPLAY': ':0', 06:15:44 INFO - 'HOME': '/home/cltbld', 06:15:44 INFO - 'LANG': 'en_US.UTF-8', 06:15:44 INFO - 'LANGUAGE': 'en_US:en', 06:15:44 INFO - 'LOGNAME': 'cltbld', 06:15:44 INFO - 'MAIL': '/var/mail/cltbld', 06:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:44 INFO - 'MOZ_NO_REMOTE': '1', 06:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:44 INFO - 'NO_EM_RESTART': '1', 06:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:44 INFO - 'PWD': '/builds/slave/test', 06:15:44 INFO - 'SHELL': '/bin/bash', 06:15:44 INFO - 'SHLVL': '1', 06:15:44 INFO - 'TERM': 'linux', 06:15:44 INFO - 'TMOUT': '86400', 06:15:44 INFO - 'USER': 'cltbld', 06:15:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:44 INFO - '_': '/tools/buildbot/bin/python'} 06:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:44 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 06:15:44 INFO - Cleaning up... 06:15:44 INFO - Return code: 0 06:15:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:15:44 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')]} 06:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:44 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')]} 06:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:44 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:15:44 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 06:15:44 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 06:15:44 INFO - Using env: {'DISPLAY': ':0', 06:15:44 INFO - 'HOME': '/home/cltbld', 06:15:44 INFO - 'LANG': 'en_US.UTF-8', 06:15:44 INFO - 'LANGUAGE': 'en_US:en', 06:15:44 INFO - 'LOGNAME': 'cltbld', 06:15:44 INFO - 'MAIL': '/var/mail/cltbld', 06:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:44 INFO - 'MOZ_NO_REMOTE': '1', 06:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:44 INFO - 'NO_EM_RESTART': '1', 06:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:44 INFO - 'PWD': '/builds/slave/test', 06:15:44 INFO - 'SHELL': '/bin/bash', 06:15:44 INFO - 'SHLVL': '1', 06:15:44 INFO - 'TERM': 'linux', 06:15:44 INFO - 'TMOUT': '86400', 06:15:44 INFO - 'USER': 'cltbld', 06:15:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:44 INFO - '_': '/tools/buildbot/bin/python'} 06:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:45 INFO - Downloading/unpacking psutil>=3.1.1 06:15:45 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 06:15:45 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 06:15:45 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 06:15:45 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 06:15:45 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 06:15:45 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 06:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:15:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:47 INFO - Installing collected packages: psutil 06:15:47 INFO - Running setup.py install for psutil 06:15:47 INFO - building 'psutil._psutil_linux' extension 06:15:47 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 06:15:47 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 06:15:47 INFO - building 'psutil._psutil_posix' extension 06:15:47 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 06:15:47 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 06:15:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:47 INFO - Successfully installed psutil 06:15:47 INFO - Cleaning up... 06:15:47 INFO - Return code: 0 06:15:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:15:47 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')]} 06:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:47 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')]} 06:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:47 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:15:47 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 06:15:47 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 06:15:47 INFO - Using env: {'DISPLAY': ':0', 06:15:47 INFO - 'HOME': '/home/cltbld', 06:15:47 INFO - 'LANG': 'en_US.UTF-8', 06:15:47 INFO - 'LANGUAGE': 'en_US:en', 06:15:47 INFO - 'LOGNAME': 'cltbld', 06:15:47 INFO - 'MAIL': '/var/mail/cltbld', 06:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:47 INFO - 'MOZ_NO_REMOTE': '1', 06:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:47 INFO - 'NO_EM_RESTART': '1', 06:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:47 INFO - 'PWD': '/builds/slave/test', 06:15:47 INFO - 'SHELL': '/bin/bash', 06:15:47 INFO - 'SHLVL': '1', 06:15:47 INFO - 'TERM': 'linux', 06:15:47 INFO - 'TMOUT': '86400', 06:15:47 INFO - 'USER': 'cltbld', 06:15:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:47 INFO - '_': '/tools/buildbot/bin/python'} 06:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:15:48 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 06:15:48 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 06:15:48 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 06:15:48 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 06:15:48 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 06:15:48 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 06:15:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:15:50 INFO - Installing collected packages: mozsystemmonitor 06:15:50 INFO - Running setup.py install for mozsystemmonitor 06:15:50 INFO - Successfully installed mozsystemmonitor 06:15:50 INFO - Cleaning up... 06:15:50 INFO - Return code: 0 06:15:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:15:50 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')]} 06:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:50 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')]} 06:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:50 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:15:50 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 06:15:50 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 06:15:50 INFO - Using env: {'DISPLAY': ':0', 06:15:50 INFO - 'HOME': '/home/cltbld', 06:15:50 INFO - 'LANG': 'en_US.UTF-8', 06:15:50 INFO - 'LANGUAGE': 'en_US:en', 06:15:50 INFO - 'LOGNAME': 'cltbld', 06:15:50 INFO - 'MAIL': '/var/mail/cltbld', 06:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:50 INFO - 'MOZ_NO_REMOTE': '1', 06:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:50 INFO - 'NO_EM_RESTART': '1', 06:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:50 INFO - 'PWD': '/builds/slave/test', 06:15:50 INFO - 'SHELL': '/bin/bash', 06:15:50 INFO - 'SHLVL': '1', 06:15:50 INFO - 'TERM': 'linux', 06:15:50 INFO - 'TMOUT': '86400', 06:15:50 INFO - 'USER': 'cltbld', 06:15:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:50 INFO - '_': '/tools/buildbot/bin/python'} 06:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:50 INFO - Downloading/unpacking jsonschema==2.5.1 06:15:50 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 06:15:50 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 06:15:50 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 06:15:50 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 06:15:50 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 06:15:50 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 06:15:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:15:52 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 06:15:52 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 06:15:52 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 06:15:52 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 06:15:52 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 06:15:52 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 06:15:52 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:52 INFO - warning: no files found matching '*.txt' 06:15:52 INFO - no previously-included directories found matching 'build' 06:15:52 INFO - no previously-included directories found matching 'dist' 06:15:52 INFO - no previously-included directories found matching '.git*' 06:15:52 INFO - Installing collected packages: jsonschema, functools32 06:15:52 INFO - Running setup.py install for functools32 06:15:52 INFO - warning: no files found matching '*.txt' 06:15:52 INFO - no previously-included directories found matching 'build' 06:15:52 INFO - no previously-included directories found matching 'dist' 06:15:52 INFO - no previously-included directories found matching '.git*' 06:15:52 INFO - Successfully installed jsonschema functools32 06:15:52 INFO - Cleaning up... 06:15:53 INFO - Return code: 0 06:15:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:15:53 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')]} 06:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:53 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')]} 06:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:53 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:15:53 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 06:15:53 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 06:15:53 INFO - Using env: {'DISPLAY': ':0', 06:15:53 INFO - 'HOME': '/home/cltbld', 06:15:53 INFO - 'LANG': 'en_US.UTF-8', 06:15:53 INFO - 'LANGUAGE': 'en_US:en', 06:15:53 INFO - 'LOGNAME': 'cltbld', 06:15:53 INFO - 'MAIL': '/var/mail/cltbld', 06:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:53 INFO - 'MOZ_NO_REMOTE': '1', 06:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:53 INFO - 'NO_EM_RESTART': '1', 06:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:53 INFO - 'PWD': '/builds/slave/test', 06:15:53 INFO - 'SHELL': '/bin/bash', 06:15:53 INFO - 'SHLVL': '1', 06:15:53 INFO - 'TERM': 'linux', 06:15:53 INFO - 'TMOUT': '86400', 06:15:53 INFO - 'USER': 'cltbld', 06:15:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:53 INFO - '_': '/tools/buildbot/bin/python'} 06:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:15:53 INFO - Cleaning up... 06:15:53 INFO - Return code: 0 06:15:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:15:53 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')]} 06:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:53 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')]} 06:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:53 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:15:53 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 06:15:53 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 06:15:53 INFO - Using env: {'DISPLAY': ':0', 06:15:53 INFO - 'HOME': '/home/cltbld', 06:15:53 INFO - 'LANG': 'en_US.UTF-8', 06:15:53 INFO - 'LANGUAGE': 'en_US:en', 06:15:53 INFO - 'LOGNAME': 'cltbld', 06:15:53 INFO - 'MAIL': '/var/mail/cltbld', 06:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:53 INFO - 'MOZ_NO_REMOTE': '1', 06:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:53 INFO - 'NO_EM_RESTART': '1', 06:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:53 INFO - 'PWD': '/builds/slave/test', 06:15:53 INFO - 'SHELL': '/bin/bash', 06:15:53 INFO - 'SHLVL': '1', 06:15:53 INFO - 'TERM': 'linux', 06:15:53 INFO - 'TMOUT': '86400', 06:15:53 INFO - 'USER': 'cltbld', 06:15:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:53 INFO - '_': '/tools/buildbot/bin/python'} 06:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:53 INFO - Downloading/unpacking blobuploader==1.2.4 06:15:53 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 06:15:53 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 06:15:53 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 06:15:53 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 06:15:53 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 06:15:53 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 06:15:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:55 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 06:15:55 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 06:15:55 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 06:15:55 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 06:15:55 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 06:15:55 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 06:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:55 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 06:15:55 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 06:15:55 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 06:15:55 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 06:15:55 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 06:15:55 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 06:15:56 INFO - Downloading docopt-0.6.1.tar.gz 06:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:56 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:56 INFO - Running setup.py install for blobuploader 06:15:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:56 INFO - Running setup.py install for requests 06:15:56 INFO - Running setup.py install for docopt 06:15:56 INFO - Successfully installed blobuploader requests docopt 06:15:56 INFO - Cleaning up... 06:15:56 INFO - Return code: 0 06:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:56 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')]} 06:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:56 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')]} 06:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:56 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:15:56 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 06:15:56 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 06:15:56 INFO - Using env: {'DISPLAY': ':0', 06:15:56 INFO - 'HOME': '/home/cltbld', 06:15:56 INFO - 'LANG': 'en_US.UTF-8', 06:15:56 INFO - 'LANGUAGE': 'en_US:en', 06:15:56 INFO - 'LOGNAME': 'cltbld', 06:15:56 INFO - 'MAIL': '/var/mail/cltbld', 06:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:56 INFO - 'MOZ_NO_REMOTE': '1', 06:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:56 INFO - 'NO_EM_RESTART': '1', 06:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:56 INFO - 'PWD': '/builds/slave/test', 06:15:56 INFO - 'SHELL': '/bin/bash', 06:15:56 INFO - 'SHLVL': '1', 06:15:56 INFO - 'TERM': 'linux', 06:15:56 INFO - 'TMOUT': '86400', 06:15:56 INFO - 'USER': 'cltbld', 06:15:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:56 INFO - '_': '/tools/buildbot/bin/python'} 06:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:57 INFO - Running setup.py (path:/tmp/pip-9qCrnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:57 INFO - Running setup.py (path:/tmp/pip-L9ky1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:57 INFO - Running setup.py (path:/tmp/pip-yfVG4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:57 INFO - Running setup.py (path:/tmp/pip-IXW4f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:57 INFO - Running setup.py (path:/tmp/pip-WQxI8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:57 INFO - Running setup.py (path:/tmp/pip-tKzPnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:57 INFO - Running setup.py (path:/tmp/pip-g4D7Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:57 INFO - Running setup.py (path:/tmp/pip-6ioMYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:57 INFO - Running setup.py (path:/tmp/pip-M7lozV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:57 INFO - Running setup.py (path:/tmp/pip-L6twTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:57 INFO - Running setup.py (path:/tmp/pip-BMa8XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:57 INFO - Running setup.py (path:/tmp/pip-4mEOlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:57 INFO - Running setup.py (path:/tmp/pip-5lmibX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:58 INFO - Running setup.py (path:/tmp/pip-Els3a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:58 INFO - Running setup.py (path:/tmp/pip-B2CRCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:58 INFO - Running setup.py (path:/tmp/pip-kALlzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:58 INFO - Running setup.py (path:/tmp/pip-hxQ2m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:58 INFO - Running setup.py install for manifestparser 06:15:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:58 INFO - Running setup.py install for mozcrash 06:15:58 INFO - Running setup.py install for mozdebug 06:15:58 INFO - Running setup.py install for mozdevice 06:15:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:15:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:58 INFO - Running setup.py install for mozfile 06:15:58 INFO - Running setup.py install for mozhttpd 06:15:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:58 INFO - Running setup.py install for mozinfo 06:15:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Running setup.py install for mozInstall 06:15:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Running setup.py install for mozleak 06:15:59 INFO - Running setup.py install for mozlog 06:15:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Running setup.py install for moznetwork 06:15:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Running setup.py install for mozprocess 06:15:59 INFO - Running setup.py install for mozprofile 06:15:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Running setup.py install for mozrunner 06:15:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Running setup.py install for mozscreenshot 06:15:59 INFO - Running setup.py install for moztest 06:16:00 INFO - Running setup.py install for mozversion 06:16:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:16:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:16:00 INFO - Cleaning up... 06:16:00 INFO - Return code: 0 06:16:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:00 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')]} 06:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:00 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')]} 06:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:00 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:16:00 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 06:16:00 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 06:16:00 INFO - Using env: {'DISPLAY': ':0', 06:16:00 INFO - 'HOME': '/home/cltbld', 06:16:00 INFO - 'LANG': 'en_US.UTF-8', 06:16:00 INFO - 'LANGUAGE': 'en_US:en', 06:16:00 INFO - 'LOGNAME': 'cltbld', 06:16:00 INFO - 'MAIL': '/var/mail/cltbld', 06:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:00 INFO - 'MOZ_NO_REMOTE': '1', 06:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:00 INFO - 'NO_EM_RESTART': '1', 06:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:00 INFO - 'PWD': '/builds/slave/test', 06:16:00 INFO - 'SHELL': '/bin/bash', 06:16:00 INFO - 'SHLVL': '1', 06:16:00 INFO - 'TERM': 'linux', 06:16:00 INFO - 'TMOUT': '86400', 06:16:00 INFO - 'USER': 'cltbld', 06:16:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:00 INFO - '_': '/tools/buildbot/bin/python'} 06:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:00 INFO - Running setup.py (path:/tmp/pip-hSGeMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:00 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)) 06:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:00 INFO - Running setup.py (path:/tmp/pip-iPEigM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:00 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)) 06:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:00 INFO - Running setup.py (path:/tmp/pip-9bsJoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:00 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)) 06:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:00 INFO - Running setup.py (path:/tmp/pip-SmTQDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:00 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)) 06:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:00 INFO - Running setup.py (path:/tmp/pip-m_eSuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:00 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)) 06:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:00 INFO - Running setup.py (path:/tmp/pip-O9i4RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:00 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)) 06:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:00 INFO - Running setup.py (path:/tmp/pip-K8EsNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:00 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)) 06:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:00 INFO - Running setup.py (path:/tmp/pip-T9vmV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:01 INFO - Running setup.py (path:/tmp/pip-bkTmGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:01 INFO - Running setup.py (path:/tmp/pip-nFsBwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:01 INFO - Running setup.py (path:/tmp/pip-a2VMcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:01 INFO - Running setup.py (path:/tmp/pip-AgDhiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:01 INFO - Running setup.py (path:/tmp/pip-AZR1_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:01 INFO - Running setup.py (path:/tmp/pip-jKiY2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:01 INFO - Running setup.py (path:/tmp/pip-gujhfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:01 INFO - Running setup.py (path:/tmp/pip-vEUSfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:01 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)) 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:01 INFO - Running setup.py (path:/tmp/pip-9GmLWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:01 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)) 06:16:01 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)) 06:16:01 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)) 06:16:01 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)) 06:16:01 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)) 06:16:01 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)) 06:16:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:03 INFO - Downloading blessings-1.6.tar.gz 06:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:16:03 INFO - Installing collected packages: blessings 06:16:03 INFO - Running setup.py install for blessings 06:16:03 INFO - Successfully installed blessings 06:16:03 INFO - Cleaning up... 06:16:03 INFO - Return code: 0 06:16:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:04 INFO - Reading from file tmpfile_stdout 06:16:04 INFO - Current package versions: 06:16:04 INFO - argparse == 1.2.1 06:16:04 INFO - blessings == 1.6 06:16:04 INFO - blobuploader == 1.2.4 06:16:04 INFO - docopt == 0.6.1 06:16:04 INFO - functools32 == 3.2.3-2 06:16:04 INFO - jsonschema == 2.5.1 06:16:04 INFO - manifestparser == 1.1 06:16:04 INFO - mozInstall == 1.12 06:16:04 INFO - mozcrash == 1.0 06:16:04 INFO - mozdebug == 0.1 06:16:04 INFO - mozdevice == 0.49 06:16:04 INFO - mozfile == 1.2 06:16:04 INFO - mozhttpd == 0.7 06:16:04 INFO - mozinfo == 0.9 06:16:04 INFO - mozleak == 0.1 06:16:04 INFO - mozlog == 3.4 06:16:04 INFO - moznetwork == 0.27 06:16:04 INFO - mozprocess == 0.24 06:16:04 INFO - mozprofile == 0.28 06:16:04 INFO - mozrunner == 6.13 06:16:04 INFO - mozscreenshot == 0.1 06:16:04 INFO - mozsystemmonitor == 0.3 06:16:04 INFO - moztest == 0.8 06:16:04 INFO - mozversion == 1.4 06:16:04 INFO - psutil == 3.1.1 06:16:04 INFO - requests == 1.2.3 06:16:04 INFO - wsgiref == 0.1.2 06:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:04 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')]} 06:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:04 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')]} 06:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:04 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:16:04 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 06:16:04 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 06:16:04 INFO - Using env: {'DISPLAY': ':0', 06:16:04 INFO - 'HOME': '/home/cltbld', 06:16:04 INFO - 'LANG': 'en_US.UTF-8', 06:16:04 INFO - 'LANGUAGE': 'en_US:en', 06:16:04 INFO - 'LOGNAME': 'cltbld', 06:16:04 INFO - 'MAIL': '/var/mail/cltbld', 06:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:04 INFO - 'MOZ_NO_REMOTE': '1', 06:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:04 INFO - 'NO_EM_RESTART': '1', 06:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:04 INFO - 'PWD': '/builds/slave/test', 06:16:04 INFO - 'SHELL': '/bin/bash', 06:16:04 INFO - 'SHLVL': '1', 06:16:04 INFO - 'TERM': 'linux', 06:16:04 INFO - 'TMOUT': '86400', 06:16:04 INFO - 'USER': 'cltbld', 06:16:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:04 INFO - '_': '/tools/buildbot/bin/python'} 06:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 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)) 06:16:04 INFO - Cleaning up... 06:16:04 INFO - Return code: 0 06:16:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:16:04 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')]} 06:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:04 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')]} 06:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:04 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 0x1d401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', '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 06:16:04 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 06:16:04 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 06:16:04 INFO - Using env: {'DISPLAY': ':0', 06:16:04 INFO - 'HOME': '/home/cltbld', 06:16:04 INFO - 'LANG': 'en_US.UTF-8', 06:16:04 INFO - 'LANGUAGE': 'en_US:en', 06:16:04 INFO - 'LOGNAME': 'cltbld', 06:16:04 INFO - 'MAIL': '/var/mail/cltbld', 06:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:04 INFO - 'MOZ_NO_REMOTE': '1', 06:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:04 INFO - 'NO_EM_RESTART': '1', 06:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:04 INFO - 'PWD': '/builds/slave/test', 06:16:04 INFO - 'SHELL': '/bin/bash', 06:16:04 INFO - 'SHLVL': '1', 06:16:04 INFO - 'TERM': 'linux', 06:16:04 INFO - 'TMOUT': '86400', 06:16:04 INFO - 'USER': 'cltbld', 06:16:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:04 INFO - '_': '/tools/buildbot/bin/python'} 06:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:16:04 INFO - Cleaning up... 06:16:04 INFO - Return code: 0 06:16:04 INFO - Running post-action listener: _resource_record_post_action 06:16:04 INFO - Running post-action listener: _start_resource_monitoring 06:16:04 INFO - Starting resource monitoring. 06:16:04 INFO - [mozharness: 2017-02-09 14:16:04.674798Z] Finished create-virtualenv step (success) 06:16:04 INFO - [mozharness: 2017-02-09 14:16:04.675236Z] Running install step. 06:16:04 INFO - Running pre-action listener: _resource_record_pre_action 06:16:04 INFO - Running main action method: install 06:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:04 INFO - Reading from file tmpfile_stdout 06:16:04 INFO - Detecting whether we're running mozinstall >=1.0... 06:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:16:04 INFO - Reading from file tmpfile_stdout 06:16:04 INFO - Output received: 06:16:04 INFO - Usage: mozinstall [options] installer 06:16:04 INFO - Options: 06:16:04 INFO - -h, --help show this help message and exit 06:16:04 INFO - -d DEST, --destination=DEST 06:16:04 INFO - Directory to install application into. [default: 06:16:04 INFO - "/builds/slave/test"] 06:16:04 INFO - --app=APP Application being installed. [default: firefox] 06:16:04 INFO - mkdir: /builds/slave/test/build/application 06:16:04 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'] 06:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:16:21 INFO - Reading from file tmpfile_stdout 06:16:21 INFO - Output received: 06:16:21 INFO - /builds/slave/test/build/application/firefox/firefox 06:16:21 INFO - Running post-action listener: _resource_record_post_action 06:16:21 INFO - [mozharness: 2017-02-09 14:16:21.399769Z] Finished install step (success) 06:16:21 INFO - [mozharness: 2017-02-09 14:16:21.400040Z] Running run-tests step. 06:16:21 INFO - Running pre-action listener: _resource_record_pre_action 06:16:21 INFO - Running main action method: run_tests 06:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:16:21 INFO - Python 2.7.3 06:16:21 INFO - Return code: 0 06:16:21 INFO - grabbing minidump binary from tooltool 06:16:21 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')]} 06:16:21 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 0x20afd00>, '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 0x20b0a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b0eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:16:21 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 06:16:21 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 06:16:21 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 06:16:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:16:21 INFO - Return code: 0 06:16:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:16:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:16:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:16:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:16:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:16:21 INFO - Using env: {'DISPLAY': ':0', 06:16:21 INFO - 'HOME': '/home/cltbld', 06:16:21 INFO - 'LANG': 'en_US.UTF-8', 06:16:21 INFO - 'LANGUAGE': 'en_US:en', 06:16:21 INFO - 'LOGNAME': 'cltbld', 06:16:21 INFO - 'MAIL': '/var/mail/cltbld', 06:16:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:21 INFO - 'MOZ_NO_REMOTE': '1', 06:16:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:21 INFO - 'NO_EM_RESTART': '1', 06:16:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:21 INFO - 'PWD': '/builds/slave/test', 06:16:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:21 INFO - 'SHELL': '/bin/bash', 06:16:21 INFO - 'SHLVL': '1', 06:16:21 INFO - 'TERM': 'linux', 06:16:21 INFO - 'TMOUT': '86400', 06:16:21 INFO - 'USER': 'cltbld', 06:16:21 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378', 06:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:21 INFO - '_': '/tools/buildbot/bin/python'} 06:16:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:16:21 INFO - mozversion application_buildid: 20170209131207 06:16:21 INFO - mozversion application_changeset: 1419fa7ee013b44501b90487bf8f8873dbaf3727 06:16:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:16:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:16:21 INFO - mozversion application_name: Firefox 06:16:21 INFO - mozversion application_remotingname: firefox-dev 06:16:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:16:21 INFO - mozversion application_vendor: Mozilla 06:16:21 INFO - mozversion application_version: 53.0a2 06:16:21 INFO - mozversion platform_buildid: 20170209131207 06:16:21 INFO - mozversion platform_changeset: 1419fa7ee013b44501b90487bf8f8873dbaf3727 06:16:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:16:21 INFO - mozversion platform_version: 53.0a2 06:16:21 INFO - using testdate: 1486649781 06:16:21 INFO - actual date: 1486649781 06:16:21 INFO - starting webserver on 'localhost:52152' 06:16:21 INFO - SUITE-START | Running 2 tests 06:16:21 INFO - TEST-START | dromaeo_css 06:16:21 INFO - operating with platform_type : linux_ 06:16:21 INFO - Initialising browser for dromaeo_css test... 06:16:21 INFO - TEST-INFO | started process 30505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRDqvvN/profile http://localhost:52152/getInfo.html) 06:16:26 INFO - PROCESS | 30505 | __metrics Screen width/height:1600/1200 06:16:26 INFO - PROCESS | 30505 | colorDepth:24 06:16:26 INFO - PROCESS | 30505 | Browser inner width/height: 1024/697 06:16:26 INFO - PROCESS | 30505 | __metrics 06:16:27 INFO - PROCESS | 30505 | 1486649787439 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 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpRDqvvN/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpRDqvvN/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpRDqvvN/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpRDqvvN/profile/extensions/talos-powers@TalosPowersService.js:55:9 06:16:27 ERROR - PROCESS | 30505 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 06:16:28 INFO - TEST-INFO | 30505: exit 0 06:16:28 INFO - Browser initialized. 06:16:28 INFO - Running cycle 1/1 for dromaeo_css test... 06:16:28 INFO - TEST-INFO | started process 30633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRDqvvN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:40 INFO - PROCESS | 30633 | RSS: Main: 144560128 06:16:40 INFO - PROCESS | 30633 | 06:19:39 INFO - PROCESS | 30633 | Cycle 1(1): loaded http://localhost:52152/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52152/tests/dromaeo/cssquery-ext.html) 06:19:40 INFO - PROCESS | 30633 | RSS: Main: 154296320 06:19:40 INFO - PROCESS | 30633 | 06:21:28 INFO - PROCESS | 30633 | ************************* 06:21:28 INFO - PROCESS | 30633 | A coding exception was thrown and uncaught in a Task. 06:21:28 INFO - PROCESS | 30633 | 06:21:28 ERROR - PROCESS | 30633 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:21:28 INFO - PROCESS | 30633 | Full stack: 06:21:28 INFO - PROCESS | 30633 | ************************* 06:22:42 INFO - PROCESS | 30633 | Cycle 1(1): loaded http://localhost:52152/tests/dromaeo/cssquery-ext.html (next: http://localhost:52152/tests/dromaeo/cssquery-jquery.html) 06:22:43 INFO - PROCESS | 30633 | RSS: Main: 150315008 06:22:43 INFO - PROCESS | 30633 | 06:25:44 INFO - PROCESS | 30633 | Cycle 1(1): loaded http://localhost:52152/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52152/tests/dromaeo/cssquery-mootools.html) 06:25:45 INFO - PROCESS | 30633 | RSS: Main: 153645056 06:25:45 INFO - PROCESS | 30633 | 06:28:47 INFO - PROCESS | 30633 | Cycle 1(1): loaded http://localhost:52152/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52152/tests/dromaeo/cssquery-prototype.html) 06:28:47 INFO - PROCESS | 30633 | RSS: Main: 151646208 06:28:47 INFO - PROCESS | 30633 | 06:31:50 INFO - PROCESS | 30633 | Cycle 1(1): loaded http://localhost:52152/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52152/tests/dromaeo/cssquery-yui.html) 06:31:50 INFO - PROCESS | 30633 | RSS: Main: 152772608 06:31:50 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | Cycle 1(1): loaded http://localhost:52152/tests/dromaeo/cssquery-yui.html (next: http://localhost:52152/tests/dromaeo/cssquery-dojo.html) 06:34:53 INFO - PROCESS | 30633 | RSS: Main: 153591808 06:34:53 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | __start_tp_report 06:34:53 INFO - PROCESS | 30633 | _x_x_mozilla_page_load 06:34:53 INFO - PROCESS | 30633 | _x_x_mozilla_page_load_details 06:34:53 INFO - PROCESS | 30633 | |i|pagename|runs| 06:34:53 INFO - PROCESS | 30633 | |0;dojo.html;3321.5515905352777;3339.549160863283;3347.2134048498597;3351.6480769519185;3370.8314584270797;5432.728363581825;5465.453454654533;5494.2582751328555;5502.5597952163835;5528.364238112618;5538.75075621597;5552.305961754781;5626.859328516779;5643.463870932265;5651.632643878155;5117.513836185556;5137.101007323722;5180.766865491043;5201.791928322863;5220.712860792655;5122.282880396748;5176.120059589879;5179.015986962465;5193.195054766517;5205.37535495741;5035.899282014358;5041.571466425358;5182.507661772144;5190.92213616796;5214.634975551713;5042.117629414856;5061.44324124346;5086.059079070384;5135;5158.871028224287;4986.700797952134;5075.568576670988;5077.746112694387;5092;5100.15847385181;5345.385280692732;5450.482204190595;5454.181872719084;5536.944630553683;5548.278723765885;5832.970835145839;5844.532437404998;5901.557383196277;5917;5927.555433342516;5870.090136028923;5921.496672782819;5936.079907614327;5945.31628862682;5946.048632218867;5509.47659972302;5527.060399732055;5538.723063846832;5550.69471179085;5558.333000040021;5925.200097986803;5949.732262048218;6046.274447066292;6090.23872015998;6110.663913484712;5830.38780928005;5883.02930016551;5894.351621321651;5896.64620122794;5901.996660567714;5918.674472904032;5935.376785437467;5955.970220148872;5958.702064896738;5965;5745.368009518949;5786.07422812348;5800.477956983892;5834.212381328552;5956.791512297049;5902.439268269508;5911.201987731687;5918;5927.585069045125;5946.67293298864;4441.955580444219;4446.9777651111535;4452.888677783017;4464.821407143678;4474.440694913136;3994.7802870842384;4004.099077707551;4009.51885773709;4013.6387725104883;4033.6773058155277;5801.970990145022;5807.477327040587;5825.854353641193;5831.533477321804;5872.706364681834;5924.407559244041;5935.317438494542;5981.0729336952845;5992.580519363602;5995.670238136857;5659.971700141556;5706.3152421709665;5741.25363702716;5767.279090113736;5788.016037273674;5101.464346243591;5104.872378190575;5106.412762532282;5136;5136.486351364908;6195.752169913243;6230.43926046658;6240.157578726905;6252;6252.187215661935;5857.326407463196;5888.970555147197;5922.289325280994;5977.043673012471;5985.162077309267;6173.1666225060835;6294.43350098475;6295.1186833842385;6296.118543403835;6309.432151106423;5838.854028649148;5921.644701317935;5929.703514824155;5940.079287710412;5964.910526342195;5773.797917072882;5809.680467574324;6003.129546215861;6013.6692481913915;6053.334133245427;5738.569607279387;5771.509421699203;5779.104238842818;5820.796272130455;5830.4461076197695;5809.128630705428;5817.9127313091185;5826.038703613856;5832.300123985149;5840.591158618856;5776.566757493289;5780.537556995346;5781.075027995501;5792.073268277056;5794.507466865195;5598.244237027949;5709.885802284014;5732.856678583069;5801.042827933344;5855.824325270249;5808.419158084158;5822.155787410887;5834.824955251349;5869.090291004901;5880.382559831156 06:34:53 INFO - PROCESS | 30633 | |1;ext.html;555.3141869790808;612.4457366083694;617.6016469377251;716.5163514627628;734.8493558820443;44701.552984470145;45863.082738345256;49016.264756028686;49168.26247606289;49242.261366079445;49998.75000625001;51053.48946510543;51092.23361649578;51164.23253651198;51178;9148.313876459275;10640.09559187466;11026.669199924016;11042.723931901726;11327.830082548728;10782.514786834612;10834.891651083468;10859.83710244347;10864.511097000654;10864.565417383295;10849.620263290786;10944.124470042418;10992.17558683098;10996.23026388153;11025.61410350638;10730.946345268301;10806.405647689375;10808.351498910091;10841.241113122085;10923.289986150914;10820.404877731722;10877.619283325124;10894.237403381767;10937.179711521667;10970.286931349516;42831;42980.57019429797;43211.35182972258;43421.78289108534;43454.56545434537;4389.275769498029;4411.580899814512;4481.193385190664;4561.657875659339;4565.429321334833;32155.83922080398;32369.67630323714;32722.509162362585;32943.6705632943;33585.16037099068;4575.862724118282;4683.508231635663;4710.905781884343;4711.882202944919;4732.597729193023;351723;352176;352718;354174;356196;56323.71838140783;56723.43276567264;56810.71594642083;56822.7158864203;57008.42991570114;58838;58936.70531647314;59005;59479.40520594825;59551.702241488514;17729;18724.063796810104;18937.90531047336;19225.13486893065;19244.518887027938;13691.383887724876;13802.102863313852;13915.791263131061;13939.581812545639;14020.859791401956;20550.486237843874;20621.38135855927;20644.07101680428;20663.690044649342;20762.896185518977;7519.699212031457;7561.962190189014;7607.430606546411;7799.142094369615;7824.843503129906;968.4576637083256;976.1702552830179;977.8924318324979;979.4417182206074;986.2553771902311;34229.48655770165;34456;34497.482537761956;34572.13569660779;34573;1052.2213561964245;1169.2107827216764;1171.91796574239;1181.769554936779;1194.0805579703579;17850.19674114642;17906.28374864991;18033.368832090815;18153.364632237808;18249.178786954355;156236;156557;156631;157367;157949.210253948;69867.3013269871;70424.64787676028;70534.2946570538;70617;70711;1481.3111902964959;1488.0922637191304;1500.3323521033035;1516.8862335324675;1539.622792415843;32868.83565582157;32995.83502082474;33546;33678.49482257817;33892;59751.402485974584;59974;60046.69976650089;60452.09321860263;60492.69753651204;416096;420328;422971;423405;423993;31936.52095218527;32816.67183328136;32970.5054424179;33075.66924330822;33162.170945725586;46773.2984005247;47265;48349.75825120852;54606.45393546172;54704.7767580424;41418.1716365665;42035;42826;42940.785296074566;43289.35065974076;41550;42063;43017.139657207306;43260.35109473298;43530.34704479372;41174.1765164701;41304.79347603243;41825;42065.57934420617;45271;34112.48831267483;37099.25801483901;37197.25605487929;37554.62445375511;37655.81172094122;28725.267596496753;29115.85442072776;29297.41405171927;29488.41023179567;29495.705042949296 06:34:53 INFO - PROCESS | 30633 | |2;jquery.html;436.53509012901236;442.5817602365765;445.50326386079513;449.126449056585;455.20793818755374;20411.183552657894;21152.89423552882;22379;22492.662610060863;22516.77483225167;22632.54734905301;23251.186208482708;23479.178228761997;23532.76467235327;23743;6020.337762846083;6027.819165425044;6189.969050154743;6235.469985051276;6246.937530624704;5987.371326010772;6114.847128821771;6118.3269840317525;6120.846978825521;6126.908096378558;5836.533077353802;6033.517318614522;6076.392360763933;6085.908711369333;6088.969555152218;6092.451679348857;6114.510839132881;6136.110264011738;6148.354422785588;6161.4146656067605;5394.91907621386;5518.448155184489;5530.087535556629;5540.778368865241;5556.472135147154;26329.868350658315;26605.866970665218;26806.86596567024;26920.461590768075;27053.729462705316;2479.7148327942336;2561.2316305108393;2569.1393383216646;2578.4714133602565;2591.922242332733;11257.831132533018;12909.935450322688;15364;15499;16512.174391280507;2058.8970551472516;2061.9278325258692;2084.062172022596;2089.5298557824367;2099.202303124818;97838;97841.51079244558;98159;101008.49495752547;101731;10525.526351314209;10629.734256643645;10780.191485638608;10826.56693732242;12671.493140274286;14430.855691443161;14700.411983520753;14707.191104489142;14779.113253204841;14820.407183712747;8591.527465989306;8977.147171018743;9011.504367259733;9133.360664753536;9191;9069.410488318239;9090.590923408463;9178.173964343108;9341.626334946663;9447.244220462346;4409.11817636474;4469.7318160910445;4492.797824097924;4546.295324224684;4636.907261854812;2201.9889900550716;2209.171560664751;2254.1884921428273;2317.1310758465575;2320.6519022146813;910.2172131966504;912.8995810460976;926.8841394825647;928.2295694573622;944.7024187380953;19657.803421965596;21096.261630842848;21408.678869816966;21550.46123846885;21554.568908622052;942.3780304998805;945.9499955049889;948.4356807699407;950.5294879034922;952.2526164488241;11453;11990;11998;12057.819132713017;12090.335031573348;656188;656412;668350;715401;726883;100697;101756.49121754344;109955.45022274838;111827.4408627968;112712;1164.1618035014776;1187.9643610691694;1211.9151659383936;1213.9514419423124;1229.225587879648;19688.704669429684;19737.605247895248;19951.20195192234;19961.800381995996;19977;43123.137537248454;43262.351064734685;46389.07221855612;46576.30135548037;48402.51597484121;66201.33798661952;70088.64955675189;70112;70558;70732.29267707258;9355.391899526508;9557.522123893916;9583.760405989906;9694.175995040501;9694.6122155113;10267.84598231042;10539.367637941748;10760.83858742135;14497.565073047403;14718.484853030093;12159.696007599881;12200.206986545845;12230.571929982763;12330.321832299309;12405.069619778373;12164.391780410768;12250.571230006906;12405.875941240472;12433.37833108323;12620.747585048064;12360;13027.348632568144;13207.60377188686;13304.800427993781;13419.114890298633;9628.47043412619;9665.71002869915;9667.613295468103;9721.125098741148;9783.217342612432;10764.46177691128;12287;12337.50649974027;12399.75200496003;12599.93700031494 06:34:53 INFO - PROCESS | 30633 | |3;mootools.html;1475.911445313282;1494.5441640299712;1517.3475405575612;1523.200319832088;1523.9695206095878;7815.179406162342;7990.400719946013;8314.334853211743;8823.602937867796;8890.599923003472;8177;8464.195901389357;8474.830503389943;8552.5296108714;8672.52301123438;2462.2982450001796;2497.5878979968284;2499.0628514307136;2501.962470562943;2503.824732268742;2410.1323523531514;2483.3170878008514;2489.0790407549234;2491.5141547398266;2500.8374455660323;2405.9639105413435;2414.058517178293;2414.915477958272;2416.299273210767;2417.9240238094053;2334.393057804966;2335.637976113705;2349.553584818879;2360.6459031145296;2366.8343215974887;2328.639060945556;2341.660459233419;2377.322463098009;2378.1319818266206;2378.21518898763;8474.152584741538;8474.406791524534;8533.359998000175;8539.274161696263;8568.143185681445;5229.947700523022;5333.306670132897;5340.946590534084;5368.1679339702405;5376.91934620981;3295.8516866741056;3355.5470011548373;3410;3456.1359660084977;3469.115375579211;1432.248069763372;1458.5843034735155;1476.431573844067;1494.1408690003184;1495.9476418325307;11174.66476005721;11518.827217591743;11568.363739994296;11877.16859819813;11903.761924761542;4377.606015458624;4511.05267893746;4541.591256786905;4730.361401210861;4757.714537127784;9284;9318.627254909863;9336.533173341442;9345.766355841022;9373.859392109123;5327.413984461706;5349.973250133802;5354.678719276856;5360.544353729977;5367.75845086972;4878.219484882402;4965.081459929925;5086.72023038729;5115.7442127893455;5146.794128234904;3905.628965248297;4004.1791432756213;4017.819198136091;4042.211768705074;4056.9391459128137;1249.8687637798082;1252.2423933520272;1260.5588044184462;1262.551794113095;1267.0940277701488;976.3360914578155;1073.0825144501496;1082.6697857153645;1085.9891401086047;1090.6727981605486;6012.038073908154;6031.306399763996;6037.426444487766;6063.848403789941;6072.574919755663;667.7028722218566;1032.2722480651123;1074.3446497636435;1084.3981590217347;1120.9719757005978;4130.958690413117;4197.433346498184;4216.9789151054665;4217.514985776614;4297.312430011246;10014;10288.485575721184;10302.639407620698;10311.020453056948;10320.845187322197;10094.646687365906;10094.798104038025;10118;10232.334898231591;10240.231982601335;7854.607269636495;7860.253275938777;7901.446898717149;7951.960240198762;7960.164182760843;5571.916421253603;5673.092305231144;5704.828855134353;5733.111367738007;5834;8896.510691912006;9058.320625953213;9058.954705226432;9105.27157827359;9191.86212206804;8906.153915378029;9182;9186.58660360272;9198.310126740655;9277.582508787256;7287.927120728725;7466.701331946879;7552;7753.806154845948;7929.563873986755;8321.12628174033;8352.123027082069;8388.370872184489;8425.031121421114;8427.62075706607;7469.58917259556;7497;7524;7544.886826697494;7661.731839385595;7277.381422578928;7323.377512911462;7393.8151546211775;7415.295546923249;7429.294217049372;6517.73929042833;6577.934220657924;6598.769043083469;6645.235797883305;6649.501287403561;5051.090803655377;5111.05445492585;5144.819931302386;5183.611229157904;5350.090484617546;5334.653247538898;5336.786528538815;5341.385740639721;5384.569234461312;5526.668399896019 06:34:53 INFO - PROCESS | 30633 | |4;prototype.html;395.0912900329242;411.28641806465794;412.60390025575447;413.2394811768428;420.4975054809503;5239.371275446947;5326.387465441476;5461.317335333083;5503.477169668885;5542.974549708301;5355.7857685692525;5403.729813509319;5466.480684334992;5468.562514998801;5481.5340696040785;4333.956660433402;4341.305391137419;4360.302351623741;4391.473023237216;4399.5160532341415;4279.935800962988;4307.8492252771;4336.522982471925;4392.626626736731;4401.383806267125;4286.76422796746;4316.503602085753;4317.373980772786;4317.611414972652;4326.598737700575;4292.699511034198;4325.805338759732;4331.133773245332;4333.090051089275;4343.348497725351;3810.4474851146706;3845.61543845616;3863.4784304118866;3868.2263547290654;3887.522741358294;5336.146216605363;5337.11937530307;5345.572354211693;5368.141097424394;5370.5435038021815;4931.679440836334;4945.9258111128365;4963.6525443218625;4965.627577931669;4967.826126085606;5555;5679.630823996468;5741.617228850022;5752.309722833245;5775.422457754233;4192.128392051424;4197.223513649954;4199.958000419987;4214.747115173069;4221.6833737469815;5954.8809023819285;5986.323829327752;6013.75944962201;6014.127951447016;6020.8193754187005;4211;4237.512686041083;4335.34969754533;4350.521442641307;4358.585934336233;4275.422817919603;4345.9356805517755;4349.739015659071;4354.303311470149;4361.956380436219;4937.407511098691;4948.802047918115;4951.257311403247;4976.054549635558;4984.501549844987;5678.914816277759;5727.4845263926445;5817.50551203144;5850.3272123705465;5852.356240813507;1424.2095636921401;1425.664968732347;1426.8359138699182;1430.5207755401848;1441.704450587627;984.4044353166374;1012.6860673191334;1014.3558840136419;1027.2398425165325;1028.5011769291887;5515.944840551543;5523.696196709219;5533.78648540587;5574.804881829116;5588.21764952907;5673.205751194836;5680.488756011896;5756.359437560275;5760.6255593386295;5761.164631128463;5457.45425457459;5560.833175004756;5574.414686457863;5656.462636049569;5697.715114244271;2999.1555193555805;3009.5786589877434;3014;3033.5752994580776;3043.4978228592036;5804.912926306109;5977.491913187341;5992.250968628921;6002.349353927705;6051.334353221142;5788.218590490314;5798.420157984167;5813.151555737658;5819.970900145472;5824.88350232993;5989.580729348903;6025.487833534199;6050.394960503914;6067.453929146398;6098.481629061579;5552.250446189712;5560.332760068818;5625.831225063254;5678.517326027334;5722.5421966241765;5555.361133469541;5585.664860108406;5598.692071936082;5603.719814009365;5612.915806262828;5631.88736225265;6017.638941663514;6096.237970253718;6100.450959413674;6112.991356426318;4050.311447053949;4221.852235171754;4333.371661109185;4362.1493808707;4368.322909948963;5951.256092988377;5978.7608495661425;5979.790707325223;5984.341722410619;6019.458248757633;5617;5805.593608447368;5813.593048486566;5845.532357411482;5901.586888917906;5748.39641837601;5761.884762304814;5773.711314434346;5789.263221033589;5811.331696854916;5711.5145212655725;5736.0248757712125;5743.224664670216;5795.6527606319505;5800.50695690871;5559.6664200148125;5744.885102298014;5799.333076696234;5801.810628820997;5816.912746308724;5669.461401166883;5671.886562268649;5687.60186786921;5694.430556944272;5709.343425505954 06:34:53 INFO - PROCESS | 30633 | |5;yui.html;843.2663582683067;859.8108416148445;866.7399780065979;926.4117285523693;932.1889955738507;15359.308831102599;17005.489835304947;17433.82566174338;17615.119244037778;17671.116444177806;15177.16525591092;15479.690406191869;16048.75926861098;16261.10563918984;16308;805.963731632078;811.0227176252631;811.3711873298182;814.0597609760736;828.2380210206609;840.3949156607233;845.0408786027841;845.1632883445376;848.7156802471179;849.6983570832358;887.6848718704864;889.4574309671095;892.7678803511102;894.1952242981337;894.789724414762;883.3286702106445;884.8009197930478;886.8182022685367;886.9379143459961;887.8712586674928;645.4384685323798;647.5402464250387;648.6043513456788;649.337675570915;651.5178767711907;17051.744223836653;17203.311867525284;17314.65370692579;17774;17997.1001449927;16355.182240887909;16391.344346226255;16609.252583633646;16652.75020874688;16736;13839.30803459833;13883.167009979434;13907.304634768221;13988;14069.859301406957;4007.97996010021;4045.130296986162;4076.164386300801;4104.527979282391;4119.8352065917325;86797.56601217017;87731;89887.55056224743;89986.10013899909;90110;12653.746925061447;12684.556040538537;12726;12760.617181484571;12779.977601791834;24039.158629447884;24257.878710606336;24263.150789722276;24355.512889742105;24488;8284.25441710237;8311;8464.703735369232;8498.532580707997;8500.192481714228;4797.808087676523;4835;4854.368932038812;4854.5873600744335;4866.829660961849;3867.9226415471535;3903.2974064668633;3909.4331321958157;3948.348522493814;3977.7414468059483;674.2212744280364;684.9623270720059;686.5160062156168;697.5221972948547;707.2891743797451;692.3976140757574;695.485340847769;708.4757279613049;716.8637958787814;721.1166321256419;11187.4965626547;11210.66368008961;11294.754828974894;11666.591669291534;11882.643520694393;837.1962915600969;848.1052489623384;857.8713193020972;859.5959898847532;867.7353407210735;5282.996230716151;5363.919541206885;5545.279113715191;5553.500184983371;5960.433758792908;66147.66926165434;77387;78553.60723196347;81816;86309.5684521586;67503;67740;67902.3209767906;69827.65086174537;70957;64808;64983;66300;66821;67787.3221267781;10411.843822342822;10877.238593298393;11152.44237788091;11164.832527511931;11184;42874.57125428706;44183.77908110439;44255.77872110619;44390.11219775651;44961.550384495735;54995.72502137624;55457.1681424787;56041.43958560525;56890;57511;14065.296735163405;14313.71372572522;14598.343074561457;14911.701765964403;14932.178730169511;15541.300641471387;15784.21078946071;15913.602159946095;16056.19719014068;17420.564485887953;14780.704385912437;14991.325390357242;15529.922350388175;16385.42651007209;16387.67224655524;15652.295646696153;16246.512604621881;16408.425705100264;17106;17122.828771712124;14642.341094650554;14695;15907.204639768197;16038.679226415174;16542.503724888273;12725.490980360682;12766.680832978878;12827.679308017001;13472.124311919693;13701.246431445967;11796.941015295211;12028.271235916895;12282.877171228174;12471.750564988468;12733.872661273268 06:34:53 INFO - PROCESS | 30633 | __end_tp_report 06:34:53 INFO - PROCESS | 30633 | __start_cc_report 06:34:53 INFO - PROCESS | 30633 | _x_x_mozilla_cycle_collect,302 06:34:53 INFO - PROCESS | 30633 | __end_cc_report 06:34:53 INFO - PROCESS | 30633 | __startTimestamp1486650893499__endTimestamp 06:34:53 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | ------- Summary: start ------- 06:34:53 INFO - PROCESS | 30633 | Number of tests: 6 06:34:53 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | [#0] dojo.html Cycles:165 Average:5541.28 Median:5792.07 stddev:618.60 (10.7%) stddev-sans-first:595.48 06:34:53 INFO - PROCESS | 30633 | Values: 3321.6 3339.5 3347.2 3351.6 3370.8 5432.7 5465.5 5494.3 5502.6 5528.4 5538.8 5552.3 5626.9 5643.5 5651.6 5117.5 5137.1 5180.8 5201.8 5220.7 5122.3 5176.1 5179.0 5193.2 5205.4 5035.9 5041.6 5182.5 5190.9 5214.6 5042.1 5061.4 5086.1 5135.0 5158.9 4986.7 5075.6 5077.7 5092.0 5100.2 5345.4 5450.5 5454.2 5536.9 5548.3 5833.0 5844.5 5901.6 5917.0 5927.6 5870.1 5921.5 5936.1 5945.3 5946.0 5509.5 5527.1 5538.7 5550.7 5558.3 5925.2 5949.7 6046.3 6090.2 6110.7 5830.4 5883.0 5894.4 5896.6 5902.0 5918.7 5935.4 5956.0 5958.7 5965.0 5745.4 5786.1 5800.5 5834.2 5956.8 5902.4 5911.2 5918.0 5927.6 5946.7 4442.0 4447.0 4452.9 4464.8 4474.4 3994.8 4004.1 4009.5 4013.6 4033.7 5802.0 5807.5 5825.9 5831.5 5872.7 5924.4 5935.3 5981.1 5992.6 5995.7 5660.0 5706.3 5741.3 5767.3 5788.0 5101.5 5104.9 5106.4 5136.0 5136.5 6195.8 6230.4 6240.2 6252.0 6252.2 5857.3 5889.0 5922.3 5977.0 5985.2 6173.2 6294.4 6295.1 6296.1 6309.4 5838.9 5921.6 5929.7 5940.1 5964.9 5773.8 5809.7 6003.1 6013.7 6053.3 5738.6 5771.5 5779.1 5820.8 5830.4 5809.1 5817.9 5826.0 5832.3 5840.6 5776.6 5780.5 5781.1 5792.1 5794.5 5598.2 5709.9 5732.9 5801.0 5855.8 5808.4 5822.2 5834.8 5869.1 5880.4 06:34:53 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | [#1] ext.html Cycles:180 Average:51213.11 Median:37148.26 stddev:87052.22 (234.3%) stddev-sans-first:87213.33 06:34:53 INFO - PROCESS | 30633 | Values: 555.3 612.4 617.6 716.5 734.8 44701.6 45863.1 49016.3 49168.3 49242.3 49998.8 51053.5 51092.2 51164.2 51178.0 9148.3 10640.1 11026.7 11042.7 11327.8 10782.5 10834.9 10859.8 10864.5 10864.6 10849.6 10944.1 10992.2 10996.2 11025.6 10730.9 10806.4 10808.4 10841.2 10923.3 10820.4 10877.6 10894.2 10937.2 10970.3 42831.0 42980.6 43211.4 43421.8 43454.6 4389.3 4411.6 4481.2 4561.7 4565.4 32155.8 32369.7 32722.5 32943.7 33585.2 4575.9 4683.5 4710.9 4711.9 4732.6 351723.0 352176.0 352718.0 354174.0 356196.0 56323.7 56723.4 56810.7 56822.7 57008.4 58838.0 58936.7 59005.0 59479.4 59551.7 17729.0 18724.1 18937.9 19225.1 19244.5 13691.4 13802.1 13915.8 13939.6 14020.9 20550.5 20621.4 20644.1 20663.7 20762.9 7519.7 7562.0 7607.4 7799.1 7824.8 968.5 976.2 977.9 979.4 986.3 34229.5 34456.0 34497.5 34572.1 34573.0 1052.2 1169.2 1171.9 1181.8 1194.1 17850.2 17906.3 18033.4 18153.4 18249.2 156236.0 156557.0 156631.0 157367.0 157949.2 69867.3 70424.6 70534.3 70617.0 70711.0 1481.3 1488.1 1500.3 1516.9 1539.6 32868.8 32995.8 33546.0 33678.5 33892.0 59751.4 59974.0 60046.7 60452.1 60492.7 416096.0 420328.0 422971.0 423405.0 423993.0 31936.5 32816.7 32970.5 33075.7 33162.2 46773.3 47265.0 48349.8 54606.5 54704.8 41418.2 42035.0 42826.0 42940.8 43289.4 41550.0 42063.0 43017.1 43260.4 43530.3 41174.2 41304.8 41825.0 42065.6 45271.0 34112.5 37099.3 37197.3 37554.6 37655.8 28725.3 29115.9 29297.4 29488.4 29495.7 06:34:53 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | [#2] jquery.html Cycles:180 Average:36540.62 Median:2585.20 stddev:112679.77 (4358.7%) stddev-sans-first:112963.25 06:34:53 INFO - PROCESS | 30633 | Values: 436.5 442.6 445.5 449.1 455.2 20411.2 21152.9 22379.0 22492.7 22516.8 22632.5 23251.2 23479.2 23532.8 23743.0 6020.3 6027.8 6190.0 6235.5 6246.9 5987.4 6114.8 6118.3 6120.8 6126.9 5836.5 6033.5 6076.4 6085.9 6089.0 6092.5 6114.5 6136.1 6148.4 6161.4 5394.9 5518.4 5530.1 5540.8 5556.5 26329.9 26605.9 26806.9 26920.5 27053.7 2479.7 2561.2 2569.1 2578.5 2591.9 11257.8 12909.9 15364.0 15499.0 16512.2 2058.9 2061.9 2084.1 2089.5 2099.2 97838.0 97841.5 98159.0 101008.5 101731.0 10525.5 10629.7 10780.2 10826.6 12671.5 14430.9 14700.4 14707.2 14779.1 14820.4 8591.5 8977.1 9011.5 9133.4 9191.0 9069.4 9090.6 9178.2 9341.6 9447.2 4409.1 4469.7 4492.8 4546.3 4636.9 2202.0 2209.2 2254.2 2317.1 2320.7 910.2 912.9 926.9 928.2 944.7 19657.8 21096.3 21408.7 21550.5 21554.6 942.4 945.9 948.4 950.5 952.3 11453.0 11990.0 11998.0 12057.8 12090.3 656188.0 656412.0 668350.0 715401.0 726883.0 100697.0 101756.5 109955.5 111827.4 112712.0 1164.2 1188.0 1211.9 1214.0 1229.2 19688.7 19737.6 19951.2 19961.8 19977.0 43123.1 43262.4 46389.1 46576.3 48402.5 66201.3 70088.6 70112.0 70558.0 70732.3 9355.4 9557.5 9583.8 9694.2 9694.6 10267.8 10539.4 10760.8 14497.6 14718.5 12159.7 12200.2 12230.6 12330.3 12405.1 12164.4 12250.6 12405.9 12433.4 12620.7 12360.0 13027.3 13207.6 13304.8 13419.1 9628.5 9665.7 9667.6 9721.1 9783.2 10764.5 12287.0 12337.5 12399.8 12599.9 06:34:53 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | [#3] mootools.html Cycles:180 Average:5636.27 Median:5165.20 stddev:3004.02 (58.2%) stddev-sans-first:2996.17 06:34:53 INFO - PROCESS | 30633 | Values: 1475.9 1494.5 1517.3 1523.2 1524.0 7815.2 7990.4 8314.3 8823.6 8890.6 8177.0 8464.2 8474.8 8552.5 8672.5 2462.3 2497.6 2499.1 2502.0 2503.8 2410.1 2483.3 2489.1 2491.5 2500.8 2406.0 2414.1 2414.9 2416.3 2417.9 2334.4 2335.6 2349.6 2360.6 2366.8 2328.6 2341.7 2377.3 2378.1 2378.2 8474.2 8474.4 8533.4 8539.3 8568.1 5229.9 5333.3 5340.9 5368.2 5376.9 3295.9 3355.5 3410.0 3456.1 3469.1 1432.2 1458.6 1476.4 1494.1 1495.9 11174.7 11518.8 11568.4 11877.2 11903.8 4377.6 4511.1 4541.6 4730.4 4757.7 9284.0 9318.6 9336.5 9345.8 9373.9 5327.4 5350.0 5354.7 5360.5 5367.8 4878.2 4965.1 5086.7 5115.7 5146.8 3905.6 4004.2 4017.8 4042.2 4056.9 1249.9 1252.2 1260.6 1262.6 1267.1 976.3 1073.1 1082.7 1086.0 1090.7 6012.0 6031.3 6037.4 6063.8 6072.6 667.7 1032.3 1074.3 1084.4 1121.0 4131.0 4197.4 4217.0 4217.5 4297.3 10014.0 10288.5 10302.6 10311.0 10320.8 10094.6 10094.8 10118.0 10232.3 10240.2 7854.6 7860.3 7901.4 7952.0 7960.2 5571.9 5673.1 5704.8 5733.1 5834.0 8896.5 9058.3 9059.0 9105.3 9191.9 8906.2 9182.0 9186.6 9198.3 9277.6 7287.9 7466.7 7552.0 7753.8 7929.6 8321.1 8352.1 8388.4 8425.0 8427.6 7469.6 7497.0 7524.0 7544.9 7661.7 7277.4 7323.4 7393.8 7415.3 7429.3 6517.7 6577.9 6598.8 6645.2 6649.5 5051.1 5111.1 5144.8 5183.6 5350.1 5334.7 5336.8 5341.4 5384.6 5526.7 06:34:53 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | [#4] prototype.html Cycles:180 Average:4845.11 Median:5528.74 stddev:1398.71 (25.3%) stddev-sans-first:1362.17 06:34:53 INFO - PROCESS | 30633 | Values: 395.1 411.3 412.6 413.2 420.5 5239.4 5326.4 5461.3 5503.5 5543.0 5355.8 5403.7 5466.5 5468.6 5481.5 4334.0 4341.3 4360.3 4391.5 4399.5 4279.9 4307.8 4336.5 4392.6 4401.4 4286.8 4316.5 4317.4 4317.6 4326.6 4292.7 4325.8 4331.1 4333.1 4343.3 3810.4 3845.6 3863.5 3868.2 3887.5 5336.1 5337.1 5345.6 5368.1 5370.5 4931.7 4945.9 4963.7 4965.6 4967.8 5555.0 5679.6 5741.6 5752.3 5775.4 4192.1 4197.2 4200.0 4214.7 4221.7 5954.9 5986.3 6013.8 6014.1 6020.8 4211.0 4237.5 4335.3 4350.5 4358.6 4275.4 4345.9 4349.7 4354.3 4362.0 4937.4 4948.8 4951.3 4976.1 4984.5 5678.9 5727.5 5817.5 5850.3 5852.4 1424.2 1425.7 1426.8 1430.5 1441.7 984.4 1012.7 1014.4 1027.2 1028.5 5515.9 5523.7 5533.8 5574.8 5588.2 5673.2 5680.5 5756.4 5760.6 5761.2 5457.5 5560.8 5574.4 5656.5 5697.7 2999.2 3009.6 3014.0 3033.6 3043.5 5804.9 5977.5 5992.3 6002.3 6051.3 5788.2 5798.4 5813.2 5820.0 5824.9 5989.6 6025.5 6050.4 6067.5 6098.5 5552.3 5560.3 5625.8 5678.5 5722.5 5555.4 5585.7 5598.7 5603.7 5612.9 5631.9 6017.6 6096.2 6100.5 6113.0 4050.3 4221.9 4333.4 4362.1 4368.3 5951.3 5978.8 5979.8 5984.3 6019.5 5617.0 5805.6 5813.6 5845.5 5901.6 5748.4 5761.9 5773.7 5789.3 5811.3 5711.5 5736.0 5743.2 5795.7 5800.5 5559.7 5744.9 5799.3 5801.8 5816.9 5669.5 5671.9 5687.6 5694.4 5709.3 06:34:53 INFO - PROCESS | 30633 | 06:34:53 INFO - PROCESS | 30633 | [#5] yui.html Cycles:180 Average:18894.00 Median:43529.18 stddev:23302.88 (53.5%) stddev-sans-first:23328.83 06:34:53 INFO - PROCESS | 30633 | Values: 843.3 859.8 866.7 926.4 932.2 15359.3 17005.5 17433.8 17615.1 17671.1 15177.2 15479.7 16048.8 16261.1 16308.0 806.0 811.0 811.4 814.1 828.2 840.4 845.0 845.2 848.7 849.7 887.7 889.5 892.8 894.2 894.8 883.3 884.8 886.8 886.9 887.9 645.4 647.5 648.6 649.3 651.5 17051.7 17203.3 17314.7 17774.0 17997.1 16355.2 16391.3 16609.3 16652.8 16736.0 13839.3 13883.2 13907.3 13988.0 14069.9 4008.0 4045.1 4076.2 4104.5 4119.8 86797.6 87731.0 89887.6 89986.1 90110.0 12653.7 12684.6 12726.0 12760.6 12780.0 24039.2 24257.9 24263.2 24355.5 24488.0 8284.3 8311.0 8464.7 8498.5 8500.2 4797.8 4835.0 4854.4 4854.6 4866.8 3867.9 3903.3 3909.4 3948.3 3977.7 674.2 685.0 686.5 697.5 707.3 692.4 695.5 708.5 716.9 721.1 11187.5 11210.7 11294.8 11666.6 11882.6 837.2 848.1 857.9 859.6 867.7 5283.0 5363.9 5545.3 5553.5 5960.4 66147.7 77387.0 78553.6 81816.0 86309.6 67503.0 67740.0 67902.3 69827.7 70957.0 64808.0 64983.0 66300.0 66821.0 67787.3 10411.8 10877.2 11152.4 11164.8 11184.0 42874.6 44183.8 44255.8 44390.1 44961.6 54995.7 55457.2 56041.4 56890.0 57511.0 14065.3 14313.7 14598.3 14911.7 14932.2 15541.3 15784.2 15913.6 16056.2 17420.6 14780.7 14991.3 15529.9 16385.4 16387.7 15652.3 16246.5 16408.4 17106.0 17122.8 14642.3 14695.0 15907.2 16038.7 16542.5 12725.5 12766.7 12827.7 13472.1 13701.2 11796.9 12028.3 12282.9 12471.8 12733.9 06:34:53 INFO - PROCESS | 30633 | -------- Summary: end -------- 06:34:53 INFO - PROCESS | 30633 | 06:34:54 INFO - TEST-INFO | 30633: exit 0 06:34:54 INFO - TEST-OK | dromaeo_css | took 1112598ms 06:34:54 INFO - TEST-START | kraken 06:34:54 INFO - operating with platform_type : linux_ 06:34:54 INFO - Initialising browser for kraken test... 06:34:54 INFO - TEST-INFO | started process 31005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8wWqQM/profile http://localhost:52152/getInfo.html) 06:34:59 INFO - PROCESS | 31005 | __metrics Screen width/height:1600/1200 06:34:59 INFO - PROCESS | 31005 | colorDepth:24 06:34:59 INFO - PROCESS | 31005 | Browser inner width/height: 1024/697 06:34:59 INFO - PROCESS | 31005 | __metrics 06:34:59 INFO - PROCESS | 31005 | 1486650899944 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 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmp8wWqQM/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp8wWqQM/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp8wWqQM/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp8wWqQM/profile/extensions/talos-powers@TalosPowersService.js:55:9 06:35:00 ERROR - PROCESS | 31005 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 06:35:00 INFO - TEST-INFO | 31005: exit 0 06:35:00 INFO - Browser initialized. 06:35:00 INFO - Running cycle 1/1 for kraken test... 06:35:00 INFO - TEST-INFO | started process 31131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8wWqQM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:35:12 INFO - PROCESS | 31131 | RSS: Main: 144490496 06:35:12 INFO - PROCESS | 31131 | 06:35:15 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52152/tests/kraken/driver.html?testName=audio-beat-detection) 06:35:16 INFO - PROCESS | 31131 | RSS: Main: 150933504 06:35:16 INFO - PROCESS | 31131 | 06:35:18 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52152/tests/kraken/driver.html?testName=audio-dft) 06:35:19 INFO - PROCESS | 31131 | RSS: Main: 149934080 06:35:19 INFO - PROCESS | 31131 | 06:35:22 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52152/tests/kraken/driver.html?testName=audio-fft) 06:35:22 INFO - PROCESS | 31131 | RSS: Main: 150499328 06:35:22 INFO - PROCESS | 31131 | 06:35:24 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52152/tests/kraken/driver.html?testName=audio-oscillator) 06:35:25 INFO - PROCESS | 31131 | RSS: Main: 150548480 06:35:25 INFO - PROCESS | 31131 | 06:35:27 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52152/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:35:28 INFO - PROCESS | 31131 | RSS: Main: 150253568 06:35:28 INFO - PROCESS | 31131 | 06:35:31 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52152/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:31 INFO - PROCESS | 31131 | RSS: Main: 153419776 06:35:31 INFO - PROCESS | 31131 | 06:35:35 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52152/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:35 INFO - PROCESS | 31131 | RSS: Main: 153292800 06:35:35 INFO - PROCESS | 31131 | 06:35:38 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52152/tests/kraken/driver.html?testName=json-parse-financial) 06:35:39 INFO - PROCESS | 31131 | RSS: Main: 152702976 06:35:39 INFO - PROCESS | 31131 | 06:35:40 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52152/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:41 INFO - PROCESS | 31131 | RSS: Main: 152133632 06:35:41 INFO - PROCESS | 31131 | 06:35:43 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52152/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:44 INFO - PROCESS | 31131 | RSS: Main: 152563712 06:35:44 INFO - PROCESS | 31131 | 06:35:46 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52152/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:46 INFO - PROCESS | 31131 | RSS: Main: 153055232 06:35:46 INFO - PROCESS | 31131 | 06:35:49 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52152/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:49 INFO - PROCESS | 31131 | RSS: Main: 153251840 06:35:49 INFO - PROCESS | 31131 | 06:35:52 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52152/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:53 INFO - PROCESS | 31131 | RSS: Main: 152952832 06:35:53 INFO - PROCESS | 31131 | 06:35:54 INFO - PROCESS | 31131 | Cycle 1(1): loaded http://localhost:52152/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52152/tests/kraken/driver.html?testName=ai-astar) 06:35:55 INFO - PROCESS | 31131 | RSS: Main: 154783744 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | __start_tp_report 06:35:55 INFO - PROCESS | 31131 | _x_x_mozilla_page_load 06:35:55 INFO - PROCESS | 31131 | _x_x_mozilla_page_load_details 06:35:55 INFO - PROCESS | 31131 | |i|pagename|runs| 06:35:55 INFO - PROCESS | 31131 | |0;ai-astar;106;113;113;112;113;112;113;113;115;113 06:35:55 INFO - PROCESS | 31131 | |1;audio-beat-detection;143;122;118;150;118;119;121;132;136;120 06:35:55 INFO - PROCESS | 31131 | |2;audio-dft;161;162;164;161;162;163;163;163;163;162 06:35:55 INFO - PROCESS | 31131 | |3;audio-fft;74;76;75;121;76;76;77;75;97;75 06:35:55 INFO - PROCESS | 31131 | |4;audio-oscillator;83;83;105;83;84;83;96;83;82;109 06:35:55 INFO - PROCESS | 31131 | |5;imaging-gaussian-blur;118;118;119;118;118;117;117;118;118;117 06:35:55 INFO - PROCESS | 31131 | |6;imaging-darkroom;147;147;147;151;147;147;147;147;149;147 06:35:55 INFO - PROCESS | 31131 | |7;imaging-desaturate;97;97;100;96;97;96;96;96;97;97 06:35:55 INFO - PROCESS | 31131 | |8;json-parse-financial;55;60;56;57;59;57;56;56;56;56 06:35:55 INFO - PROCESS | 31131 | |9;json-stringify-tinderbox;64;65;65;66;65;65;65;66;65;66 06:35:55 INFO - PROCESS | 31131 | |10;stanford-crypto-aes;78;78;76;84;78;76;76;85;77;76 06:35:55 INFO - PROCESS | 31131 | |11;stanford-crypto-ccm;124;135;122;121;134;122;129;135;161;120 06:35:55 INFO - PROCESS | 31131 | |12;stanford-crypto-pbkdf2;158;158;160;158;157;170;155;164;161;160 06:35:55 INFO - PROCESS | 31131 | |13;stanford-crypto-sha256-iterative;60;65;61;61;60;60;61;60;60;60 06:35:55 INFO - PROCESS | 31131 | __end_tp_report 06:35:55 INFO - PROCESS | 31131 | __start_cc_report 06:35:55 INFO - PROCESS | 31131 | _x_x_mozilla_cycle_collect,714 06:35:55 INFO - PROCESS | 31131 | __end_cc_report 06:35:55 INFO - PROCESS | 31131 | __startTimestamp1486650955213__endTimestamp 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | ------- Summary: start ------- 06:35:55 INFO - PROCESS | 31131 | Number of tests: 14 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.36 (2.1%) stddev-sans-first:0.87 06:35:55 INFO - PROCESS | 31131 | Values: 106.0 113.0 113.0 112.0 113.0 112.0 113.0 113.0 115.0 113.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:127.00 stddev:11.64 (9.2%) stddev-sans-first:10.99 06:35:55 INFO - PROCESS | 31131 | Values: 143.0 122.0 118.0 150.0 118.0 119.0 121.0 132.0 136.0 120.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 06:35:55 INFO - PROCESS | 31131 | Values: 161.0 162.0 164.0 161.0 162.0 163.0 163.0 163.0 163.0 162.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:15.24 (20.0%) stddev-sans-first:15.87 06:35:55 INFO - PROCESS | 31131 | Values: 74.0 76.0 75.0 121.0 76.0 76.0 77.0 75.0 97.0 75.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:83.00 stddev:10.32 (12.4%) stddev-sans-first:10.71 06:35:55 INFO - PROCESS | 31131 | Values: 83.0 83.0 105.0 83.0 84.0 83.0 96.0 83.0 82.0 109.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:35:55 INFO - PROCESS | 31131 | Values: 118.0 118.0 119.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.41 06:35:55 INFO - PROCESS | 31131 | Values: 147.0 147.0 147.0 151.0 147.0 147.0 147.0 147.0 149.0 147.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:1.20 (1.2%) stddev-sans-first:1.27 06:35:55 INFO - PROCESS | 31131 | Values: 97.0 97.0 100.0 96.0 97.0 96.0 96.0 96.0 97.0 97.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:1.55 (2.7%) stddev-sans-first:1.50 06:35:55 INFO - PROCESS | 31131 | Values: 55.0 60.0 56.0 57.0 59.0 57.0 56.0 56.0 56.0 56.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 06:35:55 INFO - PROCESS | 31131 | Values: 64.0 65.0 65.0 66.0 65.0 65.0 65.0 66.0 65.0 66.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:3.34 (4.3%) stddev-sans-first:3.54 06:35:55 INFO - PROCESS | 31131 | Values: 78.0 78.0 76.0 84.0 78.0 76.0 76.0 85.0 77.0 76.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:131.50 stddev:12.35 (9.4%) stddev-sans-first:12.88 06:35:55 INFO - PROCESS | 31131 | Values: 124.0 135.0 122.0 121.0 134.0 122.0 129.0 135.0 161.0 120.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:4.25 (2.7%) stddev-sans-first:4.44 06:35:55 INFO - PROCESS | 31131 | Values: 158.0 158.0 160.0 158.0 157.0 170.0 155.0 164.0 161.0 160.0 06:35:55 INFO - PROCESS | 31131 | 06:35:55 INFO - PROCESS | 31131 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:60.50 stddev:1.55 (2.6%) stddev-sans-first:1.62 06:35:55 INFO - PROCESS | 31131 | Values: 60.0 65.0 61.0 61.0 60.0 60.0 61.0 60.0 60.0 60.0 06:35:55 INFO - PROCESS | 31131 | -------- Summary: end -------- 06:35:55 INFO - PROCESS | 31131 | 06:35:56 INFO - TEST-INFO | 31131: exit 0 06:35:56 INFO - TEST-OK | kraken | took 61977ms 06:35:56 INFO - SUITE-END | took 1174s 06:35:56 INFO - Completed test suite (00:19:34) 06:35:56 INFO - javascript benchmark 06:35:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7585.6219661855375, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.5515905352777, 3339.549160863283, 3347.2134048498597, 3351.6480769519185, 3370.8314584270797, 5432.728363581825, 5465.453454654533, 5494.2582751328555, 5502.5597952163835, 5528.364238112618, 5538.75075621597, 5552.305961754781, 5626.859328516779, 5643.463870932265, 5651.632643878155, 5117.513836185556, 5137.101007323722, 5180.766865491043, 5201.791928322863, 5220.712860792655, 5122.282880396748, 5176.120059589879, 5179.015986962465, 5193.195054766517, 5205.37535495741, 5035.899282014358, 5041.571466425358, 5182.507661772144, 5190.92213616796, 5214.634975551713, 5042.117629414856, 5061.44324124346, 5086.059079070384, 5135.0, 5158.871028224287, 4986.700797952134, 5075.568576670988, 5077.746112694387, 5092.0, 5100.15847385181, 5345.385280692732, 5450.482204190595, 5454.181872719084, 5536.944630553683, 5548.278723765885, 5832.970835145839, 5844.532437404998, 5901.557383196277, 5917.0, 5927.555433342516, 5870.090136028923, 5921.496672782819, 5936.079907614327, 5945.31628862682, 5946.048632218867, 5509.47659972302, 5527.060399732055, 5538.723063846832, 5550.69471179085, 5558.333000040021, 5925.200097986803, 5949.732262048218, 6046.274447066292, 6090.23872015998, 6110.663913484712, 5830.38780928005, 5883.02930016551, 5894.351621321651, 5896.64620122794, 5901.996660567714, 5918.674472904032, 5935.376785437467, 5955.970220148872, 5958.702064896738, 5965.0, 5745.368009518949, 5786.07422812348, 5800.477956983892, 5834.212381328552, 5956.791512297049, 5902.439268269508, 5911.201987731687, 5918.0, 5927.585069045125, 5946.67293298864, 4441.955580444219, 4446.9777651111535, 4452.888677783017, 4464.821407143678, 4474.440694913136, 3994.7802870842384, 4004.099077707551, 4009.51885773709, 4013.6387725104883, 4033.6773058155277, 5801.970990145022, 5807.477327040587, 5825.854353641193, 5831.533477321804, 5872.706364681834, 5924.407559244041, 5935.317438494542, 5981.0729336952845, 5992.580519363602, 5995.670238136857, 5659.971700141556, 5706.3152421709665, 5741.25363702716, 5767.279090113736, 5788.016037273674, 5101.464346243591, 5104.872378190575, 5106.412762532282, 5136.0, 5136.486351364908, 6195.752169913243, 6230.43926046658, 6240.157578726905, 6252.0, 6252.187215661935, 5857.326407463196, 5888.970555147197, 5922.289325280994, 5977.043673012471, 5985.162077309267, 6173.1666225060835, 6294.43350098475, 6295.1186833842385, 6296.118543403835, 6309.432151106423, 5838.854028649148, 5921.644701317935, 5929.703514824155, 5940.079287710412, 5964.910526342195, 5773.797917072882, 5809.680467574324, 6003.129546215861, 6013.6692481913915, 6053.334133245427, 5738.569607279387, 5771.509421699203, 5779.104238842818, 5820.796272130455, 5830.4461076197695, 5809.128630705428, 5817.9127313091185, 5826.038703613856, 5832.300123985149, 5840.591158618856, 5776.566757493289, 5780.537556995346, 5781.075027995501, 5792.073268277056, 5794.507466865195, 5598.244237027949, 5709.885802284014, 5732.856678583069, 5801.042827933344, 5855.824325270249, 5808.419158084158, 5822.155787410887, 5834.824955251349, 5869.090291004901, 5880.382559831156], "value": 5500.620752904873, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3141869790808, 612.4457366083694, 617.6016469377251, 716.5163514627628, 734.8493558820443, 44701.552984470145, 45863.082738345256, 49016.264756028686, 49168.26247606289, 49242.261366079445, 49998.75000625001, 51053.48946510543, 51092.23361649578, 51164.23253651198, 51178.0, 9148.313876459275, 10640.09559187466, 11026.669199924016, 11042.723931901726, 11327.830082548728, 10782.514786834612, 10834.891651083468, 10859.83710244347, 10864.511097000654, 10864.565417383295, 10849.620263290786, 10944.124470042418, 10992.17558683098, 10996.23026388153, 11025.61410350638, 10730.946345268301, 10806.405647689375, 10808.351498910091, 10841.241113122085, 10923.289986150914, 10820.404877731722, 10877.619283325124, 10894.237403381767, 10937.179711521667, 10970.286931349516, 42831.0, 42980.57019429797, 43211.35182972258, 43421.78289108534, 43454.56545434537, 4389.275769498029, 4411.580899814512, 4481.193385190664, 4561.657875659339, 4565.429321334833, 32155.83922080398, 32369.67630323714, 32722.509162362585, 32943.6705632943, 33585.16037099068, 4575.862724118282, 4683.508231635663, 4710.905781884343, 4711.882202944919, 4732.597729193023, 351723.0, 352176.0, 352718.0, 354174.0, 356196.0, 56323.71838140783, 56723.43276567264, 56810.71594642083, 56822.7158864203, 57008.42991570114, 58838.0, 58936.70531647314, 59005.0, 59479.40520594825, 59551.702241488514, 17729.0, 18724.063796810104, 18937.90531047336, 19225.13486893065, 19244.518887027938, 13691.383887724876, 13802.102863313852, 13915.791263131061, 13939.581812545639, 14020.859791401956, 20550.486237843874, 20621.38135855927, 20644.07101680428, 20663.690044649342, 20762.896185518977, 7519.699212031457, 7561.962190189014, 7607.430606546411, 7799.142094369615, 7824.843503129906, 968.4576637083256, 976.1702552830179, 977.8924318324979, 979.4417182206074, 986.2553771902311, 34229.48655770165, 34456.0, 34497.482537761956, 34572.13569660779, 34573.0, 1052.2213561964245, 1169.2107827216764, 1171.91796574239, 1181.769554936779, 1194.0805579703579, 17850.19674114642, 17906.28374864991, 18033.368832090815, 18153.364632237808, 18249.178786954355, 156236.0, 156557.0, 156631.0, 157367.0, 157949.210253948, 69867.3013269871, 70424.64787676028, 70534.2946570538, 70617.0, 70711.0, 1481.3111902964959, 1488.0922637191304, 1500.3323521033035, 1516.8862335324675, 1539.622792415843, 32868.83565582157, 32995.83502082474, 33546.0, 33678.49482257817, 33892.0, 59751.402485974584, 59974.0, 60046.69976650089, 60452.09321860263, 60492.69753651204, 416096.0, 420328.0, 422971.0, 423405.0, 423993.0, 31936.52095218527, 32816.67183328136, 32970.5054424179, 33075.66924330822, 33162.170945725586, 46773.2984005247, 47265.0, 48349.75825120852, 54606.45393546172, 54704.7767580424, 41418.1716365665, 42035.0, 42826.0, 42940.785296074566, 43289.35065974076, 41550.0, 42063.0, 43017.139657207306, 43260.35109473298, 43530.34704479372, 41174.1765164701, 41304.79347603243, 41825.0, 42065.57934420617, 45271.0, 34112.48831267483, 37099.25801483901, 37197.25605487929, 37554.62445375511, 37655.81172094122, 28725.267596496753, 29115.85442072776, 29297.41405171927, 29488.41023179567, 29495.705042949296], "value": 21081.768098930148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.53509012901236, 442.5817602365765, 445.50326386079513, 449.126449056585, 455.20793818755374, 20411.183552657894, 21152.89423552882, 22379.0, 22492.662610060863, 22516.77483225167, 22632.54734905301, 23251.186208482708, 23479.178228761997, 23532.76467235327, 23743.0, 6020.337762846083, 6027.819165425044, 6189.969050154743, 6235.469985051276, 6246.937530624704, 5987.371326010772, 6114.847128821771, 6118.3269840317525, 6120.846978825521, 6126.908096378558, 5836.533077353802, 6033.517318614522, 6076.392360763933, 6085.908711369333, 6088.969555152218, 6092.451679348857, 6114.510839132881, 6136.110264011738, 6148.354422785588, 6161.4146656067605, 5394.91907621386, 5518.448155184489, 5530.087535556629, 5540.778368865241, 5556.472135147154, 26329.868350658315, 26605.866970665218, 26806.86596567024, 26920.461590768075, 27053.729462705316, 2479.7148327942336, 2561.2316305108393, 2569.1393383216646, 2578.4714133602565, 2591.922242332733, 11257.831132533018, 12909.935450322688, 15364.0, 15499.0, 16512.174391280507, 2058.8970551472516, 2061.9278325258692, 2084.062172022596, 2089.5298557824367, 2099.202303124818, 97838.0, 97841.51079244558, 98159.0, 101008.49495752547, 101731.0, 10525.526351314209, 10629.734256643645, 10780.191485638608, 10826.56693732242, 12671.493140274286, 14430.855691443161, 14700.411983520753, 14707.191104489142, 14779.113253204841, 14820.407183712747, 8591.527465989306, 8977.147171018743, 9011.504367259733, 9133.360664753536, 9191.0, 9069.410488318239, 9090.590923408463, 9178.173964343108, 9341.626334946663, 9447.244220462346, 4409.11817636474, 4469.7318160910445, 4492.797824097924, 4546.295324224684, 4636.907261854812, 2201.9889900550716, 2209.171560664751, 2254.1884921428273, 2317.1310758465575, 2320.6519022146813, 910.2172131966504, 912.8995810460976, 926.8841394825647, 928.2295694573622, 944.7024187380953, 19657.803421965596, 21096.261630842848, 21408.678869816966, 21550.46123846885, 21554.568908622052, 942.3780304998805, 945.9499955049889, 948.4356807699407, 950.5294879034922, 952.2526164488241, 11453.0, 11990.0, 11998.0, 12057.819132713017, 12090.335031573348, 656188.0, 656412.0, 668350.0, 715401.0, 726883.0, 100697.0, 101756.49121754344, 109955.45022274838, 111827.4408627968, 112712.0, 1164.1618035014776, 1187.9643610691694, 1211.9151659383936, 1213.9514419423124, 1229.225587879648, 19688.704669429684, 19737.605247895248, 19951.20195192234, 19961.800381995996, 19977.0, 43123.137537248454, 43262.351064734685, 46389.07221855612, 46576.30135548037, 48402.51597484121, 66201.33798661952, 70088.64955675189, 70112.0, 70558.0, 70732.29267707258, 9355.391899526508, 9557.522123893916, 9583.760405989906, 9694.175995040501, 9694.6122155113, 10267.84598231042, 10539.367637941748, 10760.83858742135, 14497.565073047403, 14718.484853030093, 12159.696007599881, 12200.206986545845, 12230.571929982763, 12330.321832299309, 12405.069619778373, 12164.391780410768, 12250.571230006906, 12405.875941240472, 12433.37833108323, 12620.747585048064, 12360.0, 13027.348632568144, 13207.60377188686, 13304.800427993781, 13419.114890298633, 9628.47043412619, 9665.71002869915, 9667.613295468103, 9721.125098741148, 9783.217342612432, 10764.46177691128, 12287.0, 12337.50649974027, 12399.75200496003, 12599.93700031494], "value": 10130.092183926276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.911445313282, 1494.5441640299712, 1517.3475405575612, 1523.200319832088, 1523.9695206095878, 7815.179406162342, 7990.400719946013, 8314.334853211743, 8823.602937867796, 8890.599923003472, 8177.0, 8464.195901389357, 8474.830503389943, 8552.5296108714, 8672.52301123438, 2462.2982450001796, 2497.5878979968284, 2499.0628514307136, 2501.962470562943, 2503.824732268742, 2410.1323523531514, 2483.3170878008514, 2489.0790407549234, 2491.5141547398266, 2500.8374455660323, 2405.9639105413435, 2414.058517178293, 2414.915477958272, 2416.299273210767, 2417.9240238094053, 2334.393057804966, 2335.637976113705, 2349.553584818879, 2360.6459031145296, 2366.8343215974887, 2328.639060945556, 2341.660459233419, 2377.322463098009, 2378.1319818266206, 2378.21518898763, 8474.152584741538, 8474.406791524534, 8533.359998000175, 8539.274161696263, 8568.143185681445, 5229.947700523022, 5333.306670132897, 5340.946590534084, 5368.1679339702405, 5376.91934620981, 3295.8516866741056, 3355.5470011548373, 3410.0, 3456.1359660084977, 3469.115375579211, 1432.248069763372, 1458.5843034735155, 1476.431573844067, 1494.1408690003184, 1495.9476418325307, 11174.66476005721, 11518.827217591743, 11568.363739994296, 11877.16859819813, 11903.761924761542, 4377.606015458624, 4511.05267893746, 4541.591256786905, 4730.361401210861, 4757.714537127784, 9284.0, 9318.627254909863, 9336.533173341442, 9345.766355841022, 9373.859392109123, 5327.413984461706, 5349.973250133802, 5354.678719276856, 5360.544353729977, 5367.75845086972, 4878.219484882402, 4965.081459929925, 5086.72023038729, 5115.7442127893455, 5146.794128234904, 3905.628965248297, 4004.1791432756213, 4017.819198136091, 4042.211768705074, 4056.9391459128137, 1249.8687637798082, 1252.2423933520272, 1260.5588044184462, 1262.551794113095, 1267.0940277701488, 976.3360914578155, 1073.0825144501496, 1082.6697857153645, 1085.9891401086047, 1090.6727981605486, 6012.038073908154, 6031.306399763996, 6037.426444487766, 6063.848403789941, 6072.574919755663, 667.7028722218566, 1032.2722480651123, 1074.3446497636435, 1084.3981590217347, 1120.9719757005978, 4130.958690413117, 4197.433346498184, 4216.9789151054665, 4217.514985776614, 4297.312430011246, 10014.0, 10288.485575721184, 10302.639407620698, 10311.020453056948, 10320.845187322197, 10094.646687365906, 10094.798104038025, 10118.0, 10232.334898231591, 10240.231982601335, 7854.607269636495, 7860.253275938777, 7901.446898717149, 7951.960240198762, 7960.164182760843, 5571.916421253603, 5673.092305231144, 5704.828855134353, 5733.111367738007, 5834.0, 8896.510691912006, 9058.320625953213, 9058.954705226432, 9105.27157827359, 9191.86212206804, 8906.153915378029, 9182.0, 9186.58660360272, 9198.310126740655, 9277.582508787256, 7287.927120728725, 7466.701331946879, 7552.0, 7753.806154845948, 7929.563873986755, 8321.12628174033, 8352.123027082069, 8388.370872184489, 8425.031121421114, 8427.62075706607, 7469.58917259556, 7497.0, 7524.0, 7544.886826697494, 7661.731839385595, 7277.381422578928, 7323.377512911462, 7393.8151546211775, 7415.295546923249, 7429.294217049372, 6517.73929042833, 6577.934220657924, 6598.769043083469, 6645.235797883305, 6649.501287403561, 5051.090803655377, 5111.05445492585, 5144.819931302386, 5183.611229157904, 5350.090484617546, 5334.653247538898, 5336.786528538815, 5341.385740639721, 5384.569234461312, 5526.668399896019], "value": 4631.061882671007, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.0912900329242, 411.28641806465794, 412.60390025575447, 413.2394811768428, 420.4975054809503, 5239.371275446947, 5326.387465441476, 5461.317335333083, 5503.477169668885, 5542.974549708301, 5355.7857685692525, 5403.729813509319, 5466.480684334992, 5468.562514998801, 5481.5340696040785, 4333.956660433402, 4341.305391137419, 4360.302351623741, 4391.473023237216, 4399.5160532341415, 4279.935800962988, 4307.8492252771, 4336.522982471925, 4392.626626736731, 4401.383806267125, 4286.76422796746, 4316.503602085753, 4317.373980772786, 4317.611414972652, 4326.598737700575, 4292.699511034198, 4325.805338759732, 4331.133773245332, 4333.090051089275, 4343.348497725351, 3810.4474851146706, 3845.61543845616, 3863.4784304118866, 3868.2263547290654, 3887.522741358294, 5336.146216605363, 5337.11937530307, 5345.572354211693, 5368.141097424394, 5370.5435038021815, 4931.679440836334, 4945.9258111128365, 4963.6525443218625, 4965.627577931669, 4967.826126085606, 5555.0, 5679.630823996468, 5741.617228850022, 5752.309722833245, 5775.422457754233, 4192.128392051424, 4197.223513649954, 4199.958000419987, 4214.747115173069, 4221.6833737469815, 5954.8809023819285, 5986.323829327752, 6013.75944962201, 6014.127951447016, 6020.8193754187005, 4211.0, 4237.512686041083, 4335.34969754533, 4350.521442641307, 4358.585934336233, 4275.422817919603, 4345.9356805517755, 4349.739015659071, 4354.303311470149, 4361.956380436219, 4937.407511098691, 4948.802047918115, 4951.257311403247, 4976.054549635558, 4984.501549844987, 5678.914816277759, 5727.4845263926445, 5817.50551203144, 5850.3272123705465, 5852.356240813507, 1424.2095636921401, 1425.664968732347, 1426.8359138699182, 1430.5207755401848, 1441.704450587627, 984.4044353166374, 1012.6860673191334, 1014.3558840136419, 1027.2398425165325, 1028.5011769291887, 5515.944840551543, 5523.696196709219, 5533.78648540587, 5574.804881829116, 5588.21764952907, 5673.205751194836, 5680.488756011896, 5756.359437560275, 5760.6255593386295, 5761.164631128463, 5457.45425457459, 5560.833175004756, 5574.414686457863, 5656.462636049569, 5697.715114244271, 2999.1555193555805, 3009.5786589877434, 3014.0, 3033.5752994580776, 3043.4978228592036, 5804.912926306109, 5977.491913187341, 5992.250968628921, 6002.349353927705, 6051.334353221142, 5788.218590490314, 5798.420157984167, 5813.151555737658, 5819.970900145472, 5824.88350232993, 5989.580729348903, 6025.487833534199, 6050.394960503914, 6067.453929146398, 6098.481629061579, 5552.250446189712, 5560.332760068818, 5625.831225063254, 5678.517326027334, 5722.5421966241765, 5555.361133469541, 5585.664860108406, 5598.692071936082, 5603.719814009365, 5612.915806262828, 5631.88736225265, 6017.638941663514, 6096.237970253718, 6100.450959413674, 6112.991356426318, 4050.311447053949, 4221.852235171754, 4333.371661109185, 4362.1493808707, 4368.322909948963, 5951.256092988377, 5978.7608495661425, 5979.790707325223, 5984.341722410619, 6019.458248757633, 5617.0, 5805.593608447368, 5813.593048486566, 5845.532357411482, 5901.586888917906, 5748.39641837601, 5761.884762304814, 5773.711314434346, 5789.263221033589, 5811.331696854916, 5711.5145212655725, 5736.0248757712125, 5743.224664670216, 5795.6527606319505, 5800.50695690871, 5559.6664200148125, 5744.885102298014, 5799.333076696234, 5801.810628820997, 5816.912746308724, 5669.461401166883, 5671.886562268649, 5687.60186786921, 5694.430556944272, 5709.343425505954], "value": 4415.927251756433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.2663582683067, 859.8108416148445, 866.7399780065979, 926.4117285523693, 932.1889955738507, 15359.308831102599, 17005.489835304947, 17433.82566174338, 17615.119244037778, 17671.116444177806, 15177.16525591092, 15479.690406191869, 16048.75926861098, 16261.10563918984, 16308.0, 805.963731632078, 811.0227176252631, 811.3711873298182, 814.0597609760736, 828.2380210206609, 840.3949156607233, 845.0408786027841, 845.1632883445376, 848.7156802471179, 849.6983570832358, 887.6848718704864, 889.4574309671095, 892.7678803511102, 894.1952242981337, 894.789724414762, 883.3286702106445, 884.8009197930478, 886.8182022685367, 886.9379143459961, 887.8712586674928, 645.4384685323798, 647.5402464250387, 648.6043513456788, 649.337675570915, 651.5178767711907, 17051.744223836653, 17203.311867525284, 17314.65370692579, 17774.0, 17997.1001449927, 16355.182240887909, 16391.344346226255, 16609.252583633646, 16652.75020874688, 16736.0, 13839.30803459833, 13883.167009979434, 13907.304634768221, 13988.0, 14069.859301406957, 4007.97996010021, 4045.130296986162, 4076.164386300801, 4104.527979282391, 4119.8352065917325, 86797.56601217017, 87731.0, 89887.55056224743, 89986.10013899909, 90110.0, 12653.746925061447, 12684.556040538537, 12726.0, 12760.617181484571, 12779.977601791834, 24039.158629447884, 24257.878710606336, 24263.150789722276, 24355.512889742105, 24488.0, 8284.25441710237, 8311.0, 8464.703735369232, 8498.532580707997, 8500.192481714228, 4797.808087676523, 4835.0, 4854.368932038812, 4854.5873600744335, 4866.829660961849, 3867.9226415471535, 3903.2974064668633, 3909.4331321958157, 3948.348522493814, 3977.7414468059483, 674.2212744280364, 684.9623270720059, 686.5160062156168, 697.5221972948547, 707.2891743797451, 692.3976140757574, 695.485340847769, 708.4757279613049, 716.8637958787814, 721.1166321256419, 11187.4965626547, 11210.66368008961, 11294.754828974894, 11666.591669291534, 11882.643520694393, 837.1962915600969, 848.1052489623384, 857.8713193020972, 859.5959898847532, 867.7353407210735, 5282.996230716151, 5363.919541206885, 5545.279113715191, 5553.500184983371, 5960.433758792908, 66147.66926165434, 77387.0, 78553.60723196347, 81816.0, 86309.5684521586, 67503.0, 67740.0, 67902.3209767906, 69827.65086174537, 70957.0, 64808.0, 64983.0, 66300.0, 66821.0, 67787.3221267781, 10411.843822342822, 10877.238593298393, 11152.44237788091, 11164.832527511931, 11184.0, 42874.57125428706, 44183.77908110439, 44255.77872110619, 44390.11219775651, 44961.550384495735, 54995.72502137624, 55457.1681424787, 56041.43958560525, 56890.0, 57511.0, 14065.296735163405, 14313.71372572522, 14598.343074561457, 14911.701765964403, 14932.178730169511, 15541.300641471387, 15784.21078946071, 15913.602159946095, 16056.19719014068, 17420.564485887953, 14780.704385912437, 14991.325390357242, 15529.922350388175, 16385.42651007209, 16387.67224655524, 15652.295646696153, 16246.512604621881, 16408.425705100264, 17106.0, 17122.828771712124, 14642.341094650554, 14695.0, 15907.204639768197, 16038.679226415174, 16542.503724888273, 12725.490980360682, 12766.680832978878, 12827.679308017001, 13472.124311919693, 13701.246431445967, 11796.941015295211, 12028.271235916895, 12282.877171228174, 12471.750564988468, 12733.872661273268], "value": 7929.882531655753, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1487.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0, 115.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 118.0, 150.0, 118.0, 119.0, 121.0, 132.0, 136.0, 120.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 161.0, 162.0, 163.0, 163.0, 163.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 121.0, 76.0, 76.0, 77.0, 75.0, 97.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 105.0, 83.0, 84.0, 83.0, 96.0, 83.0, 82.0, 109.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 151.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 100.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 56.0, 57.0, 59.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 84.0, 78.0, 76.0, 76.0, 85.0, 77.0, 76.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 135.0, 122.0, 121.0, 134.0, 122.0, 129.0, 135.0, 161.0, 120.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 160.0, 158.0, 157.0, 170.0, 155.0, 164.0, 161.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 61.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0], "value": 60.8, "unit": "score"}]}]} 06:35:56 INFO - Return code: 0 06:35:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:56 ERROR - # TBPL SUCCESS # 06:35:56 INFO - Running post-action listener: _resource_record_post_action 06:35:56 INFO - [mozharness: 2017-02-09 14:35:56.545358Z] Finished run-tests step (success) 06:35:56 INFO - Running post-run listener: _resource_record_post_run 06:35:56 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361226240; Read time: 12; Write time: 300984 06:35:56 INFO - TinderboxPrint: CPU usage
13.3% 06:35:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:35:56 INFO - TinderboxPrint: I/O write bytes / time
361,226,240 / 300,984 06:35:56 INFO - TinderboxPrint: CPU idle
8,234.8 (86.6%) 06:35:56 INFO - TinderboxPrint: CPU user
1,208.0 (12.7%) 06:35:56 INFO - TinderboxPrint: Swap in / out
0 / 0 06:35:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110116864; Read time: 0; Write time: 139752 06:35:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251109376; Read time: 12; Write time: 161232 06:35:57 INFO - Running post-run listener: _upload_blobber_files 06:35:57 INFO - Blob upload gear active. 06:35:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:57 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:35:57 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:35:57 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:35:57 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:35:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:58 INFO - (blobuploader) - INFO - Done attempting. 06:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:59 INFO - (blobuploader) - INFO - Done attempting. 06:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:36:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:02 INFO - (blobuploader) - INFO - Done attempting. 06:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:03 INFO - (blobuploader) - INFO - Done attempting. 06:36:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:36:03 INFO - Return code: 0 06:36:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:36:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:36:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ff96cf77b98bdfeb419d939fcbe07c9b5a45783660114525ff007ccb2a5dbb66fc702bb0ef718d78afce9be027e5348caad6ac7d03b9cc64e31337e6bd1066f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/82182c93827dc85485aacf5879868cd5c90cac1f479b3299f6248981ab49af734f2aead16deb5b12b814ddf3dad386daa28d596d70ffa8d73d7546ddba1744f0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/365683cc9771629c0c888fe5615c919bea286185164dcf1b8a1323c4946caba61e9dbab44665fb7fa00be360181952a89b8cca83d9bcfebdc630be51b7a8b714", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d436ad95b40d5aa5176ce3cf7c25a0bfc64c7ad91dc0a3c2faa4358fed5006ac3222b9c9024c2c04d4da2f26c46045309b9cfd85e1b04f211eb50f6e6d0bc1a9"} 06:36:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:36:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:36:03 INFO - Contents: 06:36:03 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ff96cf77b98bdfeb419d939fcbe07c9b5a45783660114525ff007ccb2a5dbb66fc702bb0ef718d78afce9be027e5348caad6ac7d03b9cc64e31337e6bd1066f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/82182c93827dc85485aacf5879868cd5c90cac1f479b3299f6248981ab49af734f2aead16deb5b12b814ddf3dad386daa28d596d70ffa8d73d7546ddba1744f0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/365683cc9771629c0c888fe5615c919bea286185164dcf1b8a1323c4946caba61e9dbab44665fb7fa00be360181952a89b8cca83d9bcfebdc630be51b7a8b714", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d436ad95b40d5aa5176ce3cf7c25a0bfc64c7ad91dc0a3c2faa4358fed5006ac3222b9c9024c2c04d4da2f26c46045309b9cfd85e1b04f211eb50f6e6d0bc1a9"} 06:36:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:36:03 INFO - Copying logs to upload dir... 06:36:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:36:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.639391 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 06:36:03.623966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 06:36:03.626957) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ff96cf77b98bdfeb419d939fcbe07c9b5a45783660114525ff007ccb2a5dbb66fc702bb0ef718d78afce9be027e5348caad6ac7d03b9cc64e31337e6bd1066f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/82182c93827dc85485aacf5879868cd5c90cac1f479b3299f6248981ab49af734f2aead16deb5b12b814ddf3dad386daa28d596d70ffa8d73d7546ddba1744f0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/365683cc9771629c0c888fe5615c919bea286185164dcf1b8a1323c4946caba61e9dbab44665fb7fa00be360181952a89b8cca83d9bcfebdc630be51b7a8b714", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d436ad95b40d5aa5176ce3cf7c25a0bfc64c7ad91dc0a3c2faa4358fed5006ac3222b9c9024c2c04d4da2f26c46045309b9cfd85e1b04f211eb50f6e6d0bc1a9"} build_url:https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ff96cf77b98bdfeb419d939fcbe07c9b5a45783660114525ff007ccb2a5dbb66fc702bb0ef718d78afce9be027e5348caad6ac7d03b9cc64e31337e6bd1066f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/82182c93827dc85485aacf5879868cd5c90cac1f479b3299f6248981ab49af734f2aead16deb5b12b814ddf3dad386daa28d596d70ffa8d73d7546ddba1744f0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/365683cc9771629c0c888fe5615c919bea286185164dcf1b8a1323c4946caba61e9dbab44665fb7fa00be360181952a89b8cca83d9bcfebdc630be51b7a8b714", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d436ad95b40d5aa5176ce3cf7c25a0bfc64c7ad91dc0a3c2faa4358fed5006ac3222b9c9024c2c04d4da2f26c46045309b9cfd85e1b04f211eb50f6e6d0bc1a9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 06:36:03.651688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:36:03.652019) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1486649725.653041-1267106378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:36:03.735291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 06:36:03.735619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 06:36:03.735890) ========= ========= Total master_lag: 0.17 =========