builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1491813751.17 results: success (0) revision: efca7a198376e7800873e4612a8b34fc77022d4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:31.172829) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:31.173273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:31.173555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:31.187954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:31.188228) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-10 01:42:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-04-10 01:42:31 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:31.282621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:31.282924) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020597 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:31.331792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 01:42:31.332103) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev efca7a198376e7800873e4612a8b34fc77022d4d --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 efca7a198376e7800873e4612a8b34fc77022d4d --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=9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-10 01:42:31,538 truncating revision to first 12 chars 2017-04-10 01:42:31,538 Setting DEBUG logging. 2017-04-10 01:42:31,538 attempt 1/10 2017-04-10 01:42:31,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/efca7a198376?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 01:42:32,535 unpacking tar archive at: mozilla-aurora-efca7a198376/testing/mozharness/ program finished with exit code 0 elapsedTime=1.342472 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 01:42:32.687683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:32.688036) ========= script_repo_revision: efca7a198376e7800873e4612a8b34fc77022d4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:32.688411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:32.688677) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 01:42:32.697965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-10 01:42:32.698252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:42:32 INFO - MultiFileLogger online at 20170410 01:42:32 in /builds/slave/test 01:42:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 01:42:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:42:32 INFO - {'append_to_log': False, 01:42:32 INFO - 'base_work_dir': '/builds/slave/test', 01:42:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:42:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:42:32 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:42:32 INFO - 'buildbot_json_path': 'buildprops.json', 01:42:32 INFO - 'config_files': ('talos/linux_config.py',), 01:42:32 INFO - 'default_actions': ('clobber', 01:42:32 INFO - 'read-buildbot-config', 01:42:32 INFO - 'download-and-extract', 01:42:32 INFO - 'populate-webroot', 01:42:32 INFO - 'create-virtualenv', 01:42:32 INFO - 'install', 01:42:32 INFO - 'run-tests'), 01:42:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:42:32 INFO - 'download_minidump_stackwalk': True, 01:42:32 INFO - 'download_symbols': 'ondemand', 01:42:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:42:32 INFO - 'tooltool.py': '/tools/tooltool.py', 01:42:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:42:32 INFO - '/tools/misc-python/virtualenv.py')}, 01:42:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:42:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:42:32 INFO - 'gecko_profile': False, 01:42:32 INFO - 'gecko_profile_interval': 0, 01:42:32 INFO - 'installer_path': 'installer.exe', 01:42:32 INFO - 'log_level': 'info', 01:42:32 INFO - 'log_name': 'talos', 01:42:32 INFO - 'log_to_console': True, 01:42:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:42:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:42:32 INFO - 'opt_config_files': (), 01:42:32 INFO - 'pip_index': False, 01:42:32 INFO - 'suite': 'dromaeojs', 01:42:32 INFO - 'system_bits': '32', 01:42:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:42:32 INFO - 'title': 'talos-linux64-ix-013', 01:42:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:42:32 INFO - 'use_talos_json': True, 01:42:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:42:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:42:32 INFO - 'work_dir': 'build'} 01:42:32 INFO - [mozharness: 2017-04-10 08:42:32.997920Z] Running clobber step. 01:42:32 INFO - Running pre-action listener: _resource_record_pre_action 01:42:32 INFO - Running main action method: clobber 01:42:32 INFO - rmtree: /builds/slave/test/build 01:42:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:42:34 INFO - Running post-action listener: _resource_record_post_action 01:42:34 INFO - [mozharness: 2017-04-10 08:42:34.031447Z] Finished clobber step (success) 01:42:34 INFO - [mozharness: 2017-04-10 08:42:34.031545Z] Running read-buildbot-config step. 01:42:34 INFO - Running pre-action listener: _resource_record_pre_action 01:42:34 INFO - Running main action method: read_buildbot_config 01:42:34 INFO - Using buildbot properties: 01:42:34 INFO - { 01:42:34 INFO - "project": "", 01:42:34 INFO - "product": "firefox", 01:42:34 INFO - "who": "nobody@mozilla.org", 01:42:34 INFO - "installer_path": "public/build/target.tar.bz2", 01:42:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:42:34 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:42:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:42:34 INFO - "stage_platform": "linux64", 01:42:34 INFO - "basedir": "/builds/slave/test", 01:42:34 INFO - "buildnumber": 118, 01:42:34 INFO - "platform": "ubuntu64_hw", 01:42:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:42:34 INFO - "slavebuilddir": "test", 01:42:34 INFO - "taskId": "GwjGF7qMTay1R76bXdummw", 01:42:34 INFO - "branch": "mozilla-aurora", 01:42:34 INFO - "script_repo_revision": "production", 01:42:34 INFO - "revision": "efca7a198376e7800873e4612a8b34fc77022d4d", 01:42:34 INFO - "slavename": "talos-linux64-ix-013", 01:42:34 INFO - "repo_path": "releases/mozilla-aurora" 01:42:34 INFO - } 01:42:34 INFO - Finding installer, test and symbols from parent task. 01:42:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwjGF7qMTay1R76bXdummw'}, attempt #1 01:42:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwjGF7qMTay1R76bXdummw'}, attempt #1 01:42:34 INFO - Task dependencies: eaSTkW9-SE6LVESU0UZ2uQ 01:42:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ'}, attempt #1 01:42:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.tar.bz2 01:42:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/test_packages.json 01:42:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.crashreporter-symbols.zip 01:42:35 INFO - Running post-action listener: _resource_record_post_action 01:42:35 INFO - [mozharness: 2017-04-10 08:42:35.390197Z] Finished read-buildbot-config step (success) 01:42:35 INFO - [mozharness: 2017-04-10 08:42:35.390415Z] Running download-and-extract step. 01:42:35 INFO - Running pre-action listener: _resource_record_pre_action 01:42:35 INFO - Running main action method: download_and_extract 01:42:35 INFO - mkdir: /builds/slave/test/build/tests 01:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:42:35 INFO - trying https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.test_packages.json 01:42:35 INFO - Downloading https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:42:35 INFO - Downloaded 896 bytes. 01:42:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:42:35 INFO - Using the following test package requirements: 01:42:35 INFO - {u'common': [u'target.common.tests.zip'], 01:42:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:42:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:42:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:42:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:42:35 INFO - u'mozbase': [u'target.common.tests.zip'], 01:42:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:42:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:42:35 INFO - u'web-platform': [u'target.common.tests.zip', 01:42:35 INFO - u'target.web-platform.tests.zip'], 01:42:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:42:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:42:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.common.tests.zip 01:42:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:42:35 INFO - Fetch https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.common.tests.zip into memory 01:42:37 INFO - Expected file size: 59544254 01:42:37 INFO - Obtained file size: 59544254 01:42:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:42:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.common.tests.zip 01:42:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:42:46 INFO - Fetch https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.common.tests.zip into memory 01:42:48 INFO - Expected file size: 59544254 01:42:48 INFO - Obtained file size: 59544254 01:42:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.talos.tests.zip 01:42:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:42:59 INFO - Fetch https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.talos.tests.zip into memory 01:43:00 INFO - Expected file size: 14404424 01:43:00 INFO - Obtained file size: 14404424 01:43: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')]} 01:43:00 INFO - trying https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.tar.bz2 01:43:00 INFO - Downloading https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:43:01 INFO - Downloaded 66685836 bytes. 01:43:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.tar.bz2 01:43:01 INFO - mkdir: /builds/slave/test/properties 01:43:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:43:01 INFO - Writing to file /builds/slave/test/properties/build_url 01:43:01 INFO - Contents: 01:43:01 INFO - build_url:https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.tar.bz2 01:43:01 INFO - Running post-action listener: _resource_record_post_action 01:43:01 INFO - Running post-action listener: set_extra_try_arguments 01:43:01 INFO - [mozharness: 2017-04-10 08:43:01.491277Z] Finished download-and-extract step (success) 01:43:01 INFO - [mozharness: 2017-04-10 08:43:01.491374Z] Running populate-webroot step. 01:43:01 INFO - Running pre-action listener: _resource_record_pre_action 01:43:01 INFO - Running main action method: populate_webroot 01:43:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:43:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:43:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:43:01 INFO - '--tppagecycles', 01:43:01 INFO - '7'], 01:43:01 INFO - 'tests': ['tsvgm']}}, 01:43:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:43:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:43:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:43:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:43:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:43:01 INFO - 'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:43:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:43:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:43:01 INFO - 'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['damp', 'tps']}, 01:43:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:43:01 INFO - 'tests': ['damp', 'tps']}, 01:43:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['dromaeo_dom']}, 01:43:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:43:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['basic_compositor_video']}, 01:43:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:43:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['a11yr', 01:43:01 INFO - 'ts_paint', 01:43:01 INFO - 'tpaint', 01:43:01 INFO - 'sessionrestore', 01:43:01 INFO - 'sessionrestore_no_auto_restore', 01:43:01 INFO - 'tabpaint']}, 01:43:01 INFO - 'other-e10s': {'tests': ['a11yr', 01:43:01 INFO - 'ts_paint', 01:43:01 INFO - 'tpaint', 01:43:01 INFO - 'sessionrestore', 01:43:01 INFO - 'sessionrestore_no_auto_restore', 01:43:01 INFO - 'tabpaint']}, 01:43:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:43:01 INFO - 'ts_paint', 01:43:01 INFO - 'tpaint', 01:43:01 INFO - 'sessionrestore', 01:43:01 INFO - 'sessionrestore_no_auto_restore', 01:43:01 INFO - 'tabpaint']}, 01:43:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:43:01 INFO - 'ts_paint', 01:43:01 INFO - 'tpaint', 01:43:01 INFO - 'sessionrestore', 01:43:01 INFO - 'sessionrestore_no_auto_restore', 01:43:01 INFO - 'tabpaint']}, 01:43:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['a11yr', 01:43:01 INFO - 'ts_paint', 01:43:01 INFO - 'tpaint', 01:43:01 INFO - 'sessionrestore', 01:43:01 INFO - 'sessionrestore_no_auto_restore', 01:43:01 INFO - 'tabpaint']}, 01:43:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['a11yr', 01:43:01 INFO - 'ts_paint', 01:43:01 INFO - 'tpaint', 01:43:01 INFO - 'sessionrestore', 01:43:01 INFO - 'sessionrestore_no_auto_restore', 01:43:01 INFO - 'tabpaint']}, 01:43:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['tsvgx', 01:43:01 INFO - 'tsvgr_opacity', 01:43:01 INFO - 'tart', 01:43:01 INFO - 'tscrollx', 01:43:01 INFO - 'cart', 01:43:01 INFO - 'tsvg_static']}, 01:43:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:43:01 INFO - 'tsvgr_opacity', 01:43:01 INFO - 'tart', 01:43:01 INFO - 'tscrollx', 01:43:01 INFO - 'cart', 01:43:01 INFO - 'tsvg_static']}, 01:43:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:43:01 INFO - 'talos_options': ['--disable-e10s'], 01:43:01 INFO - 'tests': ['tp5o']}, 01:43:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:43:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:43:01 INFO - 'talos_options': ['--disable-e10s', 01:43:01 INFO - '--xperf_path', 01:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:43:01 INFO - 'tests': ['tp5n']}, 01:43:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:43:01 INFO - 'talos_options': ['--xperf_path', 01:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:43:01 INFO - 'tests': ['tp5n']}}, 01:43:01 INFO - 'talos.zip': {'path': '', 01:43:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:43:01 INFO - Running post-action listener: _resource_record_post_action 01:43:01 INFO - [mozharness: 2017-04-10 08:43:01.504495Z] Finished populate-webroot step (success) 01:43:01 INFO - [mozharness: 2017-04-10 08:43:01.504585Z] Running create-virtualenv step. 01:43:01 INFO - Running pre-action listener: _resource_record_pre_action 01:43:01 INFO - Running main action method: create_virtualenv 01:43:01 INFO - Creating virtualenv /builds/slave/test/build/venv 01:43:01 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 01:43:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:43:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:43:01 INFO - Using real prefix '/usr' 01:43:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:43:02 INFO - Installing distribute.............................................................................................................................................................................................done. 01:43:04 INFO - Installing pip.................done. 01:43:04 INFO - Return code: 0 01:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:43:04 INFO - Reading from file tmpfile_stdout 01:43:04 INFO - Output received: 01:43:04 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) 01:43:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:43: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')]} 01:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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')]} 01:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43: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', 'pip>=1.5'] in /builds/slave/test/build 01:43: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 pip>=1.5 01:43:04 INFO - Using env: {'DISPLAY': ':0', 01:43:04 INFO - 'HOME': '/home/cltbld', 01:43:04 INFO - 'LANG': 'en_US.UTF-8', 01:43:04 INFO - 'LANGUAGE': 'en_US:en', 01:43:04 INFO - 'LOGNAME': 'cltbld', 01:43:04 INFO - 'MAIL': '/var/mail/cltbld', 01:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:04 INFO - 'MOZ_NO_REMOTE': '1', 01:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:04 INFO - 'NO_EM_RESTART': '1', 01:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:04 INFO - 'PWD': '/builds/slave/test', 01:43:04 INFO - 'SHELL': '/bin/bash', 01:43:04 INFO - 'SHLVL': '1', 01:43:04 INFO - 'TERM': 'linux', 01:43:04 INFO - 'TMOUT': '86400', 01:43:04 INFO - 'USER': 'cltbld', 01:43:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:04 INFO - '_': '/tools/buildbot/bin/python'} 01:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:04 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 01:43:04 INFO - Cleaning up... 01:43:04 INFO - Return code: 0 01:43:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:43: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')]} 01:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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')]} 01:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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', '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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01:43: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 psutil>=3.1.1 01:43:04 INFO - Using env: {'DISPLAY': ':0', 01:43:04 INFO - 'HOME': '/home/cltbld', 01:43:04 INFO - 'LANG': 'en_US.UTF-8', 01:43:04 INFO - 'LANGUAGE': 'en_US:en', 01:43:04 INFO - 'LOGNAME': 'cltbld', 01:43:04 INFO - 'MAIL': '/var/mail/cltbld', 01:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:04 INFO - 'MOZ_NO_REMOTE': '1', 01:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:04 INFO - 'NO_EM_RESTART': '1', 01:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:04 INFO - 'PWD': '/builds/slave/test', 01:43:04 INFO - 'SHELL': '/bin/bash', 01:43:04 INFO - 'SHLVL': '1', 01:43:04 INFO - 'TERM': 'linux', 01:43:04 INFO - 'TMOUT': '86400', 01:43:04 INFO - 'USER': 'cltbld', 01:43:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:04 INFO - '_': '/tools/buildbot/bin/python'} 01:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:04 INFO - Downloading/unpacking psutil>=3.1.1 01:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:43:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:43:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:43:06 INFO - Installing collected packages: psutil 01:43:06 INFO - Running setup.py install for psutil 01:43:06 INFO - building 'psutil._psutil_linux' extension 01:43:06 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 01:43:07 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 01:43:07 INFO - building 'psutil._psutil_posix' extension 01:43:07 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 01:43:07 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 01:43:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:43:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:43:07 INFO - Successfully installed psutil 01:43:07 INFO - Cleaning up... 01:43:07 INFO - Return code: 0 01:43:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:07 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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43:07 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 01:43:07 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 01:43:07 INFO - Using env: {'DISPLAY': ':0', 01:43:07 INFO - 'HOME': '/home/cltbld', 01:43:07 INFO - 'LANG': 'en_US.UTF-8', 01:43:07 INFO - 'LANGUAGE': 'en_US:en', 01:43:07 INFO - 'LOGNAME': 'cltbld', 01:43:07 INFO - 'MAIL': '/var/mail/cltbld', 01:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:07 INFO - 'MOZ_NO_REMOTE': '1', 01:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:07 INFO - 'NO_EM_RESTART': '1', 01:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:07 INFO - 'PWD': '/builds/slave/test', 01:43:07 INFO - 'SHELL': '/bin/bash', 01:43:07 INFO - 'SHLVL': '1', 01:43:07 INFO - 'TERM': 'linux', 01:43:07 INFO - 'TMOUT': '86400', 01:43:07 INFO - 'USER': 'cltbld', 01:43:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:07 INFO - '_': '/tools/buildbot/bin/python'} 01:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:43:07 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 01:43:07 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 01:43:07 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 01:43:07 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 01:43:07 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 01:43:07 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 01:43:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:43:09 INFO - Installing collected packages: mozsystemmonitor 01:43:09 INFO - Running setup.py install for mozsystemmonitor 01:43:10 INFO - Successfully installed mozsystemmonitor 01:43:10 INFO - Cleaning up... 01:43:10 INFO - Return code: 0 01:43:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:43:10 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')]} 01:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:10 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')]} 01:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:10 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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43:10 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 01:43:10 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 01:43:10 INFO - Using env: {'DISPLAY': ':0', 01:43:10 INFO - 'HOME': '/home/cltbld', 01:43:10 INFO - 'LANG': 'en_US.UTF-8', 01:43:10 INFO - 'LANGUAGE': 'en_US:en', 01:43:10 INFO - 'LOGNAME': 'cltbld', 01:43:10 INFO - 'MAIL': '/var/mail/cltbld', 01:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:10 INFO - 'MOZ_NO_REMOTE': '1', 01:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:10 INFO - 'NO_EM_RESTART': '1', 01:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:10 INFO - 'PWD': '/builds/slave/test', 01:43:10 INFO - 'SHELL': '/bin/bash', 01:43:10 INFO - 'SHLVL': '1', 01:43:10 INFO - 'TERM': 'linux', 01:43:10 INFO - 'TMOUT': '86400', 01:43:10 INFO - 'USER': 'cltbld', 01:43:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:10 INFO - '_': '/tools/buildbot/bin/python'} 01:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:10 INFO - Downloading/unpacking jsonschema==2.5.1 01:43:10 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 01:43:10 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 01:43:10 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 01:43:10 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 01:43:10 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 01:43:10 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 01:43:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:43:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:12 INFO - Downloading functools32-3.2.3-2.tar.gz 01:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:43:12 INFO - warning: no files found matching '*.txt' 01:43:12 INFO - no previously-included directories found matching 'build' 01:43:12 INFO - no previously-included directories found matching 'dist' 01:43:12 INFO - no previously-included directories found matching '.git*' 01:43:12 INFO - Installing collected packages: jsonschema, functools32 01:43:12 INFO - Running setup.py install for functools32 01:43:12 INFO - warning: no files found matching '*.txt' 01:43:12 INFO - no previously-included directories found matching 'build' 01:43:12 INFO - no previously-included directories found matching 'dist' 01:43:12 INFO - no previously-included directories found matching '.git*' 01:43:12 INFO - Successfully installed jsonschema functools32 01:43:12 INFO - Cleaning up... 01:43:12 INFO - Return code: 0 01:43:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:43:12 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')]} 01:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:12 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')]} 01:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:12 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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43:12 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 01:43:12 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 01:43:12 INFO - Using env: {'DISPLAY': ':0', 01:43:12 INFO - 'HOME': '/home/cltbld', 01:43:12 INFO - 'LANG': 'en_US.UTF-8', 01:43:12 INFO - 'LANGUAGE': 'en_US:en', 01:43:12 INFO - 'LOGNAME': 'cltbld', 01:43:12 INFO - 'MAIL': '/var/mail/cltbld', 01:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:12 INFO - 'MOZ_NO_REMOTE': '1', 01:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:12 INFO - 'NO_EM_RESTART': '1', 01:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:12 INFO - 'PWD': '/builds/slave/test', 01:43:12 INFO - 'SHELL': '/bin/bash', 01:43:12 INFO - 'SHLVL': '1', 01:43:12 INFO - 'TERM': 'linux', 01:43:12 INFO - 'TMOUT': '86400', 01:43:12 INFO - 'USER': 'cltbld', 01:43:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:12 INFO - '_': '/tools/buildbot/bin/python'} 01:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:43:13 INFO - Cleaning up... 01:43:13 INFO - Return code: 0 01:43:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:43:13 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')]} 01:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:13 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')]} 01:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:13 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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43:13 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 01:43:13 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 01:43:13 INFO - Using env: {'DISPLAY': ':0', 01:43:13 INFO - 'HOME': '/home/cltbld', 01:43:13 INFO - 'LANG': 'en_US.UTF-8', 01:43:13 INFO - 'LANGUAGE': 'en_US:en', 01:43:13 INFO - 'LOGNAME': 'cltbld', 01:43:13 INFO - 'MAIL': '/var/mail/cltbld', 01:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:13 INFO - 'MOZ_NO_REMOTE': '1', 01:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:13 INFO - 'NO_EM_RESTART': '1', 01:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:13 INFO - 'PWD': '/builds/slave/test', 01:43:13 INFO - 'SHELL': '/bin/bash', 01:43:13 INFO - 'SHLVL': '1', 01:43:13 INFO - 'TERM': 'linux', 01:43:13 INFO - 'TMOUT': '86400', 01:43:13 INFO - 'USER': 'cltbld', 01:43:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:13 INFO - '_': '/tools/buildbot/bin/python'} 01:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:13 INFO - Downloading/unpacking blobuploader==1.2.4 01:43:13 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 01:43:13 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 01:43:13 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 01:43:13 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 01:43:13 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 01:43:13 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 01:43:15 INFO - Downloading blobuploader-1.2.4.tar.gz 01:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:43:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:43:15 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 01:43:15 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 01:43:15 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 01:43:15 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 01:43:15 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 01:43:15 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 01:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:43:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:43:15 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 01:43:15 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 01:43:15 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 01:43:15 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 01:43:15 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 01:43:15 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 01:43:15 INFO - Downloading docopt-0.6.1.tar.gz 01:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:43:16 INFO - Installing collected packages: blobuploader, requests, docopt 01:43:16 INFO - Running setup.py install for blobuploader 01:43:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:43:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:43:16 INFO - Running setup.py install for requests 01:43:16 INFO - Running setup.py install for docopt 01:43:16 INFO - Successfully installed blobuploader requests docopt 01:43:16 INFO - Cleaning up... 01:43:16 INFO - Return code: 0 01:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43:16 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')]} 01:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:16 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')]} 01:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:16 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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43:16 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 01:43:16 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 01:43:16 INFO - Using env: {'DISPLAY': ':0', 01:43:16 INFO - 'HOME': '/home/cltbld', 01:43:16 INFO - 'LANG': 'en_US.UTF-8', 01:43:16 INFO - 'LANGUAGE': 'en_US:en', 01:43:16 INFO - 'LOGNAME': 'cltbld', 01:43:16 INFO - 'MAIL': '/var/mail/cltbld', 01:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:16 INFO - 'MOZ_NO_REMOTE': '1', 01:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:16 INFO - 'NO_EM_RESTART': '1', 01:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:16 INFO - 'PWD': '/builds/slave/test', 01:43:16 INFO - 'SHELL': '/bin/bash', 01:43:16 INFO - 'SHLVL': '1', 01:43:16 INFO - 'TERM': 'linux', 01:43:16 INFO - 'TMOUT': '86400', 01:43:16 INFO - 'USER': 'cltbld', 01:43:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:16 INFO - '_': '/tools/buildbot/bin/python'} 01:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:43:16 INFO - Running setup.py (path:/tmp/pip-WX_696-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:43:16 INFO - Running setup.py (path:/tmp/pip-3cqoyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:43:17 INFO - Running setup.py (path:/tmp/pip-Q4ZyhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:43:17 INFO - Running setup.py (path:/tmp/pip-UbmZeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:43:17 INFO - Running setup.py (path:/tmp/pip-qOnDcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:43:17 INFO - Running setup.py (path:/tmp/pip-3pj56y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:43:17 INFO - Running setup.py (path:/tmp/pip-c6ZSjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:43:17 INFO - Running setup.py (path:/tmp/pip-mbwEKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:43:17 INFO - Running setup.py (path:/tmp/pip-JTYuF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:43:17 INFO - Running setup.py (path:/tmp/pip-rUqPRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:43:17 INFO - Running setup.py (path:/tmp/pip-3L7Mx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:43:17 INFO - Running setup.py (path:/tmp/pip-82LfQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:43:17 INFO - Running setup.py (path:/tmp/pip-5UpAol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:43:17 INFO - Running setup.py (path:/tmp/pip-eCJKpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:17 INFO - Running setup.py (path:/tmp/pip-VODvcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:43:17 INFO - Running setup.py (path:/tmp/pip-4vMIOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:43:18 INFO - Running setup.py (path:/tmp/pip-oFXRlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:43:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:43:18 INFO - Running setup.py install for manifestparser 01:43:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Running setup.py install for mozcrash 01:43:18 INFO - Running setup.py install for mozdebug 01:43:18 INFO - Running setup.py install for mozdevice 01:43:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Running setup.py install for mozfile 01:43:18 INFO - Running setup.py install for mozhttpd 01:43:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Running setup.py install for mozinfo 01:43:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Running setup.py install for mozInstall 01:43:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:43:18 INFO - Running setup.py install for mozleak 01:43:19 INFO - Running setup.py install for mozlog 01:43:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:43:19 INFO - Running setup.py install for moznetwork 01:43:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:43:19 INFO - Running setup.py install for mozprocess 01:43:19 INFO - Running setup.py install for mozprofile 01:43:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:43:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:43:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:43:19 INFO - Running setup.py install for mozrunner 01:43:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:43:19 INFO - Running setup.py install for mozscreenshot 01:43:19 INFO - Running setup.py install for moztest 01:43:19 INFO - Running setup.py install for mozversion 01:43:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:43:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:43:19 INFO - Cleaning up... 01:43:19 INFO - Return code: 0 01:43:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:19 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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43:19 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 01:43:19 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 01:43:19 INFO - Using env: {'DISPLAY': ':0', 01:43:19 INFO - 'HOME': '/home/cltbld', 01:43:19 INFO - 'LANG': 'en_US.UTF-8', 01:43:19 INFO - 'LANGUAGE': 'en_US:en', 01:43:19 INFO - 'LOGNAME': 'cltbld', 01:43:19 INFO - 'MAIL': '/var/mail/cltbld', 01:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:19 INFO - 'MOZ_NO_REMOTE': '1', 01:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:19 INFO - 'NO_EM_RESTART': '1', 01:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:19 INFO - 'PWD': '/builds/slave/test', 01:43:19 INFO - 'SHELL': '/bin/bash', 01:43:19 INFO - 'SHLVL': '1', 01:43:19 INFO - 'TERM': 'linux', 01:43:19 INFO - 'TMOUT': '86400', 01:43:19 INFO - 'USER': 'cltbld', 01:43:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:19 INFO - '_': '/tools/buildbot/bin/python'} 01:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:43:20 INFO - Running setup.py (path:/tmp/pip-SFIM6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:43:20 INFO - Running setup.py (path:/tmp/pip-fk1McL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:43:20 INFO - Running setup.py (path:/tmp/pip-l0Lc5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:43:20 INFO - Running setup.py (path:/tmp/pip-p_Udbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:43:20 INFO - Running setup.py (path:/tmp/pip-Lj4_6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:43:20 INFO - Running setup.py (path:/tmp/pip-HahNXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:43:20 INFO - Running setup.py (path:/tmp/pip-vFT_3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:43:20 INFO - Running setup.py (path:/tmp/pip-FjB4TB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:43:20 INFO - Running setup.py (path:/tmp/pip-mijSKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:43:20 INFO - Running setup.py (path:/tmp/pip-8WhaL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:43:20 INFO - Running setup.py (path:/tmp/pip-4e4Tg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:43:20 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)) 01:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:43:20 INFO - Running setup.py (path:/tmp/pip-1_eHXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:43:21 INFO - Running setup.py (path:/tmp/pip-m01IXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:43:21 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)) 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:43:21 INFO - Running setup.py (path:/tmp/pip-jmR_da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:43:21 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)) 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:21 INFO - Running setup.py (path:/tmp/pip-1GBL5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:21 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)) 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:43:21 INFO - Running setup.py (path:/tmp/pip-EfvqDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:43:21 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)) 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:43:21 INFO - Running setup.py (path:/tmp/pip-gRMNNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:43:21 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)) 01:43:21 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)) 01:43:21 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)) 01:43:21 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)) 01:43:21 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)) 01:43:21 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)) 01:43:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:43:21 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 01:43:21 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 01:43:21 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 01:43:21 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 01:43:21 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 01:43:21 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 01:43:23 INFO - Downloading blessings-1.6.tar.gz 01:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:43:23 INFO - Installing collected packages: blessings 01:43:23 INFO - Running setup.py install for blessings 01:43:23 INFO - Successfully installed blessings 01:43:23 INFO - Cleaning up... 01:43:23 INFO - Return code: 0 01:43:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:43:23 INFO - Reading from file tmpfile_stdout 01:43:23 INFO - Current package versions: 01:43:23 INFO - argparse == 1.2.1 01:43:23 INFO - blessings == 1.6 01:43:23 INFO - blobuploader == 1.2.4 01:43:23 INFO - docopt == 0.6.1 01:43:23 INFO - functools32 == 3.2.3-2 01:43:23 INFO - jsonschema == 2.5.1 01:43:23 INFO - manifestparser == 1.1 01:43:23 INFO - mozInstall == 1.12 01:43:23 INFO - mozcrash == 1.0 01:43:23 INFO - mozdebug == 0.1 01:43:23 INFO - mozdevice == 0.49 01:43:23 INFO - mozfile == 1.2 01:43:23 INFO - mozhttpd == 0.7 01:43:23 INFO - mozinfo == 0.9 01:43:23 INFO - mozleak == 0.1 01:43:23 INFO - mozlog == 3.4 01:43:23 INFO - moznetwork == 0.27 01:43:23 INFO - mozprocess == 0.25 01:43:23 INFO - mozprofile == 0.28 01:43:23 INFO - mozrunner == 6.13 01:43:23 INFO - mozscreenshot == 0.1 01:43:23 INFO - mozsystemmonitor == 0.3 01:43:23 INFO - moztest == 0.8 01:43:23 INFO - mozversion == 1.4 01:43:23 INFO - psutil == 3.1.1 01:43:23 INFO - requests == 1.2.3 01:43:23 INFO - wsgiref == 0.1.2 01:43:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:23 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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43:23 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 01:43:23 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 01:43:23 INFO - Using env: {'DISPLAY': ':0', 01:43:23 INFO - 'HOME': '/home/cltbld', 01:43:23 INFO - 'LANG': 'en_US.UTF-8', 01:43:23 INFO - 'LANGUAGE': 'en_US:en', 01:43:23 INFO - 'LOGNAME': 'cltbld', 01:43:23 INFO - 'MAIL': '/var/mail/cltbld', 01:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:23 INFO - 'MOZ_NO_REMOTE': '1', 01:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:23 INFO - 'NO_EM_RESTART': '1', 01:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:23 INFO - 'PWD': '/builds/slave/test', 01:43:23 INFO - 'SHELL': '/bin/bash', 01:43:23 INFO - 'SHLVL': '1', 01:43:23 INFO - 'TERM': 'linux', 01:43:23 INFO - 'TMOUT': '86400', 01:43:23 INFO - 'USER': 'cltbld', 01:43:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:23 INFO - '_': '/tools/buildbot/bin/python'} 01:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 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)) 01:43:24 INFO - Cleaning up... 01:43:24 INFO - Return code: 0 01:43:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:43:24 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')]} 01:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:24 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')]} 01:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:24 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 0x1d021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d40a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', '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 01:43:24 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 01:43:24 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 01:43:24 INFO - Using env: {'DISPLAY': ':0', 01:43:24 INFO - 'HOME': '/home/cltbld', 01:43:24 INFO - 'LANG': 'en_US.UTF-8', 01:43:24 INFO - 'LANGUAGE': 'en_US:en', 01:43:24 INFO - 'LOGNAME': 'cltbld', 01:43:24 INFO - 'MAIL': '/var/mail/cltbld', 01:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:24 INFO - 'MOZ_NO_REMOTE': '1', 01:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:24 INFO - 'NO_EM_RESTART': '1', 01:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:24 INFO - 'PWD': '/builds/slave/test', 01:43:24 INFO - 'SHELL': '/bin/bash', 01:43:24 INFO - 'SHLVL': '1', 01:43:24 INFO - 'TERM': 'linux', 01:43:24 INFO - 'TMOUT': '86400', 01:43:24 INFO - 'USER': 'cltbld', 01:43:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:24 INFO - '_': '/tools/buildbot/bin/python'} 01:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:43:24 INFO - Cleaning up... 01:43:24 INFO - Return code: 0 01:43:24 INFO - Running post-action listener: _resource_record_post_action 01:43:24 INFO - Running post-action listener: _start_resource_monitoring 01:43:24 INFO - Starting resource monitoring. 01:43:24 INFO - [mozharness: 2017-04-10 08:43:24.338887Z] Finished create-virtualenv step (success) 01:43:24 INFO - [mozharness: 2017-04-10 08:43:24.339359Z] Running install step. 01:43:24 INFO - Running pre-action listener: _resource_record_pre_action 01:43:24 INFO - Running main action method: install 01:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:43:24 INFO - Reading from file tmpfile_stdout 01:43:24 INFO - Detecting whether we're running mozinstall >=1.0... 01:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:43:24 INFO - Reading from file tmpfile_stdout 01:43:24 INFO - Output received: 01:43:24 INFO - Usage: mozinstall [options] installer 01:43:24 INFO - Options: 01:43:24 INFO - -h, --help show this help message and exit 01:43:24 INFO - -d DEST, --destination=DEST 01:43:24 INFO - Directory to install application into. [default: 01:43:24 INFO - "/builds/slave/test"] 01:43:24 INFO - --app=APP Application being installed. [default: firefox] 01:43:24 INFO - mkdir: /builds/slave/test/build/application 01:43:24 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'] 01:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:43:41 INFO - Reading from file tmpfile_stdout 01:43:41 INFO - Output received: 01:43:41 INFO - /builds/slave/test/build/application/firefox/firefox 01:43:41 INFO - Running post-action listener: _resource_record_post_action 01:43:41 INFO - [mozharness: 2017-04-10 08:43:41.257286Z] Finished install step (success) 01:43:41 INFO - [mozharness: 2017-04-10 08:43:41.257566Z] Running run-tests step. 01:43:41 INFO - Running pre-action listener: _resource_record_pre_action 01:43:41 INFO - Running main action method: run_tests 01:43:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:43:41 INFO - Python 2.7.3 01:43:41 INFO - Return code: 0 01:43:41 INFO - grabbing minidump binary from tooltool 01:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:43:41 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 0x1f9d400>, '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 0x1f9e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9e840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:43:41 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 01:43:41 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 01:43:41 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 01:43:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:43:41 INFO - Return code: 0 01:43:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:43:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:43:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:43:41 INFO - ENV: RUST_BACKTRACE is now 1 01:43:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:43:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:43:41 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:43:41 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:43:41 INFO - Using env: {'DISPLAY': ':0', 01:43:41 INFO - 'HOME': '/home/cltbld', 01:43:41 INFO - 'LANG': 'en_US.UTF-8', 01:43:41 INFO - 'LANGUAGE': 'en_US:en', 01:43:41 INFO - 'LOGNAME': 'cltbld', 01:43:41 INFO - 'MAIL': '/var/mail/cltbld', 01:43:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:43:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:41 INFO - 'MOZ_NO_REMOTE': '1', 01:43:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:41 INFO - 'NO_EM_RESTART': '1', 01:43:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:41 INFO - 'PWD': '/builds/slave/test', 01:43:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:43:41 INFO - 'RUST_BACKTRACE': '1', 01:43:41 INFO - 'SHELL': '/bin/bash', 01:43:41 INFO - 'SHLVL': '1', 01:43:41 INFO - 'TERM': 'linux', 01:43:41 INFO - 'TMOUT': '86400', 01:43:41 INFO - 'USER': 'cltbld', 01:43:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106', 01:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:41 INFO - '_': '/tools/buildbot/bin/python'} 01:43:41 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:43:41 INFO - mozversion application_buildid: 20170410074807 01:43:41 INFO - mozversion application_changeset: efca7a198376e7800873e4612a8b34fc77022d4d 01:43:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:43:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:43:41 INFO - mozversion application_name: Firefox 01:43:41 INFO - mozversion application_remotingname: firefox-dev 01:43:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:43:41 INFO - mozversion application_vendor: Mozilla 01:43:41 INFO - mozversion application_version: 54.0a2 01:43:41 INFO - mozversion platform_buildid: 20170410074807 01:43:41 INFO - mozversion platform_changeset: efca7a198376e7800873e4612a8b34fc77022d4d 01:43:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:43:41 INFO - mozversion platform_version: 54.0a2 01:43:41 INFO - using testdate: 1491813821 01:43:41 INFO - actual date: 1491813821 01:43:41 INFO - starting webserver on 'localhost:47447' 01:43:41 INFO - SUITE-START | Running 2 tests 01:43:41 INFO - TEST-START | dromaeo_css 01:43:41 INFO - operating with platform_type : linux_ 01:43:41 INFO - Initialising browser for dromaeo_css test... 01:43:41 INFO - TEST-INFO | started process 16509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmwJQoa/profile http://localhost:47447/getInfo.html) 01:43:45 INFO - PROCESS | 16509 | __metrics Screen width/height:1600/1200 01:43:45 INFO - PROCESS | 16509 | colorDepth:24 01:43:45 INFO - PROCESS | 16509 | Browser inner width/height: 1024/697 01:43:45 INFO - PROCESS | 16509 | __metrics 01:43:46 INFO - PROCESS | 16509 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:43:46 INFO - PROCESS | 16509 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:43:47 INFO - TEST-INFO | 16509: exit 0 01:43:47 INFO - Browser initialized. 01:43:47 INFO - Running cycle 1/1 for dromaeo_css test... 01:43:47 INFO - TEST-INFO | started process 16599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmwJQoa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:43:59 INFO - PROCESS | 16599 | RSS: Main: 140251136 01:43:59 INFO - PROCESS | 16599 | 01:47:01 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:47447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47447/tests/dromaeo/cssquery-ext.html) 01:47:02 INFO - PROCESS | 16599 | RSS: Main: 216707072 01:47:02 INFO - PROCESS | 16599 | 01:48:49 INFO - PROCESS | 16599 | ************************* 01:48:49 INFO - PROCESS | 16599 | A coding exception was thrown and uncaught in a Task. 01:48:49 INFO - PROCESS | 16599 | 01:48:49 ERROR - PROCESS | 16599 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:48:49 INFO - PROCESS | 16599 | Full stack: 01:48:49 INFO - PROCESS | 16599 | ************************* 01:48:49 INFO - PROCESS | 16599 | ************************* 01:48:49 INFO - PROCESS | 16599 | A coding exception was thrown and uncaught in a Task. 01:48:49 INFO - PROCESS | 16599 | 01:48:49 ERROR - PROCESS | 16599 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:48:49 INFO - PROCESS | 16599 | Full stack: 01:48:49 INFO - PROCESS | 16599 | ************************* 01:48:49 INFO - PROCESS | 16599 | ************************* 01:48:49 INFO - PROCESS | 16599 | A coding exception was thrown and uncaught in a Task. 01:48:49 INFO - PROCESS | 16599 | 01:48:49 ERROR - PROCESS | 16599 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:48:49 INFO - PROCESS | 16599 | Full stack: 01:48:49 INFO - PROCESS | 16599 | ************************* 01:48:49 INFO - PROCESS | 16599 | ************************* 01:48:49 INFO - PROCESS | 16599 | A coding exception was thrown and uncaught in a Task. 01:48:49 INFO - PROCESS | 16599 | 01:48:49 ERROR - PROCESS | 16599 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:48:49 INFO - PROCESS | 16599 | Full stack: 01:48:49 INFO - PROCESS | 16599 | ************************* 01:50:05 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:47447/tests/dromaeo/cssquery-ext.html (next: http://localhost:47447/tests/dromaeo/cssquery-jquery.html) 01:50:05 INFO - PROCESS | 16599 | RSS: Main: 216924160 01:50:05 INFO - PROCESS | 16599 | 01:53:07 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:47447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47447/tests/dromaeo/cssquery-mootools.html) 01:53:08 INFO - PROCESS | 16599 | RSS: Main: 200536064 01:53:08 INFO - PROCESS | 16599 | 01:56:10 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:47447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47447/tests/dromaeo/cssquery-prototype.html) 01:56:10 INFO - PROCESS | 16599 | RSS: Main: 170741760 01:56:10 INFO - PROCESS | 16599 | 01:59:13 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:47447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47447/tests/dromaeo/cssquery-yui.html) 01:59:14 INFO - PROCESS | 16599 | RSS: Main: 175063040 01:59:14 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:47447/tests/dromaeo/cssquery-yui.html (next: http://localhost:47447/tests/dromaeo/cssquery-dojo.html) 02:02:16 INFO - PROCESS | 16599 | RSS: Main: 260816896 02:02:16 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | __start_tp_report 02:02:16 INFO - PROCESS | 16599 | _x_x_mozilla_page_load 02:02:16 INFO - PROCESS | 16599 | _x_x_mozilla_page_load_details 02:02:16 INFO - PROCESS | 16599 | |i|pagename|runs| 02:02:16 INFO - PROCESS | 16599 | |0;dojo.html;3365.512000759889;3404.795712257266;3419.179396944733;3420.0936751760805;3440.51832743416;5579.8605034874145;5695.629784064038;5704.11586204138;5708.486236238738;5726;5674.914876276849;5705.48650621444;5713.342965558962;5727.942720572803;5736.110902810061;5174.094533456649;5200.427952925175;5202.0376230397405;5237.973810130963;5286.2070689396705;5102.795888164469;5119.283300337937;5295.576353891679;5298.09932311508;5325.680459172443;5129.051125541768;5145.073886700392;5193.246979188034;5202.141646628302;5218.478152184789;5223.294855194538;5234.345706786652;5235.240890070937;5236.581073514148;5261.394939581959;5026.798928042874;5081.66969147008;5146.099432599281;5207.921881171786;5210.843674689765;5579.274694289757;5618.297712785902;5677.034904066319;5687.971560142173;5702.8289151325525;6011.278646562397;6048.60684055535;6062.696865156769;6063.393660633946;6068;6129.38706129388;6136.294326152505;6138.14066030756;6144.446999770043;6147.600405973642;5556.472135147154;5611.803586874481;5652.604317697763;5698.62958907678;5703.74333155009;6251;6253.280872699606;6256.280527739368;6257.342978987141;6260.593061450991;5982.282126144891;6045.33501314855;6047.939520604826;6055.666938318347;6058.727357268934;5916.3787802281;5959.612625179436;5982.222311099529;6031.728572214261;6104.868540434902;6023.62341669937;6034.577579569388;6036.15493830864;6040.486558642477;6055.303640081447;5795.594308398372;5824.6796426196115;5833.329167145833;6015.578909476382;6048.334683184846;4256.404103425523;4270.210011147948;4275.657947364203;4294.935575966363;4298.376735373416;3801.353769859131;3866.0914685048992;3881.5924327945722;3900.687944964396;3906.257811015898;5855.619384739978;5855.795047173328;5870.44230798082;5948.643081415043;5960.0165972614905;6110.175126357884;6120.357362476965;6120.663363515049;6132.724027418777;6149.385061493815;5888.440598143169;5906;5911.054231322968;5912.201852749909;5913.05391137416;5061;5131.204663277198;5162.406323272871;5221.269022336875;5258.07983602868;6370.58591191571;6373.776917807854;6376.489880809524;6380.968095159587;6386;6134.969325153345;6142.754289828356;6146.323904370605;6155.753769849335;6159.19930409044;6137.7851775187655;6143.38905964972;6254.061890716429;6262.686865656608;6311.96844015777;6010.068439391901;6027.728752206073;6031.60794548353;6047.213862197887;6059.848503787264;6128.908066378919;6131.294901086254;6135.754569817157;6137.84655383619;6152.907706384497;5697.487226149667;5806.709664516842;5882.294124705063;5970;5985.102234664835;5992.101184822137;6022.006368949074;6030.75876964934;6031.577789554689;6032.607880487754;5910.261217347832;5943.257092863392;5955.910661339996;5959.791407300723;5963.075723262901;5815.912761308499;5825.737841797045;5880.705964701833;5922.822315330547;5999.700014999145;5873.853153671193;5883.794067207798;5888.057910734433;5897.941020589739;5941.702914854153 02:02:16 INFO - PROCESS | 16599 | |1;ext.html;765.770268919324;818.1736446189349;831.8211584509329;836.8159005018902;906.1572737354267;30914.53628195576;31234.843825780867;44751.552484475105;45522.77238613811;45558.77220613901;46247.53752462474;46426.76786616062;46457;46457;46520;7728.845423091535;9083.227925626314;9219.124183202584;9226.953865230698;9230.26157907369;7624.504407213513;10521.316114452575;10764.946175269151;10835.512401941893;10842.891571084307;10875.510602022929;10941.726456838564;10961.12311015121;10977.06694930932;10982.890171098266;10842.403667798268;10848.132149428027;10905.83641245382;10914.945425272903;10916.727081822939;10598.523066462029;10598.68203953875;10634.734131646694;10657.360558366523;10662.626808061681;43611.34582981258;43625.78187109076;43699.34450983238;43769.562304376865;43863.34204986928;4146.440230568895;4219.156168766228;4232.957670423318;4341.327094300388;4356.89107772305;29711.40577188444;30330.393392132253;30401.23996900073;30863;31828.681713182803;4346.956530434687;4438.889027774299;4451.154280686692;4484.125595508877;4492.483364413101;243316;245029;245765.7711711448;246090;246342;54703.17945230825;54774.178387324224;54799.452005480234;54894;54914.72542637261;56479.71760141255;56637.7168114165;56669.7166514173;56674.43325566692;56911.71544142253;15805.68388632221;16544;16553.337866485206;16567.17164141788;16583;12696;12870.806937895939;14388;14397.85602143986;14410.783838242434;13480.797788033187;13899;14148.504802332074;14161.291935403395;14291.714165716627;5520.254765606672;5556.91664625031;5598.468145526169;5699.173619825102;5700.287464066992;1003.7340104872214;1005.8239808033711;1005.9245556583139;1014.457265363042;1017.9287449878437;28199.43601128007;28481.430371392456;28663.57004644932;28828.567571486445;28851.134465966054;1039.5581877701945;1087.2986923434498;1102.5975518935531;1105.171121658756;1123.7359220583157;15597.922010389875;16474.95065887839;17139.74290385645;17387.73918391225;17501.824981750273;323139;323757;324240;324324;324635;60192.398076019555;60284;60444.69777651172;60502.69748651316;60514.39485605175;1502.579277802239;1519.8176218853587;1558.633721075569;1559.2983157579135;1562.6484041090664;30060.549091763205;31359.529607056367;31487;31927.361452771278;31942.520862186622;44619.33071004003;46950.53049469598;47808.760956194994;47854.28218576794;47937.760311198224;322365;325289;325812;326246;326794;26418;26763.86618066897;31192.844035779675;31735;31955.6804431962;40093.39859902045;40114;40120.79939600283;40383.1923361537;40514.1897162061;30674.693253068075;31173.37653246877;31249.531257031616;31266.53100203544;31328.843355783076;30851;30996;31129.533057004617;31316.217094571908;31456.370872582876;34432.65567344295;34809.65190348064;34953.02899253592;35064;35596;30570;30604.540931886484;32638;32641.34717305688;33015.08962731173;25486.23541293764;25498.362540935883;25830.483390331712;25933.351666208495;26003.349916252246 02:02:16 INFO - PROCESS | 16599 | |2;jquery.html;444.0940481417908;467.2547287077112;470.0903751241346;476.99523004769964;485.90524847654706;20923.37229883104;21264.362069137933;22002.229921952734;22551.436214094654;22687.432814179654;20813.375598732026;21247.57504849902;21961;22132.557348853054;22603.547929041408;5772.5670574706855;6422.967885160591;6817.45460363171;7017.964910175442;7025.578465292073;6843.52095353323;6929.549579277356;6943.72225110995;6944.375006249436;6949.791506254821;6753.864922701543;6862.656867156647;6866.244713081557;6927.445804335641;6951.687174077153;6581.539292249545;6597.47220222381;6658.93341066588;6812.863742725142;6935.72257109715;6487.318831522669;6499.317571654956;6526.184226971629;6527.314631963671;6543.312952140004;25676.743232567624;25697.74302256972;25726.74273257262;25814.612780808304;26177.476450470884;2885.942281154365;3116.6104236970377;3127.9218019549467;3149.4488464518845;3162.98418507906;16138.677226455406;16206.270717817608;16363.42728004526;16551.08969006704;16876;2176.4885251965775;2204.922827701023;2217.401301648562;2245.41619179013;2255.334676270504;66256;67371.98942015873;83789.16210837936;112125.99999999919;112429;17300.653986920443;17791.288348466176;17838.55403614894;17966.371177009005;18472;31623.36753264922;31652;31669.20826979344;31701.365972680418;31736;9838.950805246071;9965.601375945025;10009.499525023719;10025.097741203326;10291;8263.199682413728;8301.335893128535;8369.539675317794;8509.446885952393;8515.957420212982;8965.50689712072;9019.323550733721;9134.680286189952;9226.169644732006;9254.352195346395;3504;3552.2717842842158;3560.287942411528;3598.2983318253214;3752.155764952918;933.8739270198437;942.6614207824905;950.273041123541;952.4333021851987;971.1065819445986;19819.900900495406;21211;21272;21332.893335533532;21438.03528841206;959.0270162496345;972.2659392158874;977.1938151025432;979.5445118020012;997.2420960070399;11628.18602697803;11686.883131168579;11768;11771;11903.166778325434;608540;609776;616023;623969;637807;89448.94795564655;96895.51552242335;111880.44059779649;114460;116265;1270.8919741822049;1276.489404238312;1307.7384523095418;1314.0538812055304;1316.82881225442;19052.809471905104;19299;19462.31881884184;19490.22039118476;19496.31762888292;36249.09377265589;47410.288845666655;49060;49664.50335496743;49966.50033499764;64880;65258;65789;66230;66925.3307466919;8907.153820387053;9883;12841.45902491707;12889.291088989821;12916.289604071866;13500.797488037491;13849.16904985704;14146.151230926178;14167.716645666822;14314.355853986805;11738.58914937973;11796.76406471883;12010.699732506757;12797.232166070065;13164.473421063434;11597.072234221074;11906.642800715992;11929.761404772029;11961.162718609614;12146.757064858477;12808.807867881802;12897.038476331227;12970.67573310637;13027.153235039692;13100.672483187996;12673.239605623692;12780.936095319836;12891.097623166288;12895.677608059874;13197.944164467011;12539.498420063095;12594.307313097868;12916.677083072998;13063.542776002794;13233.470661173445 02:02:16 INFO - PROCESS | 16599 | |3;mootools.html;1528.0755143138394;1539.9461018864342;1573.6065983504125;1588.8887777855548;1590.3797518967604;10505;11212.775744485105;11216.383098929566;11216.66350009499;11220.943895280523;10707.304025238354;11076.944615276932;11079.944600277007;11084.390358530278;11084.556617735281;2434.4644178280796;2472.171822439476;2473.703155621328;2476.1333533263396;2477.0091963214677;2342.2238267862153;2412.662227288181;2459.9139030133947;2463.224084413413;2463.716672582658;2391.7249516305587;2397.4006498375406;2408.9397765055837;2464.605663093905;2467.5805113130723;2285.31440567829;2338.1232037985756;2347;2347.084636991583;2378.7859092681742;2288.1533832481923;2307.7230732312064;2308.8614683119067;2315.282262498614;2323.546908352872;11210.887891121147;11431.08551315901;11432;11437.828432573519;11439.885601143966;5559.19391688207;5700.885982280372;5704.201411802351;5709.0580054290995;5710.257666503369;3338.5659864217496;3406.5230867678547;3412.334594754024;3434.8282585870606;3498.7900725956524;1281.641140480667;1293.275765571283;1307.111164408202;1327.9535216267482;1356.4709763192363;14639.780403293958;15024.399024039025;15506.767398488919;16377.83622163775;16521.66956660872;4476.485204201494;4478.731276123443;4615.3077038443835;4615.492295847454;4618.122556714214;10970.122390208764;11264.211505194722;12648.430820613094;12650.936745316214;12651.367431628565;4963;5498.532624726943;5666.886662266732;5738.626989245769;5742.712864356766;5265;5346.385165705994;5368.5436737876935;5406.945930540644;5411.485908838654;4119.382092686061;4132.070284186094;4178.623923846869;4212.978935105305;4216.051388437577;1069.187417562658;1098.2696506822874;1107.684309971654;1108.9001989820954;1112.6383925224334;824.7814329202766;832.296709280669;835.467317902727;857;862.2498426368974;6608.173978252718;6643.800685979429;6728.495362847806;6730.293319201512;6852.554583952027;1034.3276870034388;1053.5680371047833;1065.3980501017056;1076.9730756730987;1077.0844781935448;4159.875203743893;4281.850135245314;4309.59058889405;4338.305871060616;4374.12517496502;13787;14289.285535723173;14293.213873236864;14299.714005719827;14344.354504047344;13957.162570245819;14071.155730656194;14155.787663185061;14164.787528187086;14201.21893295858;10487.108595769445;10618.681439556825;10637.787244254916;10645.946770266099;10659.467026648637;6585.374389432996;6588.341165883373;6667.599944003376;6704.396604305636;6810.965945170243;12594.370281486072;12675.873241267838;12687.555935542212;12831.165974211646;13048.282344470765;12899.613011609667;13163.078584498993;13184.143030702973;13225.272610006543;13277.86722132805;8491.83016339682;8547.95726021366;8616.396852220285;8625.784355391166;8632.136786321318;10563.207759418228;10577.735556610838;10646.574137034431;10650.041496265063;10654.946725266323;9184.357095003286;9213.815723685355;9218.21645160169;9314.906850931404;9330.160285574331;8952.776180595538;8983.640654374014;9065.546722663972;9156.450612963243;9157.450552966844;7756.612169391621;8444.746657600283;8581.141885811368;8582;8610.870836937576;5696.572757043155;5771.307443106854;5782.190493330853;5833.387494313036;5882.470577647861;5769.249997500298;5816.098504731774;5837.562182836219;6048.637081775108;6084.209052823105 02:02:16 INFO - PROCESS | 16599 | |4;prototype.html;427.82459191731397;432.54582688177413;434.2682579852948;437.8839607504012;440.5770460358056;5135.435102138762;5248.606354523412;5264.49987251211;5272.4991125843035;5278.630495865282;5166.922496162551;5174.611904107188;5180.896382072357;5183.222516622509;5201.349831271091;4215.747055176692;4321.438213032301;4333.393324934512;4352.39066530686;4373.212821692094;4331.891702707426;4371.229651990949;4378.715383500078;4415.580519850609;4425.867223983286;4400.44994375703;4411.3382992551215;4414.911701765979;4428.734275943438;4446.577575130357;4202.432671589342;4350.978245108786;4365.912681746379;4393.978030109845;4403.933940990888;4088.897777555555;4114.794260287003;4114.991827002404;4117.547069822317;4133.6693064554765;5012.8997420051755;5025.773840177201;5027.723475208862;5029.748512574393;5034.4644883310575;4944.233643785219;5072.492750724935;5113.181890897438;5113.360829896263;5127.102757017507;5402.91895621566;5404.567634589223;5425.740793477102;5440.265564148868;5484.972575137139;4569.13186494565;4577.931331030038;4589.449266088058;4600.585947264729;4604.838830640945;5440.782368705247;5494.945050549523;5517.475839795213;5658.321001479808;5658.377578466366;4582.770861456914;4632.814687412533;4658.67227840064;4682.9531704683195;4706.810938264947;4755.453122890912;4801.639877009238;4808.975955120202;4838.685485443435;4851.539103785135;4696.95303046972;4850.011495286915;4980.327655766498;5042.672226305279;5046.873828154252;5289.841304760864;5339.305890234323;5346.39608117571;5361.624686271924;5372.272400287722;1602.3510478256326;1632.2981118119085;1636.7954005749282;1641.7783599214192;1646.382606522554;1228.6498347970964;1242.9627111186678;1268.6955130768733;1269.282855186835;1296.3971753134838;5328.946710532922;5409.891802163935;5415.729213539386;5438.45615438453;5457.345118585795;5624.634398764068;5645.887082258332;5649.915251271234;5667.263255776805;5686.914696279477;5004.874878128076;5275.235090911796;5312.442193569696;5327.920081198785;5332.70693601755;2906.2007947814095;2911.1470758656637;2917.5186094294204;2924.4151169766133;2926.7171606146812;5451.890962180734;5717.428257174332;5734.971325143348;5764.510016648632;5799;5636;5639.379668236491;5672.801451949162;5674.432556744293;5676.460736230051;5714.628549144292;5734.426557344233;5737.254156959652;5802.8259152224655;5807.535397168132;5484.8990438892215;5521.199426083115;5539.6150962259435;5609.775608975595;5617.550595952396;5523.944760552504;5539.7230138492105;5571.693556854249;5582.944170558242;5590.5248053915875;5561.388247292875;5626.690532020614;5666.546676265972;5749.453801888814;5820.711298116551;4670.556297151765;4693.624510039257;4694.906101877875;4749.548792864673;4771.165046116985;5407.593216273723;5659.462351076641;5669.688167150846;5673.347565030074;5692.658440493584;5401.918971215514;5423.322084739408;5429.701366424884;5430.456954304538;5462.317210348707;5440.470181365684;5444.972775136099;5447.74701818576;5449.3460784706085;5487.832306238934;5221.738913054256;5374.193870919394;5393.325834270716;5412.810551630674;5481.835544933659;5476.3702174250475;5476.534494568006;5488.69812160335;5508.834734957958;5514.944850551443;5351.464853514617;5385.165299378603;5386.622936394415;5393.029254734185;5398.001369746609 02:02:16 INFO - PROCESS | 16599 | |5;yui.html;853.4324674091729;872.1801506583811;905.791667916379;911.9726408207754;918.3846822628834;16907.577310567227;16939.78420466073;18309.17608707608;18433.90783046083;18702.438926832183;15068.171250581214;15328.386864525433;15406.07563546188;16877.033897034187;16920.74618880715;856.4304737349655;872.7599910024762;874.8206617643368;876.5091548732698;876.7764220123892;848.6435697007241;874.8381549413378;882.7219425880827;882.8366752150872;882.8808110905042;928.6239073175375;930.4556834251937;932.9300302477342;937.0769791755116;937.5499760115149;929.4748467116058;930.1256818590537;930.1767935377206;930.1953809954408;931.5481991234246;674.8076798112563;678.2369833936821;678.5691086160274;682.2018238660729;682.276786606199;16169.353225870951;16459.341626335052;16548.089855057966;17957.102144892833;18189.090545472674;15714.842851571453;16039.91980040104;16093.275802588794;16134.273957671932;16221.837781622151;13453.798193027113;13999.65000874976;14117.505887293895;14119.788203176859;14384.99305048647;3747.887563373103;3762.9059273518383;3771.754835935683;3783.5270591176104;3869.613038696136;50078.74960625174;52836.73581632067;54854;69450.65274673645;80932.59533702294;12594.496220151275;12733.299668518135;12826.80759788604;12873.420696068699;12965.675858103623;22595.43511412195;22786.43033924132;22808.543829123326;22848.885755571115;22915.08339666428;6654.70053847578;8163.183681631908;8453.408261421642;8775.561221938877;8937.285017198608;5046.243063540425;5133.948660513422;5191.792328306901;5259.789608415621;5294;3740.1958578905665;3806.676432503268;3831.6934645228316;3838.1172330363615;3864.2851072551666;632.4466092169351;634.7524465458475;637.8182218067828;640.7917426836296;645.3449748505271;799.6681377228385;824.8350329934037;834.4659417972503;848.804774901776;854.5599016506504;10812.366060798495;11125.332480051224;11178.776424471627;11290.717732056764;11715.531378744925;779.8128449172158;791.0665414810463;793.928546430824;802.863513202757;811.5252577242379;5322;5387.272718183073;5443.374011988592;5453.618246722771;5454.3454785426;64162;66401;72473;77637;82361.58819205865;68781.96827047598;69414;70117.29882701108;70787.64606176937;71287.28712712911;50442.24336634953;54707;56009.719951400795;56702.7164864173;56987;11141;11667.241629294409;11797.29216247028;11914.702132446759;11920.70198245016;41698.374524382765;42072.579274206866;42734.5726542743;42868.78565607152;43801.56198437975;50540;50671.49328506815;50833.74583127061;50869.74565127151;50981.490185097675;12883.935580322413;12888.355582220664;12948.328568668425;13065.738685226052;13426.731465370443;14627.92686036563;14804.333804979016;14948.028378155384;15002.924985375003;15336.76994845056;14692;14754.557363279118;14865.777013344592;15101.32044057998;15151.469698560497;14133.434662613381;14488.927555362156;14595.635109122357;14700.044497107654;14998.400063997755;14485.637859053608;14614.415423382945;14687.853121468648;14705.92647036758;15157.242137892841;11388.886111138783;11584.594539191088;11590;11693.006094482063;11714.88285117138;12404.937975310426;13156.210627362389;13254.403551839998;13313.04602930729;13574.728505430034 02:02:16 INFO - PROCESS | 16599 | __end_tp_report 02:02:16 INFO - PROCESS | 16599 | __start_cc_report 02:02:16 INFO - PROCESS | 16599 | _x_x_mozilla_cycle_collect,904 02:02:16 INFO - PROCESS | 16599 | __end_cc_report 02:02:16 INFO - PROCESS | 16599 | __startTimestamp1491814936779__endTimestamp 02:02:16 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | ------- Summary: start ------- 02:02:16 INFO - PROCESS | 16599 | Number of tests: 6 02:02:16 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | [#0] dojo.html Cycles:165 Average:5645.93 Median:5906.00 stddev:673.65 (11.4%) stddev-sans-first:651.53 02:02:16 INFO - PROCESS | 16599 | Values: 3365.5 3404.8 3419.2 3420.1 3440.5 5579.9 5695.6 5704.1 5708.5 5726.0 5674.9 5705.5 5713.3 5727.9 5736.1 5174.1 5200.4 5202.0 5238.0 5286.2 5102.8 5119.3 5295.6 5298.1 5325.7 5129.1 5145.1 5193.2 5202.1 5218.5 5223.3 5234.3 5235.2 5236.6 5261.4 5026.8 5081.7 5146.1 5207.9 5210.8 5579.3 5618.3 5677.0 5688.0 5702.8 6011.3 6048.6 6062.7 6063.4 6068.0 6129.4 6136.3 6138.1 6144.4 6147.6 5556.5 5611.8 5652.6 5698.6 5703.7 6251.0 6253.3 6256.3 6257.3 6260.6 5982.3 6045.3 6047.9 6055.7 6058.7 5916.4 5959.6 5982.2 6031.7 6104.9 6023.6 6034.6 6036.2 6040.5 6055.3 5795.6 5824.7 5833.3 6015.6 6048.3 4256.4 4270.2 4275.7 4294.9 4298.4 3801.4 3866.1 3881.6 3900.7 3906.3 5855.6 5855.8 5870.4 5948.6 5960.0 6110.2 6120.4 6120.7 6132.7 6149.4 5888.4 5906.0 5911.1 5912.2 5913.1 5061.0 5131.2 5162.4 5221.3 5258.1 6370.6 6373.8 6376.5 6381.0 6386.0 6135.0 6142.8 6146.3 6155.8 6159.2 6137.8 6143.4 6254.1 6262.7 6312.0 6010.1 6027.7 6031.6 6047.2 6059.8 6128.9 6131.3 6135.8 6137.8 6152.9 5697.5 5806.7 5882.3 5970.0 5985.1 5992.1 6022.0 6030.8 6031.6 6032.6 5910.3 5943.3 5955.9 5959.8 5963.1 5815.9 5825.7 5880.7 5922.8 5999.7 5873.9 5883.8 5888.1 5897.9 5941.7 02:02:16 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | [#1] ext.html Cycles:180 Average:46940.92 Median:31407.95 stddev:78580.42 (250.2%) stddev-sans-first:78724.38 02:02:16 INFO - PROCESS | 16599 | Values: 765.8 818.2 831.8 836.8 906.2 30914.5 31234.8 44751.6 45522.8 45558.8 46247.5 46426.8 46457.0 46457.0 46520.0 7728.8 9083.2 9219.1 9227.0 9230.3 7624.5 10521.3 10764.9 10835.5 10842.9 10875.5 10941.7 10961.1 10977.1 10982.9 10842.4 10848.1 10905.8 10914.9 10916.7 10598.5 10598.7 10634.7 10657.4 10662.6 43611.3 43625.8 43699.3 43769.6 43863.3 4146.4 4219.2 4233.0 4341.3 4356.9 29711.4 30330.4 30401.2 30863.0 31828.7 4347.0 4438.9 4451.2 4484.1 4492.5 243316.0 245029.0 245765.8 246090.0 246342.0 54703.2 54774.2 54799.5 54894.0 54914.7 56479.7 56637.7 56669.7 56674.4 56911.7 15805.7 16544.0 16553.3 16567.2 16583.0 12696.0 12870.8 14388.0 14397.9 14410.8 13480.8 13899.0 14148.5 14161.3 14291.7 5520.3 5556.9 5598.5 5699.2 5700.3 1003.7 1005.8 1005.9 1014.5 1017.9 28199.4 28481.4 28663.6 28828.6 28851.1 1039.6 1087.3 1102.6 1105.2 1123.7 15597.9 16475.0 17139.7 17387.7 17501.8 323139.0 323757.0 324240.0 324324.0 324635.0 60192.4 60284.0 60444.7 60502.7 60514.4 1502.6 1519.8 1558.6 1559.3 1562.6 30060.5 31359.5 31487.0 31927.4 31942.5 44619.3 46950.5 47808.8 47854.3 47937.8 322365.0 325289.0 325812.0 326246.0 326794.0 26418.0 26763.9 31192.8 31735.0 31955.7 40093.4 40114.0 40120.8 40383.2 40514.2 30674.7 31173.4 31249.5 31266.5 31328.8 30851.0 30996.0 31129.5 31316.2 31456.4 34432.7 34809.7 34953.0 35064.0 35596.0 30570.0 30604.5 32638.0 32641.3 33015.1 25486.2 25498.4 25830.5 25933.4 26003.3 02:02:16 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | [#2] jquery.html Cycles:180 Average:35428.82 Median:14531.71 stddev:101693.23 (699.8%) stddev-sans-first:101944.58 02:02:16 INFO - PROCESS | 16599 | Values: 444.1 467.3 470.1 477.0 485.9 20923.4 21264.4 22002.2 22551.4 22687.4 20813.4 21247.6 21961.0 22132.6 22603.5 5772.6 6423.0 6817.5 7018.0 7025.6 6843.5 6929.5 6943.7 6944.4 6949.8 6753.9 6862.7 6866.2 6927.4 6951.7 6581.5 6597.5 6658.9 6812.9 6935.7 6487.3 6499.3 6526.2 6527.3 6543.3 25676.7 25697.7 25726.7 25814.6 26177.5 2885.9 3116.6 3127.9 3149.4 3163.0 16138.7 16206.3 16363.4 16551.1 16876.0 2176.5 2204.9 2217.4 2245.4 2255.3 66256.0 67372.0 83789.2 112126.0 112429.0 17300.7 17791.3 17838.6 17966.4 18472.0 31623.4 31652.0 31669.2 31701.4 31736.0 9839.0 9965.6 10009.5 10025.1 10291.0 8263.2 8301.3 8369.5 8509.4 8516.0 8965.5 9019.3 9134.7 9226.2 9254.4 3504.0 3552.3 3560.3 3598.3 3752.2 933.9 942.7 950.3 952.4 971.1 19819.9 21211.0 21272.0 21332.9 21438.0 959.0 972.3 977.2 979.5 997.2 11628.2 11686.9 11768.0 11771.0 11903.2 608540.0 609776.0 616023.0 623969.0 637807.0 89448.9 96895.5 111880.4 114460.0 116265.0 1270.9 1276.5 1307.7 1314.1 1316.8 19052.8 19299.0 19462.3 19490.2 19496.3 36249.1 47410.3 49060.0 49664.5 49966.5 64880.0 65258.0 65789.0 66230.0 66925.3 8907.2 9883.0 12841.5 12889.3 12916.3 13500.8 13849.2 14146.2 14167.7 14314.4 11738.6 11796.8 12010.7 12797.2 13164.5 11597.1 11906.6 11929.8 11961.2 12146.8 12808.8 12897.0 12970.7 13027.2 13100.7 12673.2 12780.9 12891.1 12895.7 13197.9 12539.5 12594.3 12916.7 13063.5 13233.5 02:02:16 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | [#3] mootools.html Cycles:180 Average:6883.73 Median:2447.19 stddev:4376.13 (178.8%) stddev-sans-first:4369.90 02:02:16 INFO - PROCESS | 16599 | Values: 1528.1 1539.9 1573.6 1588.9 1590.4 10505.0 11212.8 11216.4 11216.7 11220.9 10707.3 11076.9 11079.9 11084.4 11084.6 2434.5 2472.2 2473.7 2476.1 2477.0 2342.2 2412.7 2459.9 2463.2 2463.7 2391.7 2397.4 2408.9 2464.6 2467.6 2285.3 2338.1 2347.0 2347.1 2378.8 2288.2 2307.7 2308.9 2315.3 2323.5 11210.9 11431.1 11432.0 11437.8 11439.9 5559.2 5700.9 5704.2 5709.1 5710.3 3338.6 3406.5 3412.3 3434.8 3498.8 1281.6 1293.3 1307.1 1328.0 1356.5 14639.8 15024.4 15506.8 16377.8 16521.7 4476.5 4478.7 4615.3 4615.5 4618.1 10970.1 11264.2 12648.4 12650.9 12651.4 4963.0 5498.5 5666.9 5738.6 5742.7 5265.0 5346.4 5368.5 5406.9 5411.5 4119.4 4132.1 4178.6 4213.0 4216.1 1069.2 1098.3 1107.7 1108.9 1112.6 824.8 832.3 835.5 857.0 862.2 6608.2 6643.8 6728.5 6730.3 6852.6 1034.3 1053.6 1065.4 1077.0 1077.1 4159.9 4281.9 4309.6 4338.3 4374.1 13787.0 14289.3 14293.2 14299.7 14344.4 13957.2 14071.2 14155.8 14164.8 14201.2 10487.1 10618.7 10637.8 10645.9 10659.5 6585.4 6588.3 6667.6 6704.4 6811.0 12594.4 12675.9 12687.6 12831.2 13048.3 12899.6 13163.1 13184.1 13225.3 13277.9 8491.8 8548.0 8616.4 8625.8 8632.1 10563.2 10577.7 10646.6 10650.0 10654.9 9184.4 9213.8 9218.2 9314.9 9330.2 8952.8 8983.6 9065.5 9156.5 9157.5 7756.6 8444.7 8581.1 8582.0 8610.9 5696.6 5771.3 5782.2 5833.4 5882.5 5769.2 5816.1 5837.6 6048.6 6084.2 02:02:16 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | [#4] prototype.html Cycles:180 Average:4759.84 Median:5273.87 stddev:1257.49 (23.8%) stddev-sans-first:1218.25 02:02:16 INFO - PROCESS | 16599 | Values: 427.8 432.5 434.3 437.9 440.6 5135.4 5248.6 5264.5 5272.5 5278.6 5166.9 5174.6 5180.9 5183.2 5201.3 4215.7 4321.4 4333.4 4352.4 4373.2 4331.9 4371.2 4378.7 4415.6 4425.9 4400.4 4411.3 4414.9 4428.7 4446.6 4202.4 4351.0 4365.9 4394.0 4403.9 4088.9 4114.8 4115.0 4117.5 4133.7 5012.9 5025.8 5027.7 5029.7 5034.5 4944.2 5072.5 5113.2 5113.4 5127.1 5402.9 5404.6 5425.7 5440.3 5485.0 4569.1 4577.9 4589.4 4600.6 4604.8 5440.8 5494.9 5517.5 5658.3 5658.4 4582.8 4632.8 4658.7 4683.0 4706.8 4755.5 4801.6 4809.0 4838.7 4851.5 4697.0 4850.0 4980.3 5042.7 5046.9 5289.8 5339.3 5346.4 5361.6 5372.3 1602.4 1632.3 1636.8 1641.8 1646.4 1228.6 1243.0 1268.7 1269.3 1296.4 5328.9 5409.9 5415.7 5438.5 5457.3 5624.6 5645.9 5649.9 5667.3 5686.9 5004.9 5275.2 5312.4 5327.9 5332.7 2906.2 2911.1 2917.5 2924.4 2926.7 5451.9 5717.4 5735.0 5764.5 5799.0 5636.0 5639.4 5672.8 5674.4 5676.5 5714.6 5734.4 5737.3 5802.8 5807.5 5484.9 5521.2 5539.6 5609.8 5617.6 5523.9 5539.7 5571.7 5582.9 5590.5 5561.4 5626.7 5666.5 5749.5 5820.7 4670.6 4693.6 4694.9 4749.5 4771.2 5407.6 5659.5 5669.7 5673.3 5692.7 5401.9 5423.3 5429.7 5430.5 5462.3 5440.5 5445.0 5447.7 5449.3 5487.8 5221.7 5374.2 5393.3 5412.8 5481.8 5476.4 5476.5 5488.7 5508.8 5514.9 5351.5 5385.2 5386.6 5393.0 5398.0 02:02:16 INFO - PROCESS | 16599 | 02:02:16 INFO - PROCESS | 16599 | [#5] yui.html Cycles:180 Average:17302.61 Median:41885.48 stddev:20187.76 (48.2%) stddev-sans-first:20206.60 02:02:16 INFO - PROCESS | 16599 | Values: 853.4 872.2 905.8 912.0 918.4 16907.6 16939.8 18309.2 18433.9 18702.4 15068.2 15328.4 15406.1 16877.0 16920.7 856.4 872.8 874.8 876.5 876.8 848.6 874.8 882.7 882.8 882.9 928.6 930.5 932.9 937.1 937.5 929.5 930.1 930.2 930.2 931.5 674.8 678.2 678.6 682.2 682.3 16169.4 16459.3 16548.1 17957.1 18189.1 15714.8 16039.9 16093.3 16134.3 16221.8 13453.8 13999.7 14117.5 14119.8 14385.0 3747.9 3762.9 3771.8 3783.5 3869.6 50078.7 52836.7 54854.0 69450.7 80932.6 12594.5 12733.3 12826.8 12873.4 12965.7 22595.4 22786.4 22808.5 22848.9 22915.1 6654.7 8163.2 8453.4 8775.6 8937.3 5046.2 5133.9 5191.8 5259.8 5294.0 3740.2 3806.7 3831.7 3838.1 3864.3 632.4 634.8 637.8 640.8 645.3 799.7 824.8 834.5 848.8 854.6 10812.4 11125.3 11178.8 11290.7 11715.5 779.8 791.1 793.9 802.9 811.5 5322.0 5387.3 5443.4 5453.6 5454.3 64162.0 66401.0 72473.0 77637.0 82361.6 68782.0 69414.0 70117.3 70787.6 71287.3 50442.2 54707.0 56009.7 56702.7 56987.0 11141.0 11667.2 11797.3 11914.7 11920.7 41698.4 42072.6 42734.6 42868.8 43801.6 50540.0 50671.5 50833.7 50869.7 50981.5 12883.9 12888.4 12948.3 13065.7 13426.7 14627.9 14804.3 14948.0 15002.9 15336.8 14692.0 14754.6 14865.8 15101.3 15151.5 14133.4 14488.9 14595.6 14700.0 14998.4 14485.6 14614.4 14687.9 14705.9 15157.2 11388.9 11584.6 11590.0 11693.0 11714.9 12404.9 13156.2 13254.4 13313.0 13574.7 02:02:16 INFO - PROCESS | 16599 | -------- Summary: end -------- 02:02:16 INFO - PROCESS | 16599 | 02:02:17 INFO - TEST-INFO | 16599: exit 0 02:02:17 INFO - TEST-OK | dromaeo_css | took 1116004ms 02:02:17 INFO - TEST-START | kraken 02:02:17 INFO - operating with platform_type : linux_ 02:02:17 INFO - Initialising browser for kraken test... 02:02:17 INFO - TEST-INFO | started process 16920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCfcZB/profile http://localhost:47447/getInfo.html) 02:02:21 INFO - PROCESS | 16920 | __metrics Screen width/height:1600/1200 02:02:21 INFO - PROCESS | 16920 | colorDepth:24 02:02:21 INFO - PROCESS | 16920 | Browser inner width/height: 1024/697 02:02:21 INFO - PROCESS | 16920 | __metrics 02:02:22 INFO - PROCESS | 16920 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:02:22 INFO - PROCESS | 16920 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:02:23 INFO - TEST-INFO | 16920: exit 0 02:02:23 INFO - Browser initialized. 02:02:23 INFO - Running cycle 1/1 for kraken test... 02:02:23 INFO - TEST-INFO | started process 17016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCfcZB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:02:35 INFO - PROCESS | 17016 | RSS: Main: 140075008 02:02:35 INFO - PROCESS | 17016 | 02:02:37 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47447/tests/kraken/driver.html?testName=audio-beat-detection) 02:02:38 INFO - PROCESS | 17016 | RSS: Main: 183873536 02:02:38 INFO - PROCESS | 17016 | 02:02:41 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47447/tests/kraken/driver.html?testName=audio-dft) 02:02:41 INFO - PROCESS | 17016 | RSS: Main: 174321664 02:02:41 INFO - PROCESS | 17016 | 02:02:44 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47447/tests/kraken/driver.html?testName=audio-fft) 02:02:45 INFO - PROCESS | 17016 | RSS: Main: 265895936 02:02:45 INFO - PROCESS | 17016 | 02:02:47 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47447/tests/kraken/driver.html?testName=audio-oscillator) 02:02:47 INFO - PROCESS | 17016 | RSS: Main: 172167168 02:02:47 INFO - PROCESS | 17016 | 02:02:49 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:02:50 INFO - PROCESS | 17016 | RSS: Main: 174772224 02:02:50 INFO - PROCESS | 17016 | 02:02:53 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47447/tests/kraken/driver.html?testName=imaging-darkroom) 02:02:53 INFO - PROCESS | 17016 | RSS: Main: 212656128 02:02:53 INFO - PROCESS | 17016 | 02:02:57 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47447/tests/kraken/driver.html?testName=imaging-desaturate) 02:02:57 INFO - PROCESS | 17016 | RSS: Main: 211795968 02:02:57 INFO - PROCESS | 17016 | 02:03:00 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47447/tests/kraken/driver.html?testName=json-parse-financial) 02:03:01 INFO - PROCESS | 17016 | RSS: Main: 211378176 02:03:01 INFO - PROCESS | 17016 | 02:03:02 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:03:03 INFO - PROCESS | 17016 | RSS: Main: 173527040 02:03:03 INFO - PROCESS | 17016 | 02:03:05 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47447/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:03:05 INFO - PROCESS | 17016 | RSS: Main: 179511296 02:03:05 INFO - PROCESS | 17016 | 02:03:07 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:03:08 INFO - PROCESS | 17016 | RSS: Main: 188669952 02:03:08 INFO - PROCESS | 17016 | 02:03:10 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:03:11 INFO - PROCESS | 17016 | RSS: Main: 198402048 02:03:11 INFO - PROCESS | 17016 | 02:03:14 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:03:14 INFO - PROCESS | 17016 | RSS: Main: 195227648 02:03:14 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | Cycle 1(1): loaded http://localhost:47447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47447/tests/kraken/driver.html?testName=ai-astar) 02:03:16 INFO - PROCESS | 17016 | RSS: Main: 246480896 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | __start_tp_report 02:03:16 INFO - PROCESS | 17016 | _x_x_mozilla_page_load 02:03:16 INFO - PROCESS | 17016 | _x_x_mozilla_page_load_details 02:03:16 INFO - PROCESS | 17016 | |i|pagename|runs| 02:03:16 INFO - PROCESS | 17016 | |0;ai-astar;102;112;111;111;111;114;111;111;113;112 02:03:16 INFO - PROCESS | 17016 | |1;audio-beat-detection;144;115;123;157;119;124;119;115;140;116 02:03:16 INFO - PROCESS | 17016 | |2;audio-dft;162;162;160;162;163;162;162;162;160;161 02:03:16 INFO - PROCESS | 17016 | |3;audio-fft;75;75;74;110;78;76;75;76;89;76 02:03:16 INFO - PROCESS | 17016 | |4;audio-oscillator;81;82;103;84;82;81;91;82;82;102 02:03:16 INFO - PROCESS | 17016 | |5;imaging-gaussian-blur;112;113;113;113;113;112;113;112;113;112 02:03:16 INFO - PROCESS | 17016 | |6;imaging-darkroom;146;146;146;145;146;147;146;146;147;145 02:03:16 INFO - PROCESS | 17016 | |7;imaging-desaturate;94;93;94;94;94;93;94;93;94;93 02:03:16 INFO - PROCESS | 17016 | |8;json-parse-financial;54;55;53;54;55;54;54;53;55;53 02:03:16 INFO - PROCESS | 17016 | |9;json-stringify-tinderbox;53;52;53;52;53;52;52;53;54;53 02:03:16 INFO - PROCESS | 17016 | |10;stanford-crypto-aes;79;75;75;81;75;78;77;75;74;75 02:03:16 INFO - PROCESS | 17016 | |11;stanford-crypto-ccm;120;126;137;121;126;136;124;118;159;131 02:03:16 INFO - PROCESS | 17016 | |12;stanford-crypto-pbkdf2;158;160;160;168;165;161;164;163;163;161 02:03:16 INFO - PROCESS | 17016 | |13;stanford-crypto-sha256-iterative;60;66;62;60;65;58;59;60;66;59 02:03:16 INFO - PROCESS | 17016 | __end_tp_report 02:03:16 INFO - PROCESS | 17016 | __start_cc_report 02:03:16 INFO - PROCESS | 17016 | _x_x_mozilla_cycle_collect,1661 02:03:16 INFO - PROCESS | 17016 | __end_cc_report 02:03:16 INFO - PROCESS | 17016 | __startTimestamp1491814996766__endTimestamp 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | ------- Summary: start ------- 02:03:16 INFO - PROCESS | 17016 | Number of tests: 14 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:3.26 (2.9%) stddev-sans-first:1.09 02:03:16 INFO - PROCESS | 17016 | Values: 102.0 112.0 111.0 111.0 111.0 114.0 111.0 111.0 113.0 112.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:123.50 stddev:14.60 (11.8%) stddev-sans-first:14.17 02:03:16 INFO - PROCESS | 17016 | Values: 144.0 115.0 123.0 157.0 119.0 124.0 119.0 115.0 140.0 116.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 02:03:16 INFO - PROCESS | 17016 | Values: 162.0 162.0 160.0 162.0 163.0 162.0 162.0 162.0 160.0 161.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:11.27 (14.8%) stddev-sans-first:11.78 02:03:16 INFO - PROCESS | 17016 | Values: 75.0 75.0 74.0 110.0 78.0 76.0 75.0 76.0 89.0 76.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:82.00 stddev:8.68 (10.6%) stddev-sans-first:8.93 02:03:16 INFO - PROCESS | 17016 | Values: 81.0 82.0 103.0 84.0 82.0 81.0 91.0 82.0 82.0 102.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#5] imaging-gaussian-blur Cycles:10 Average:112.60 Median:113.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:03:16 INFO - PROCESS | 17016 | Values: 112.0 113.0 113.0 113.0 113.0 112.0 113.0 112.0 113.0 112.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 02:03:16 INFO - PROCESS | 17016 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 147.0 145.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:03:16 INFO - PROCESS | 17016 | Values: 94.0 93.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 93.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 02:03:16 INFO - PROCESS | 17016 | Values: 54.0 55.0 53.0 54.0 55.0 54.0 54.0 53.0 55.0 53.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#9] json-stringify-tinderbox Cycles:10 Average:52.70 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 02:03:16 INFO - PROCESS | 17016 | Values: 53.0 52.0 53.0 52.0 53.0 52.0 52.0 53.0 54.0 53.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:2.27 (3.0%) stddev-sans-first:2.20 02:03:16 INFO - PROCESS | 17016 | Values: 79.0 75.0 75.0 81.0 75.0 78.0 77.0 75.0 74.0 75.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:128.50 stddev:12.11 (9.4%) stddev-sans-first:12.31 02:03:16 INFO - PROCESS | 17016 | Values: 120.0 126.0 137.0 121.0 126.0 136.0 124.0 118.0 159.0 131.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:2.91 (1.8%) stddev-sans-first:2.64 02:03:16 INFO - PROCESS | 17016 | Values: 158.0 160.0 160.0 168.0 165.0 161.0 164.0 163.0 163.0 161.0 02:03:16 INFO - PROCESS | 17016 | 02:03:16 INFO - PROCESS | 17016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.00 stddev:3.06 (5.0%) stddev-sans-first:3.20 02:03:16 INFO - PROCESS | 17016 | Values: 60.0 66.0 62.0 60.0 65.0 58.0 59.0 60.0 66.0 59.0 02:03:16 INFO - PROCESS | 17016 | -------- Summary: end -------- 02:03:16 INFO - PROCESS | 17016 | 02:03:17 INFO - TEST-INFO | 17016: exit 0 02:03:17 INFO - TEST-OK | kraken | took 60274ms 02:03:17 INFO - SUITE-END | took 1176s 02:03:17 INFO - Completed test suite (00:19:36) 02:03:17 INFO - javascript benchmark 02:03:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7733.891360294285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.512000759889, 3404.795712257266, 3419.179396944733, 3420.0936751760805, 3440.51832743416, 5579.8605034874145, 5695.629784064038, 5704.11586204138, 5708.486236238738, 5726.0, 5674.914876276849, 5705.48650621444, 5713.342965558962, 5727.942720572803, 5736.110902810061, 5174.094533456649, 5200.427952925175, 5202.0376230397405, 5237.973810130963, 5286.2070689396705, 5102.795888164469, 5119.283300337937, 5295.576353891679, 5298.09932311508, 5325.680459172443, 5129.051125541768, 5145.073886700392, 5193.246979188034, 5202.141646628302, 5218.478152184789, 5223.294855194538, 5234.345706786652, 5235.240890070937, 5236.581073514148, 5261.394939581959, 5026.798928042874, 5081.66969147008, 5146.099432599281, 5207.921881171786, 5210.843674689765, 5579.274694289757, 5618.297712785902, 5677.034904066319, 5687.971560142173, 5702.8289151325525, 6011.278646562397, 6048.60684055535, 6062.696865156769, 6063.393660633946, 6068.0, 6129.38706129388, 6136.294326152505, 6138.14066030756, 6144.446999770043, 6147.600405973642, 5556.472135147154, 5611.803586874481, 5652.604317697763, 5698.62958907678, 5703.74333155009, 6251.0, 6253.280872699606, 6256.280527739368, 6257.342978987141, 6260.593061450991, 5982.282126144891, 6045.33501314855, 6047.939520604826, 6055.666938318347, 6058.727357268934, 5916.3787802281, 5959.612625179436, 5982.222311099529, 6031.728572214261, 6104.868540434902, 6023.62341669937, 6034.577579569388, 6036.15493830864, 6040.486558642477, 6055.303640081447, 5795.594308398372, 5824.6796426196115, 5833.329167145833, 6015.578909476382, 6048.334683184846, 4256.404103425523, 4270.210011147948, 4275.657947364203, 4294.935575966363, 4298.376735373416, 3801.353769859131, 3866.0914685048992, 3881.5924327945722, 3900.687944964396, 3906.257811015898, 5855.619384739978, 5855.795047173328, 5870.44230798082, 5948.643081415043, 5960.0165972614905, 6110.175126357884, 6120.357362476965, 6120.663363515049, 6132.724027418777, 6149.385061493815, 5888.440598143169, 5906.0, 5911.054231322968, 5912.201852749909, 5913.05391137416, 5061.0, 5131.204663277198, 5162.406323272871, 5221.269022336875, 5258.07983602868, 6370.58591191571, 6373.776917807854, 6376.489880809524, 6380.968095159587, 6386.0, 6134.969325153345, 6142.754289828356, 6146.323904370605, 6155.753769849335, 6159.19930409044, 6137.7851775187655, 6143.38905964972, 6254.061890716429, 6262.686865656608, 6311.96844015777, 6010.068439391901, 6027.728752206073, 6031.60794548353, 6047.213862197887, 6059.848503787264, 6128.908066378919, 6131.294901086254, 6135.754569817157, 6137.84655383619, 6152.907706384497, 5697.487226149667, 5806.709664516842, 5882.294124705063, 5970.0, 5985.102234664835, 5992.101184822137, 6022.006368949074, 6030.75876964934, 6031.577789554689, 6032.607880487754, 5910.261217347832, 5943.257092863392, 5955.910661339996, 5959.791407300723, 5963.075723262901, 5815.912761308499, 5825.737841797045, 5880.705964701833, 5922.822315330547, 5999.700014999145, 5873.853153671193, 5883.794067207798, 5888.057910734433, 5897.941020589739, 5941.702914854153], "value": 5598.309087348702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.770268919324, 818.1736446189349, 831.8211584509329, 836.8159005018902, 906.1572737354267, 30914.53628195576, 31234.843825780867, 44751.552484475105, 45522.77238613811, 45558.77220613901, 46247.53752462474, 46426.76786616062, 46457.0, 46457.0, 46520.0, 7728.845423091535, 9083.227925626314, 9219.124183202584, 9226.953865230698, 9230.26157907369, 7624.504407213513, 10521.316114452575, 10764.946175269151, 10835.512401941893, 10842.891571084307, 10875.510602022929, 10941.726456838564, 10961.12311015121, 10977.06694930932, 10982.890171098266, 10842.403667798268, 10848.132149428027, 10905.83641245382, 10914.945425272903, 10916.727081822939, 10598.523066462029, 10598.68203953875, 10634.734131646694, 10657.360558366523, 10662.626808061681, 43611.34582981258, 43625.78187109076, 43699.34450983238, 43769.562304376865, 43863.34204986928, 4146.440230568895, 4219.156168766228, 4232.957670423318, 4341.327094300388, 4356.89107772305, 29711.40577188444, 30330.393392132253, 30401.23996900073, 30863.0, 31828.681713182803, 4346.956530434687, 4438.889027774299, 4451.154280686692, 4484.125595508877, 4492.483364413101, 243316.0, 245029.0, 245765.7711711448, 246090.0, 246342.0, 54703.17945230825, 54774.178387324224, 54799.452005480234, 54894.0, 54914.72542637261, 56479.71760141255, 56637.7168114165, 56669.7166514173, 56674.43325566692, 56911.71544142253, 15805.68388632221, 16544.0, 16553.337866485206, 16567.17164141788, 16583.0, 12696.0, 12870.806937895939, 14388.0, 14397.85602143986, 14410.783838242434, 13480.797788033187, 13899.0, 14148.504802332074, 14161.291935403395, 14291.714165716627, 5520.254765606672, 5556.91664625031, 5598.468145526169, 5699.173619825102, 5700.287464066992, 1003.7340104872214, 1005.8239808033711, 1005.9245556583139, 1014.457265363042, 1017.9287449878437, 28199.43601128007, 28481.430371392456, 28663.57004644932, 28828.567571486445, 28851.134465966054, 1039.5581877701945, 1087.2986923434498, 1102.5975518935531, 1105.171121658756, 1123.7359220583157, 15597.922010389875, 16474.95065887839, 17139.74290385645, 17387.73918391225, 17501.824981750273, 323139.0, 323757.0, 324240.0, 324324.0, 324635.0, 60192.398076019555, 60284.0, 60444.69777651172, 60502.69748651316, 60514.39485605175, 1502.579277802239, 1519.8176218853587, 1558.633721075569, 1559.2983157579135, 1562.6484041090664, 30060.549091763205, 31359.529607056367, 31487.0, 31927.361452771278, 31942.520862186622, 44619.33071004003, 46950.53049469598, 47808.760956194994, 47854.28218576794, 47937.760311198224, 322365.0, 325289.0, 325812.0, 326246.0, 326794.0, 26418.0, 26763.86618066897, 31192.844035779675, 31735.0, 31955.6804431962, 40093.39859902045, 40114.0, 40120.79939600283, 40383.1923361537, 40514.1897162061, 30674.693253068075, 31173.37653246877, 31249.531257031616, 31266.53100203544, 31328.843355783076, 30851.0, 30996.0, 31129.533057004617, 31316.217094571908, 31456.370872582876, 34432.65567344295, 34809.65190348064, 34953.02899253592, 35064.0, 35596.0, 30570.0, 30604.540931886484, 32638.0, 32641.34717305688, 33015.08962731173, 25486.23541293764, 25498.362540935883, 25830.483390331712, 25933.351666208495, 26003.349916252246], "value": 19181.24915633573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.0940481417908, 467.2547287077112, 470.0903751241346, 476.99523004769964, 485.90524847654706, 20923.37229883104, 21264.362069137933, 22002.229921952734, 22551.436214094654, 22687.432814179654, 20813.375598732026, 21247.57504849902, 21961.0, 22132.557348853054, 22603.547929041408, 5772.5670574706855, 6422.967885160591, 6817.45460363171, 7017.964910175442, 7025.578465292073, 6843.52095353323, 6929.549579277356, 6943.72225110995, 6944.375006249436, 6949.791506254821, 6753.864922701543, 6862.656867156647, 6866.244713081557, 6927.445804335641, 6951.687174077153, 6581.539292249545, 6597.47220222381, 6658.93341066588, 6812.863742725142, 6935.72257109715, 6487.318831522669, 6499.317571654956, 6526.184226971629, 6527.314631963671, 6543.312952140004, 25676.743232567624, 25697.74302256972, 25726.74273257262, 25814.612780808304, 26177.476450470884, 2885.942281154365, 3116.6104236970377, 3127.9218019549467, 3149.4488464518845, 3162.98418507906, 16138.677226455406, 16206.270717817608, 16363.42728004526, 16551.08969006704, 16876.0, 2176.4885251965775, 2204.922827701023, 2217.401301648562, 2245.41619179013, 2255.334676270504, 66256.0, 67371.98942015873, 83789.16210837936, 112125.99999999919, 112429.0, 17300.653986920443, 17791.288348466176, 17838.55403614894, 17966.371177009005, 18472.0, 31623.36753264922, 31652.0, 31669.20826979344, 31701.365972680418, 31736.0, 9838.950805246071, 9965.601375945025, 10009.499525023719, 10025.097741203326, 10291.0, 8263.199682413728, 8301.335893128535, 8369.539675317794, 8509.446885952393, 8515.957420212982, 8965.50689712072, 9019.323550733721, 9134.680286189952, 9226.169644732006, 9254.352195346395, 3504.0, 3552.2717842842158, 3560.287942411528, 3598.2983318253214, 3752.155764952918, 933.8739270198437, 942.6614207824905, 950.273041123541, 952.4333021851987, 971.1065819445986, 19819.900900495406, 21211.0, 21272.0, 21332.893335533532, 21438.03528841206, 959.0270162496345, 972.2659392158874, 977.1938151025432, 979.5445118020012, 997.2420960070399, 11628.18602697803, 11686.883131168579, 11768.0, 11771.0, 11903.166778325434, 608540.0, 609776.0, 616023.0, 623969.0, 637807.0, 89448.94795564655, 96895.51552242335, 111880.44059779649, 114460.0, 116265.0, 1270.8919741822049, 1276.489404238312, 1307.7384523095418, 1314.0538812055304, 1316.82881225442, 19052.809471905104, 19299.0, 19462.31881884184, 19490.22039118476, 19496.31762888292, 36249.09377265589, 47410.288845666655, 49060.0, 49664.50335496743, 49966.50033499764, 64880.0, 65258.0, 65789.0, 66230.0, 66925.3307466919, 8907.153820387053, 9883.0, 12841.45902491707, 12889.291088989821, 12916.289604071866, 13500.797488037491, 13849.16904985704, 14146.151230926178, 14167.716645666822, 14314.355853986805, 11738.58914937973, 11796.76406471883, 12010.699732506757, 12797.232166070065, 13164.473421063434, 11597.072234221074, 11906.642800715992, 11929.761404772029, 11961.162718609614, 12146.757064858477, 12808.807867881802, 12897.038476331227, 12970.67573310637, 13027.153235039692, 13100.672483187996, 12673.239605623692, 12780.936095319836, 12891.097623166288, 12895.677608059874, 13197.944164467011, 12539.498420063095, 12594.307313097868, 12916.677083072998, 13063.542776002794, 13233.470661173445], "value": 11263.029705302768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.0755143138394, 1539.9461018864342, 1573.6065983504125, 1588.8887777855548, 1590.3797518967604, 10505.0, 11212.775744485105, 11216.383098929566, 11216.66350009499, 11220.943895280523, 10707.304025238354, 11076.944615276932, 11079.944600277007, 11084.390358530278, 11084.556617735281, 2434.4644178280796, 2472.171822439476, 2473.703155621328, 2476.1333533263396, 2477.0091963214677, 2342.2238267862153, 2412.662227288181, 2459.9139030133947, 2463.224084413413, 2463.716672582658, 2391.7249516305587, 2397.4006498375406, 2408.9397765055837, 2464.605663093905, 2467.5805113130723, 2285.31440567829, 2338.1232037985756, 2347.0, 2347.084636991583, 2378.7859092681742, 2288.1533832481923, 2307.7230732312064, 2308.8614683119067, 2315.282262498614, 2323.546908352872, 11210.887891121147, 11431.08551315901, 11432.0, 11437.828432573519, 11439.885601143966, 5559.19391688207, 5700.885982280372, 5704.201411802351, 5709.0580054290995, 5710.257666503369, 3338.5659864217496, 3406.5230867678547, 3412.334594754024, 3434.8282585870606, 3498.7900725956524, 1281.641140480667, 1293.275765571283, 1307.111164408202, 1327.9535216267482, 1356.4709763192363, 14639.780403293958, 15024.399024039025, 15506.767398488919, 16377.83622163775, 16521.66956660872, 4476.485204201494, 4478.731276123443, 4615.3077038443835, 4615.492295847454, 4618.122556714214, 10970.122390208764, 11264.211505194722, 12648.430820613094, 12650.936745316214, 12651.367431628565, 4963.0, 5498.532624726943, 5666.886662266732, 5738.626989245769, 5742.712864356766, 5265.0, 5346.385165705994, 5368.5436737876935, 5406.945930540644, 5411.485908838654, 4119.382092686061, 4132.070284186094, 4178.623923846869, 4212.978935105305, 4216.051388437577, 1069.187417562658, 1098.2696506822874, 1107.684309971654, 1108.9001989820954, 1112.6383925224334, 824.7814329202766, 832.296709280669, 835.467317902727, 857.0, 862.2498426368974, 6608.173978252718, 6643.800685979429, 6728.495362847806, 6730.293319201512, 6852.554583952027, 1034.3276870034388, 1053.5680371047833, 1065.3980501017056, 1076.9730756730987, 1077.0844781935448, 4159.875203743893, 4281.850135245314, 4309.59058889405, 4338.305871060616, 4374.12517496502, 13787.0, 14289.285535723173, 14293.213873236864, 14299.714005719827, 14344.354504047344, 13957.162570245819, 14071.155730656194, 14155.787663185061, 14164.787528187086, 14201.21893295858, 10487.108595769445, 10618.681439556825, 10637.787244254916, 10645.946770266099, 10659.467026648637, 6585.374389432996, 6588.341165883373, 6667.599944003376, 6704.396604305636, 6810.965945170243, 12594.370281486072, 12675.873241267838, 12687.555935542212, 12831.165974211646, 13048.282344470765, 12899.613011609667, 13163.078584498993, 13184.143030702973, 13225.272610006543, 13277.86722132805, 8491.83016339682, 8547.95726021366, 8616.396852220285, 8625.784355391166, 8632.136786321318, 10563.207759418228, 10577.735556610838, 10646.574137034431, 10650.041496265063, 10654.946725266323, 9184.357095003286, 9213.815723685355, 9218.21645160169, 9314.906850931404, 9330.160285574331, 8952.776180595538, 8983.640654374014, 9065.546722663972, 9156.450612963243, 9157.450552966844, 7756.612169391621, 8444.746657600283, 8581.141885811368, 8582.0, 8610.870836937576, 5696.572757043155, 5771.307443106854, 5782.190493330853, 5833.387494313036, 5882.470577647861, 5769.249997500298, 5816.098504731774, 5837.562182836219, 6048.637081775108, 6084.209052823105], "value": 5219.514735825959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.82459191731397, 432.54582688177413, 434.2682579852948, 437.8839607504012, 440.5770460358056, 5135.435102138762, 5248.606354523412, 5264.49987251211, 5272.4991125843035, 5278.630495865282, 5166.922496162551, 5174.611904107188, 5180.896382072357, 5183.222516622509, 5201.349831271091, 4215.747055176692, 4321.438213032301, 4333.393324934512, 4352.39066530686, 4373.212821692094, 4331.891702707426, 4371.229651990949, 4378.715383500078, 4415.580519850609, 4425.867223983286, 4400.44994375703, 4411.3382992551215, 4414.911701765979, 4428.734275943438, 4446.577575130357, 4202.432671589342, 4350.978245108786, 4365.912681746379, 4393.978030109845, 4403.933940990888, 4088.897777555555, 4114.794260287003, 4114.991827002404, 4117.547069822317, 4133.6693064554765, 5012.8997420051755, 5025.773840177201, 5027.723475208862, 5029.748512574393, 5034.4644883310575, 4944.233643785219, 5072.492750724935, 5113.181890897438, 5113.360829896263, 5127.102757017507, 5402.91895621566, 5404.567634589223, 5425.740793477102, 5440.265564148868, 5484.972575137139, 4569.13186494565, 4577.931331030038, 4589.449266088058, 4600.585947264729, 4604.838830640945, 5440.782368705247, 5494.945050549523, 5517.475839795213, 5658.321001479808, 5658.377578466366, 4582.770861456914, 4632.814687412533, 4658.67227840064, 4682.9531704683195, 4706.810938264947, 4755.453122890912, 4801.639877009238, 4808.975955120202, 4838.685485443435, 4851.539103785135, 4696.95303046972, 4850.011495286915, 4980.327655766498, 5042.672226305279, 5046.873828154252, 5289.841304760864, 5339.305890234323, 5346.39608117571, 5361.624686271924, 5372.272400287722, 1602.3510478256326, 1632.2981118119085, 1636.7954005749282, 1641.7783599214192, 1646.382606522554, 1228.6498347970964, 1242.9627111186678, 1268.6955130768733, 1269.282855186835, 1296.3971753134838, 5328.946710532922, 5409.891802163935, 5415.729213539386, 5438.45615438453, 5457.345118585795, 5624.634398764068, 5645.887082258332, 5649.915251271234, 5667.263255776805, 5686.914696279477, 5004.874878128076, 5275.235090911796, 5312.442193569696, 5327.920081198785, 5332.70693601755, 2906.2007947814095, 2911.1470758656637, 2917.5186094294204, 2924.4151169766133, 2926.7171606146812, 5451.890962180734, 5717.428257174332, 5734.971325143348, 5764.510016648632, 5799.0, 5636.0, 5639.379668236491, 5672.801451949162, 5674.432556744293, 5676.460736230051, 5714.628549144292, 5734.426557344233, 5737.254156959652, 5802.8259152224655, 5807.535397168132, 5484.8990438892215, 5521.199426083115, 5539.6150962259435, 5609.775608975595, 5617.550595952396, 5523.944760552504, 5539.7230138492105, 5571.693556854249, 5582.944170558242, 5590.5248053915875, 5561.388247292875, 5626.690532020614, 5666.546676265972, 5749.453801888814, 5820.711298116551, 4670.556297151765, 4693.624510039257, 4694.906101877875, 4749.548792864673, 4771.165046116985, 5407.593216273723, 5659.462351076641, 5669.688167150846, 5673.347565030074, 5692.658440493584, 5401.918971215514, 5423.322084739408, 5429.701366424884, 5430.456954304538, 5462.317210348707, 5440.470181365684, 5444.972775136099, 5447.74701818576, 5449.3460784706085, 5487.832306238934, 5221.738913054256, 5374.193870919394, 5393.325834270716, 5412.810551630674, 5481.835544933659, 5476.3702174250475, 5476.534494568006, 5488.69812160335, 5508.834734957958, 5514.944850551443, 5351.464853514617, 5385.165299378603, 5386.622936394415, 5393.029254734185, 5398.001369746609], "value": 4398.524102669943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.4324674091729, 872.1801506583811, 905.791667916379, 911.9726408207754, 918.3846822628834, 16907.577310567227, 16939.78420466073, 18309.17608707608, 18433.90783046083, 18702.438926832183, 15068.171250581214, 15328.386864525433, 15406.07563546188, 16877.033897034187, 16920.74618880715, 856.4304737349655, 872.7599910024762, 874.8206617643368, 876.5091548732698, 876.7764220123892, 848.6435697007241, 874.8381549413378, 882.7219425880827, 882.8366752150872, 882.8808110905042, 928.6239073175375, 930.4556834251937, 932.9300302477342, 937.0769791755116, 937.5499760115149, 929.4748467116058, 930.1256818590537, 930.1767935377206, 930.1953809954408, 931.5481991234246, 674.8076798112563, 678.2369833936821, 678.5691086160274, 682.2018238660729, 682.276786606199, 16169.353225870951, 16459.341626335052, 16548.089855057966, 17957.102144892833, 18189.090545472674, 15714.842851571453, 16039.91980040104, 16093.275802588794, 16134.273957671932, 16221.837781622151, 13453.798193027113, 13999.65000874976, 14117.505887293895, 14119.788203176859, 14384.99305048647, 3747.887563373103, 3762.9059273518383, 3771.754835935683, 3783.5270591176104, 3869.613038696136, 50078.74960625174, 52836.73581632067, 54854.0, 69450.65274673645, 80932.59533702294, 12594.496220151275, 12733.299668518135, 12826.80759788604, 12873.420696068699, 12965.675858103623, 22595.43511412195, 22786.43033924132, 22808.543829123326, 22848.885755571115, 22915.08339666428, 6654.70053847578, 8163.183681631908, 8453.408261421642, 8775.561221938877, 8937.285017198608, 5046.243063540425, 5133.948660513422, 5191.792328306901, 5259.789608415621, 5294.0, 3740.1958578905665, 3806.676432503268, 3831.6934645228316, 3838.1172330363615, 3864.2851072551666, 632.4466092169351, 634.7524465458475, 637.8182218067828, 640.7917426836296, 645.3449748505271, 799.6681377228385, 824.8350329934037, 834.4659417972503, 848.804774901776, 854.5599016506504, 10812.366060798495, 11125.332480051224, 11178.776424471627, 11290.717732056764, 11715.531378744925, 779.8128449172158, 791.0665414810463, 793.928546430824, 802.863513202757, 811.5252577242379, 5322.0, 5387.272718183073, 5443.374011988592, 5453.618246722771, 5454.3454785426, 64162.0, 66401.0, 72473.0, 77637.0, 82361.58819205865, 68781.96827047598, 69414.0, 70117.29882701108, 70787.64606176937, 71287.28712712911, 50442.24336634953, 54707.0, 56009.719951400795, 56702.7164864173, 56987.0, 11141.0, 11667.241629294409, 11797.29216247028, 11914.702132446759, 11920.70198245016, 41698.374524382765, 42072.579274206866, 42734.5726542743, 42868.78565607152, 43801.56198437975, 50540.0, 50671.49328506815, 50833.74583127061, 50869.74565127151, 50981.490185097675, 12883.935580322413, 12888.355582220664, 12948.328568668425, 13065.738685226052, 13426.731465370443, 14627.92686036563, 14804.333804979016, 14948.028378155384, 15002.924985375003, 15336.76994845056, 14692.0, 14754.557363279118, 14865.777013344592, 15101.32044057998, 15151.469698560497, 14133.434662613381, 14488.927555362156, 14595.635109122357, 14700.044497107654, 14998.400063997755, 14485.637859053608, 14614.415423382945, 14687.853121468648, 14705.92647036758, 15157.242137892841, 11388.886111138783, 11584.594539191088, 11590.0, 11693.006094482063, 11714.88285117138, 12404.937975310426, 13156.210627362389, 13254.403551839998, 13313.04602930729, 13574.728505430034], "value": 7705.87873681922, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 111.0, 114.0, 111.0, 111.0, 113.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 123.0, 157.0, 119.0, 124.0, 119.0, 115.0, 140.0, 116.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 162.0, 163.0, 162.0, 162.0, 162.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 110.0, 78.0, 76.0, 75.0, 76.0, 89.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 103.0, 84.0, 82.0, 81.0, 91.0, 82.0, 82.0, 102.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 54.0, 55.0, 54.0, 54.0, 53.0, 55.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 53.0, 52.0, 52.0, 53.0, 54.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 75.0, 81.0, 75.0, 78.0, 77.0, 75.0, 74.0, 75.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 126.0, 137.0, 121.0, 126.0, 136.0, 124.0, 118.0, 159.0, 131.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 160.0, 168.0, 165.0, 161.0, 164.0, 163.0, 163.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 66.0, 62.0, 60.0, 65.0, 58.0, 59.0, 60.0, 66.0, 59.0], "value": 61.5, "unit": "score"}]}]} 02:03:18 INFO - Return code: 0 02:03:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:03:18 ERROR - # TBPL SUCCESS # 02:03:18 INFO - Running post-action listener: _resource_record_post_action 02:03:18 INFO - [mozharness: 2017-04-10 09:03:18.097578Z] Finished run-tests step (success) 02:03:18 INFO - Running post-run listener: _resource_record_post_run 02:03:18 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 365510656; Read time: 28; Write time: 270084 02:03:18 INFO - TinderboxPrint: CPU usage
13.1% 02:03:18 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 02:03:18 INFO - TinderboxPrint: I/O write bytes / time
365,510,656 / 270,084 02:03:18 INFO - TinderboxPrint: CPU idle
8,271.9 (86.9%) 02:03:18 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 02:03:18 INFO - TinderboxPrint: Swap in / out
0 / 0 02:03:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110268416; Read time: 0; Write time: 114960 02:03:18 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254468096; Read time: 28; Write time: 155100 02:03:18 INFO - Running post-run listener: _upload_blobber_files 02:03:18 INFO - Blob upload gear active. 02:03:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:03:18 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 02:03:18 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'] 02:03:18 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 02:03:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:03:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:03:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:03:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:24 INFO - (blobuploader) - INFO - Done attempting. 02:03:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:03:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:03:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:32 INFO - (blobuploader) - INFO - Done attempting. 02:03:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:03:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:42 INFO - (blobuploader) - INFO - Done attempting. 02:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:03:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:49 INFO - (blobuploader) - INFO - Done attempting. 02:03:49 INFO - (blobuploader) - INFO - Iteration through files over. 02:03:49 INFO - Return code: 0 02:03:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:03:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:03:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/56fb381df9b202ebd4f6d6b6ae7382fb19acc2840b75ba57540c358e2875de2b54b233e40bbafe143df567c0ae7bb21982c04da73c7047f2d8f3736f11a99566", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/36d40d3ce8de7173e548712c106b0f16a46c730b28ae15c027359d644d69ebfb179bf2ecc0fb00638423037ba6ae579e439f7d219b359c85405e374826d44aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1ce41d6ef466f6b75e9f2f7c527cdd0bac3d074749748bd524a40f750c8e3b7397af9e4fddf3b0a99610f3eda1fa2df98fd367a144a470231f11a59a8650b4dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/30928f5d49f30e45f6d6a8facacb90ca6d187fb21aa327d3ffe16ddd40858d0937143db83cb84e7b5af121a46c3d1a0f6989058a6276e96b76fbcd92802b2f06"} 02:03:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:03:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:03:49 INFO - Contents: 02:03:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/56fb381df9b202ebd4f6d6b6ae7382fb19acc2840b75ba57540c358e2875de2b54b233e40bbafe143df567c0ae7bb21982c04da73c7047f2d8f3736f11a99566", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/36d40d3ce8de7173e548712c106b0f16a46c730b28ae15c027359d644d69ebfb179bf2ecc0fb00638423037ba6ae579e439f7d219b359c85405e374826d44aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1ce41d6ef466f6b75e9f2f7c527cdd0bac3d074749748bd524a40f750c8e3b7397af9e4fddf3b0a99610f3eda1fa2df98fd367a144a470231f11a59a8650b4dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/30928f5d49f30e45f6d6a8facacb90ca6d187fb21aa327d3ffe16ddd40858d0937143db83cb84e7b5af121a46c3d1a0f6989058a6276e96b76fbcd92802b2f06"} 02:03:49 INFO - Running post-run listener: copy_logs_to_upload_dir 02:03:49 INFO - Copying logs to upload dir... 02:03:49 INFO - mkdir: /builds/slave/test/build/upload/logs 02:03:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.033304 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-10 02:03:49.742021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 02:03:49.745565) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/56fb381df9b202ebd4f6d6b6ae7382fb19acc2840b75ba57540c358e2875de2b54b233e40bbafe143df567c0ae7bb21982c04da73c7047f2d8f3736f11a99566", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/36d40d3ce8de7173e548712c106b0f16a46c730b28ae15c027359d644d69ebfb179bf2ecc0fb00638423037ba6ae579e439f7d219b359c85405e374826d44aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1ce41d6ef466f6b75e9f2f7c527cdd0bac3d074749748bd524a40f750c8e3b7397af9e4fddf3b0a99610f3eda1fa2df98fd367a144a470231f11a59a8650b4dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/30928f5d49f30e45f6d6a8facacb90ca6d187fb21aa327d3ffe16ddd40858d0937143db83cb84e7b5af121a46c3d1a0f6989058a6276e96b76fbcd92802b2f06"} build_url:https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/eaSTkW9-SE6LVESU0UZ2uQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/56fb381df9b202ebd4f6d6b6ae7382fb19acc2840b75ba57540c358e2875de2b54b233e40bbafe143df567c0ae7bb21982c04da73c7047f2d8f3736f11a99566", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/36d40d3ce8de7173e548712c106b0f16a46c730b28ae15c027359d644d69ebfb179bf2ecc0fb00638423037ba6ae579e439f7d219b359c85405e374826d44aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1ce41d6ef466f6b75e9f2f7c527cdd0bac3d074749748bd524a40f750c8e3b7397af9e4fddf3b0a99610f3eda1fa2df98fd367a144a470231f11a59a8650b4dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/30928f5d49f30e45f6d6a8facacb90ca6d187fb21aa327d3ffe16ddd40858d0937143db83cb84e7b5af121a46c3d1a0f6989058a6276e96b76fbcd92802b2f06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 02:03:49.770593) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:03:49.770884) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1491813750.749818-1649762106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:03:49.856031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 02:03:49.856362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 02:03:49.856659) ========= ========= Total master_lag: 0.16 =========