builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1490701638.83 results: success (0) revision: d4af7ec6cfcd9b81cd1f433a00b412de61e95b62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.831126) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.831575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.831858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.846504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.846801) ========= 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=14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-28 04:47:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2017-03-28 04:47:19 (114 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086249 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.946910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.947244) ========= 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=14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019745 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.997057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:18.997418) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d4af7ec6cfcd9b81cd1f433a00b412de61e95b62 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev d4af7ec6cfcd9b81cd1f433a00b412de61e95b62 --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=14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-28 04:47:19,426 truncating revision to first 12 chars 2017-03-28 04:47:19,426 Setting DEBUG logging. 2017-03-28 04:47:19,426 attempt 1/10 2017-03-28 04:47:19,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d4af7ec6cfcd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-28 04:47:20,089 unpacking tar archive at: mozilla-central-d4af7ec6cfcd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956944 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:19.968181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:19.968512) ========= script_repo_revision: d4af7ec6cfcd9b81cd1f433a00b412de61e95b62 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:19.968924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:19.969217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 04:47:19.978527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-28 04:47:19.978807) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:47:20 INFO - MultiFileLogger online at 20170328 04:47:20 in /builds/slave/test 04:47:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:47:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:47:20 INFO - {'append_to_log': False, 04:47:20 INFO - 'base_work_dir': '/builds/slave/test', 04:47:20 INFO - 'blob_upload_branch': 'Firefox', 04:47:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:47:20 INFO - 'branch': 'Firefox', 04:47:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:47:20 INFO - 'config_files': ('talos/linux_config.py',), 04:47:20 INFO - 'default_actions': ('clobber', 04:47:20 INFO - 'read-buildbot-config', 04:47:20 INFO - 'download-and-extract', 04:47:20 INFO - 'populate-webroot', 04:47:20 INFO - 'create-virtualenv', 04:47:20 INFO - 'install', 04:47:20 INFO - 'run-tests'), 04:47:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:47:20 INFO - 'download_minidump_stackwalk': True, 04:47:20 INFO - 'download_symbols': 'ondemand', 04:47:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:47:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:47:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:47:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:47:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:47:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:47:20 INFO - 'gecko_profile': False, 04:47:20 INFO - 'gecko_profile_interval': 0, 04:47:20 INFO - 'installer_path': 'installer.exe', 04:47:20 INFO - 'log_level': 'info', 04:47:20 INFO - 'log_name': 'talos', 04:47:20 INFO - 'log_to_console': True, 04:47:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:47:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:47:20 INFO - 'opt_config_files': (), 04:47:20 INFO - 'pip_index': False, 04:47:20 INFO - 'suite': 'dromaeojs', 04:47:20 INFO - 'system_bits': '32', 04:47:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:47:20 INFO - 'title': 'talos-linux64-ix-036', 04:47:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:47:20 INFO - 'use_talos_json': True, 04:47:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:47:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:47:20 INFO - 'work_dir': 'build'} 04:47:20 INFO - [mozharness: 2017-03-28 11:47:20.505329Z] Running clobber step. 04:47:20 INFO - Running pre-action listener: _resource_record_pre_action 04:47:20 INFO - Running main action method: clobber 04:47:20 INFO - rmtree: /builds/slave/test/build 04:47:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:47:21 INFO - Running post-action listener: _resource_record_post_action 04:47:21 INFO - [mozharness: 2017-03-28 11:47:21.441901Z] Finished clobber step (success) 04:47:21 INFO - [mozharness: 2017-03-28 11:47:21.442001Z] Running read-buildbot-config step. 04:47:21 INFO - Running pre-action listener: _resource_record_pre_action 04:47:21 INFO - Running main action method: read_buildbot_config 04:47:21 INFO - Using buildbot properties: 04:47:21 INFO - { 04:47:21 INFO - "project": "", 04:47:21 INFO - "product": "firefox", 04:47:21 INFO - "who": "cbook@mozilla.com", 04:47:21 INFO - "installer_path": "public/build/target.tar.bz2", 04:47:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 04:47:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:47:21 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 04:47:21 INFO - "stage_platform": "linux64-stylo", 04:47:21 INFO - "basedir": "/builds/slave/test", 04:47:21 INFO - "buildnumber": 1, 04:47:21 INFO - "platform": "ubuntu64_hw_stylo", 04:47:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:47:21 INFO - "slavebuilddir": "test", 04:47:21 INFO - "taskId": "Jp6oMkI6TQSquK-Y5EqD0Q", 04:47:21 INFO - "branch": "mozilla-central", 04:47:21 INFO - "script_repo_revision": "production", 04:47:21 INFO - "revision": "d4af7ec6cfcd9b81cd1f433a00b412de61e95b62", 04:47:21 INFO - "slavename": "talos-linux64-ix-036", 04:47:21 INFO - "repo_path": "mozilla-central" 04:47:21 INFO - } 04:47:21 INFO - Finding installer, test and symbols from parent task. 04:47:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jp6oMkI6TQSquK-Y5EqD0Q'}, attempt #1 04:47:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jp6oMkI6TQSquK-Y5EqD0Q'}, attempt #1 04:47:22 INFO - Task dependencies: Dgu31funR72svcAOHHmVlQ 04:47:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ'}, attempt #1 04:47:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.tar.bz2 04:47:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/test_packages.json 04:47:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.crashreporter-symbols.zip 04:47:22 INFO - Running post-action listener: _resource_record_post_action 04:47:22 INFO - [mozharness: 2017-03-28 11:47:22.810463Z] Finished read-buildbot-config step (success) 04:47:22 INFO - [mozharness: 2017-03-28 11:47:22.810683Z] Running download-and-extract step. 04:47:22 INFO - Running pre-action listener: _resource_record_pre_action 04:47:22 INFO - Running main action method: download_and_extract 04:47:22 INFO - mkdir: /builds/slave/test/build/tests 04:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:22 INFO - trying https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.test_packages.json 04:47:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:47:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:47:23 INFO - Downloaded 986 bytes. 04:47:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:47:23 INFO - Using the following test package requirements: 04:47:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:47:23 INFO - u'common': [u'target.common.tests.zip'], 04:47:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:47:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:47:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:47:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:47:23 INFO - u'mozbase': [u'target.common.tests.zip'], 04:47:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:47:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:47:23 INFO - u'web-platform': [u'target.common.tests.zip', 04:47:23 INFO - u'target.web-platform.tests.zip'], 04:47:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:47:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:47:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.common.tests.zip 04:47:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:47:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.common.tests.zip into memory 04:47:24 INFO - Expected file size: 58225812 04:47:24 INFO - Obtained file size: 58225812 04:47:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:47:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.common.tests.zip 04:47:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:47:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.common.tests.zip into memory 04:47:35 INFO - Expected file size: 58225812 04:47:35 INFO - Obtained file size: 58225812 04:47:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.talos.tests.zip 04:47:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:47:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.talos.tests.zip into memory 04:47:46 INFO - Expected file size: 14404171 04:47:46 INFO - Obtained file size: 14404171 04:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:47 INFO - trying https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.tar.bz2 04:47:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:47:48 INFO - Downloaded 63934609 bytes. 04:47:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.tar.bz2 04:47:48 INFO - mkdir: /builds/slave/test/properties 04:47:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:48 INFO - Contents: 04:47:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.tar.bz2 04:47:48 INFO - Running post-action listener: _resource_record_post_action 04:47:48 INFO - Running post-action listener: set_extra_try_arguments 04:47:48 INFO - [mozharness: 2017-03-28 11:47:48.278822Z] Finished download-and-extract step (success) 04:47:48 INFO - [mozharness: 2017-03-28 11:47:48.278937Z] Running populate-webroot step. 04:47:48 INFO - Running pre-action listener: _resource_record_pre_action 04:47:48 INFO - Running main action method: populate_webroot 04:47:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:48 INFO - '--tppagecycles', 04:47:48 INFO - '7'], 04:47:48 INFO - 'tests': ['tsvgm']}}, 04:47:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:47:48 INFO - 'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:47:48 INFO - 'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['damp', 'tps']}, 04:47:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:47:48 INFO - 'tests': ['damp', 'tps']}, 04:47:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['dromaeo_dom']}, 04:47:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['basic_compositor_video']}, 04:47:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:47:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['a11yr', 04:47:48 INFO - 'ts_paint', 04:47:48 INFO - 'tpaint', 04:47:48 INFO - 'sessionrestore', 04:47:48 INFO - 'sessionrestore_no_auto_restore', 04:47:48 INFO - 'tabpaint']}, 04:47:48 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:48 INFO - 'ts_paint', 04:47:48 INFO - 'tpaint', 04:47:48 INFO - 'sessionrestore', 04:47:48 INFO - 'sessionrestore_no_auto_restore', 04:47:48 INFO - 'tabpaint']}, 04:47:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:48 INFO - 'ts_paint', 04:47:48 INFO - 'tpaint', 04:47:48 INFO - 'sessionrestore', 04:47:48 INFO - 'sessionrestore_no_auto_restore', 04:47:48 INFO - 'tabpaint']}, 04:47:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:48 INFO - 'ts_paint', 04:47:48 INFO - 'tpaint', 04:47:48 INFO - 'sessionrestore', 04:47:48 INFO - 'sessionrestore_no_auto_restore', 04:47:48 INFO - 'tabpaint']}, 04:47:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['a11yr', 04:47:48 INFO - 'ts_paint', 04:47:48 INFO - 'tpaint', 04:47:48 INFO - 'sessionrestore', 04:47:48 INFO - 'sessionrestore_no_auto_restore', 04:47:48 INFO - 'tabpaint']}, 04:47:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['a11yr', 04:47:48 INFO - 'ts_paint', 04:47:48 INFO - 'tpaint', 04:47:48 INFO - 'sessionrestore', 04:47:48 INFO - 'sessionrestore_no_auto_restore', 04:47:48 INFO - 'tabpaint']}, 04:47:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['tsvgx', 04:47:48 INFO - 'tsvgr_opacity', 04:47:48 INFO - 'tart', 04:47:48 INFO - 'tscrollx', 04:47:48 INFO - 'cart', 04:47:48 INFO - 'tsvg_static']}, 04:47:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:48 INFO - 'tsvgr_opacity', 04:47:48 INFO - 'tart', 04:47:48 INFO - 'tscrollx', 04:47:48 INFO - 'cart', 04:47:48 INFO - 'tsvg_static']}, 04:47:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:47:48 INFO - 'talos_options': ['--disable-e10s'], 04:47:48 INFO - 'tests': ['tp5o']}, 04:47:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:47:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:47:48 INFO - 'talos_options': ['--disable-e10s', 04:47:48 INFO - '--xperf_path', 04:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:48 INFO - 'tests': ['tp5n']}, 04:47:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:47:48 INFO - 'talos_options': ['--xperf_path', 04:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:48 INFO - 'tests': ['tp5n']}}, 04:47:48 INFO - 'talos.zip': {'path': '', 04:47:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:48 INFO - Running post-action listener: _resource_record_post_action 04:47:48 INFO - [mozharness: 2017-03-28 11:47:48.295435Z] Finished populate-webroot step (success) 04:47:48 INFO - [mozharness: 2017-03-28 11:47:48.295543Z] Running create-virtualenv step. 04:47:48 INFO - Running pre-action listener: _resource_record_pre_action 04:47:48 INFO - Running main action method: create_virtualenv 04:47:48 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:47:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:48 INFO - Using real prefix '/usr' 04:47:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:50 INFO - Installing pip.................done. 04:47:50 INFO - Return code: 0 04:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:47:51 INFO - Reading from file tmpfile_stdout 04:47:51 INFO - Output received: 04:47:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:47:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:47:51 INFO - Using env: {'DISPLAY': ':0', 04:47:51 INFO - 'HOME': '/home/cltbld', 04:47:51 INFO - 'LANG': 'en_US.UTF-8', 04:47:51 INFO - 'LANGUAGE': 'en_US:en', 04:47:51 INFO - 'LOGNAME': 'cltbld', 04:47:51 INFO - 'MAIL': '/var/mail/cltbld', 04:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:51 INFO - 'MOZ_NO_REMOTE': '1', 04:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:51 INFO - 'NO_EM_RESTART': '1', 04:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:51 INFO - 'PWD': '/builds/slave/test', 04:47:51 INFO - 'SHELL': '/bin/bash', 04:47:51 INFO - 'SHLVL': '1', 04:47:51 INFO - 'TERM': 'linux', 04:47:51 INFO - 'TMOUT': '86400', 04:47:51 INFO - 'USER': 'cltbld', 04:47:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:51 INFO - '_': '/tools/buildbot/bin/python'} 04:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:47:51 INFO - Cleaning up... 04:47:51 INFO - Return code: 0 04:47:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:47:51 INFO - Using env: {'DISPLAY': ':0', 04:47:51 INFO - 'HOME': '/home/cltbld', 04:47:51 INFO - 'LANG': 'en_US.UTF-8', 04:47:51 INFO - 'LANGUAGE': 'en_US:en', 04:47:51 INFO - 'LOGNAME': 'cltbld', 04:47:51 INFO - 'MAIL': '/var/mail/cltbld', 04:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:51 INFO - 'MOZ_NO_REMOTE': '1', 04:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:51 INFO - 'NO_EM_RESTART': '1', 04:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:51 INFO - 'PWD': '/builds/slave/test', 04:47:51 INFO - 'SHELL': '/bin/bash', 04:47:51 INFO - 'SHLVL': '1', 04:47:51 INFO - 'TERM': 'linux', 04:47:51 INFO - 'TMOUT': '86400', 04:47:51 INFO - 'USER': 'cltbld', 04:47:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:51 INFO - '_': '/tools/buildbot/bin/python'} 04:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:51 INFO - Downloading/unpacking psutil>=3.1.1 04:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:53 INFO - Installing collected packages: psutil 04:47:53 INFO - Running setup.py install for psutil 04:47:53 INFO - building 'psutil._psutil_linux' extension 04:47:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:47:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:47:53 INFO - building 'psutil._psutil_posix' extension 04:47:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:47:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:54 INFO - Successfully installed psutil 04:47:54 INFO - Cleaning up... 04:47:54 INFO - Return code: 0 04:47:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:54 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:47:54 INFO - Using env: {'DISPLAY': ':0', 04:47:54 INFO - 'HOME': '/home/cltbld', 04:47:54 INFO - 'LANG': 'en_US.UTF-8', 04:47:54 INFO - 'LANGUAGE': 'en_US:en', 04:47:54 INFO - 'LOGNAME': 'cltbld', 04:47:54 INFO - 'MAIL': '/var/mail/cltbld', 04:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:54 INFO - 'MOZ_NO_REMOTE': '1', 04:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:54 INFO - 'NO_EM_RESTART': '1', 04:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:54 INFO - 'PWD': '/builds/slave/test', 04:47:54 INFO - 'SHELL': '/bin/bash', 04:47:54 INFO - 'SHLVL': '1', 04:47:54 INFO - 'TERM': 'linux', 04:47:54 INFO - 'TMOUT': '86400', 04:47:54 INFO - 'USER': 'cltbld', 04:47:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:54 INFO - '_': '/tools/buildbot/bin/python'} 04:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:56 INFO - Installing collected packages: mozsystemmonitor 04:47:56 INFO - Running setup.py install for mozsystemmonitor 04:47:56 INFO - Successfully installed mozsystemmonitor 04:47:56 INFO - Cleaning up... 04:47:56 INFO - Return code: 0 04:47:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:56 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:47:56 INFO - Using env: {'DISPLAY': ':0', 04:47:56 INFO - 'HOME': '/home/cltbld', 04:47:56 INFO - 'LANG': 'en_US.UTF-8', 04:47:56 INFO - 'LANGUAGE': 'en_US:en', 04:47:56 INFO - 'LOGNAME': 'cltbld', 04:47:56 INFO - 'MAIL': '/var/mail/cltbld', 04:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:56 INFO - 'MOZ_NO_REMOTE': '1', 04:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:56 INFO - 'NO_EM_RESTART': '1', 04:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:56 INFO - 'PWD': '/builds/slave/test', 04:47:56 INFO - 'SHELL': '/bin/bash', 04:47:56 INFO - 'SHLVL': '1', 04:47:56 INFO - 'TERM': 'linux', 04:47:56 INFO - 'TMOUT': '86400', 04:47:56 INFO - 'USER': 'cltbld', 04:47:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:56 INFO - '_': '/tools/buildbot/bin/python'} 04:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:56 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:59 INFO - warning: no files found matching '*.txt' 04:47:59 INFO - no previously-included directories found matching 'build' 04:47:59 INFO - no previously-included directories found matching 'dist' 04:47:59 INFO - no previously-included directories found matching '.git*' 04:47:59 INFO - Installing collected packages: jsonschema, functools32 04:47:59 INFO - Running setup.py install for functools32 04:47:59 INFO - warning: no files found matching '*.txt' 04:47:59 INFO - no previously-included directories found matching 'build' 04:47:59 INFO - no previously-included directories found matching 'dist' 04:47:59 INFO - no previously-included directories found matching '.git*' 04:47:59 INFO - Successfully installed jsonschema functools32 04:47:59 INFO - Cleaning up... 04:47:59 INFO - Return code: 0 04:47:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:59 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:47:59 INFO - Using env: {'DISPLAY': ':0', 04:47:59 INFO - 'HOME': '/home/cltbld', 04:47:59 INFO - 'LANG': 'en_US.UTF-8', 04:47:59 INFO - 'LANGUAGE': 'en_US:en', 04:47:59 INFO - 'LOGNAME': 'cltbld', 04:47:59 INFO - 'MAIL': '/var/mail/cltbld', 04:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:59 INFO - 'MOZ_NO_REMOTE': '1', 04:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:59 INFO - 'NO_EM_RESTART': '1', 04:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:59 INFO - 'PWD': '/builds/slave/test', 04:47:59 INFO - 'SHELL': '/bin/bash', 04:47:59 INFO - 'SHLVL': '1', 04:47:59 INFO - 'TERM': 'linux', 04:47:59 INFO - 'TMOUT': '86400', 04:47:59 INFO - 'USER': 'cltbld', 04:47:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:59 INFO - '_': '/tools/buildbot/bin/python'} 04:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:47:59 INFO - Cleaning up... 04:47:59 INFO - Return code: 0 04:47:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:59 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:59 INFO - Using env: {'DISPLAY': ':0', 04:47:59 INFO - 'HOME': '/home/cltbld', 04:47:59 INFO - 'LANG': 'en_US.UTF-8', 04:47:59 INFO - 'LANGUAGE': 'en_US:en', 04:47:59 INFO - 'LOGNAME': 'cltbld', 04:47:59 INFO - 'MAIL': '/var/mail/cltbld', 04:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:59 INFO - 'MOZ_NO_REMOTE': '1', 04:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:59 INFO - 'NO_EM_RESTART': '1', 04:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:59 INFO - 'PWD': '/builds/slave/test', 04:47:59 INFO - 'SHELL': '/bin/bash', 04:47:59 INFO - 'SHLVL': '1', 04:47:59 INFO - 'TERM': 'linux', 04:47:59 INFO - 'TMOUT': '86400', 04:47:59 INFO - 'USER': 'cltbld', 04:47:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:59 INFO - '_': '/tools/buildbot/bin/python'} 04:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:48:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:48:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:02 INFO - Downloading docopt-0.6.1.tar.gz 04:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:48:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:48:02 INFO - Running setup.py install for blobuploader 04:48:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:48:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:48:02 INFO - Running setup.py install for requests 04:48:03 INFO - Running setup.py install for docopt 04:48:03 INFO - Successfully installed blobuploader requests docopt 04:48:03 INFO - Cleaning up... 04:48:03 INFO - Return code: 0 04:48:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:03 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:48:03 INFO - Using env: {'DISPLAY': ':0', 04:48:03 INFO - 'HOME': '/home/cltbld', 04:48:03 INFO - 'LANG': 'en_US.UTF-8', 04:48:03 INFO - 'LANGUAGE': 'en_US:en', 04:48:03 INFO - 'LOGNAME': 'cltbld', 04:48:03 INFO - 'MAIL': '/var/mail/cltbld', 04:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:03 INFO - 'MOZ_NO_REMOTE': '1', 04:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:03 INFO - 'NO_EM_RESTART': '1', 04:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:03 INFO - 'PWD': '/builds/slave/test', 04:48:03 INFO - 'SHELL': '/bin/bash', 04:48:03 INFO - 'SHLVL': '1', 04:48:03 INFO - 'TERM': 'linux', 04:48:03 INFO - 'TMOUT': '86400', 04:48:03 INFO - 'USER': 'cltbld', 04:48:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:03 INFO - '_': '/tools/buildbot/bin/python'} 04:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:03 INFO - Running setup.py (path:/tmp/pip-jy_5AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:03 INFO - Running setup.py (path:/tmp/pip-kmBAB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:03 INFO - Running setup.py (path:/tmp/pip-_ktrWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:03 INFO - Running setup.py (path:/tmp/pip-dG0DhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:03 INFO - Running setup.py (path:/tmp/pip-uouAs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:03 INFO - Running setup.py (path:/tmp/pip-tzjiTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:03 INFO - Running setup.py (path:/tmp/pip-iKNyDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:04 INFO - Running setup.py (path:/tmp/pip-5s78E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:04 INFO - Running setup.py (path:/tmp/pip-bgMKEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:04 INFO - Running setup.py (path:/tmp/pip-QMtfLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:04 INFO - Running setup.py (path:/tmp/pip-0k4EKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:04 INFO - Running setup.py (path:/tmp/pip-uKv2LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:04 INFO - Running setup.py (path:/tmp/pip-UXaAzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:04 INFO - Running setup.py (path:/tmp/pip-3a1BaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:04 INFO - Running setup.py (path:/tmp/pip-BEt7oI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:04 INFO - Running setup.py (path:/tmp/pip-RIMqsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:04 INFO - Running setup.py (path:/tmp/pip-X2v_rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:48:04 INFO - Running setup.py install for manifestparser 04:48:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:48:04 INFO - Running setup.py install for mozcrash 04:48:04 INFO - Running setup.py install for mozdebug 04:48:05 INFO - Running setup.py install for mozdevice 04:48:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Running setup.py install for mozfile 04:48:05 INFO - Running setup.py install for mozhttpd 04:48:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Running setup.py install for mozinfo 04:48:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Running setup.py install for mozInstall 04:48:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Running setup.py install for mozleak 04:48:05 INFO - Running setup.py install for mozlog 04:48:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Running setup.py install for moznetwork 04:48:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:48:05 INFO - Running setup.py install for mozprocess 04:48:06 INFO - Running setup.py install for mozprofile 04:48:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:48:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:48:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:48:06 INFO - Running setup.py install for mozrunner 04:48:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:48:06 INFO - Running setup.py install for mozscreenshot 04:48:06 INFO - Running setup.py install for moztest 04:48:06 INFO - Running setup.py install for mozversion 04:48:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:48:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:48:06 INFO - Cleaning up... 04:48:06 INFO - Return code: 0 04:48:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:06 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:48:06 INFO - Using env: {'DISPLAY': ':0', 04:48:06 INFO - 'HOME': '/home/cltbld', 04:48:06 INFO - 'LANG': 'en_US.UTF-8', 04:48:06 INFO - 'LANGUAGE': 'en_US:en', 04:48:06 INFO - 'LOGNAME': 'cltbld', 04:48:06 INFO - 'MAIL': '/var/mail/cltbld', 04:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:06 INFO - 'MOZ_NO_REMOTE': '1', 04:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:06 INFO - 'NO_EM_RESTART': '1', 04:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:06 INFO - 'PWD': '/builds/slave/test', 04:48:06 INFO - 'SHELL': '/bin/bash', 04:48:06 INFO - 'SHLVL': '1', 04:48:06 INFO - 'TERM': 'linux', 04:48:06 INFO - 'TMOUT': '86400', 04:48:06 INFO - 'USER': 'cltbld', 04:48:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:06 INFO - '_': '/tools/buildbot/bin/python'} 04:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:06 INFO - Running setup.py (path:/tmp/pip-pRAr3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:06 INFO - Running setup.py (path:/tmp/pip-81A6_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:06 INFO - Running setup.py (path:/tmp/pip-H22iKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:07 INFO - Running setup.py (path:/tmp/pip-AjolL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:07 INFO - Running setup.py (path:/tmp/pip-rloiz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:07 INFO - Running setup.py (path:/tmp/pip-zzdK5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:07 INFO - Running setup.py (path:/tmp/pip-IsKmwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:07 INFO - Running setup.py (path:/tmp/pip-GTuPmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:07 INFO - Running setup.py (path:/tmp/pip-9m28A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:07 INFO - Running setup.py (path:/tmp/pip-THX6NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:07 INFO - Running setup.py (path:/tmp/pip-HWNj6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:07 INFO - Running setup.py (path:/tmp/pip-28n6xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:07 INFO - Running setup.py (path:/tmp/pip-5fJ8BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:07 INFO - Running setup.py (path:/tmp/pip-fENuEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:07 INFO - Running setup.py (path:/tmp/pip-FYdKUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:07 INFO - Running setup.py (path:/tmp/pip-bthV7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:07 INFO - Running setup.py (path:/tmp/pip-mgtjb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:48:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:10 INFO - Downloading blessings-1.6.tar.gz 04:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:48:10 INFO - Installing collected packages: blessings 04:48:10 INFO - Running setup.py install for blessings 04:48:10 INFO - Successfully installed blessings 04:48:10 INFO - Cleaning up... 04:48:10 INFO - Return code: 0 04:48:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:10 INFO - Reading from file tmpfile_stdout 04:48:10 INFO - Current package versions: 04:48:10 INFO - argparse == 1.2.1 04:48:10 INFO - blessings == 1.6 04:48:10 INFO - blobuploader == 1.2.4 04:48:10 INFO - docopt == 0.6.1 04:48:10 INFO - functools32 == 3.2.3-2 04:48:10 INFO - jsonschema == 2.5.1 04:48:10 INFO - manifestparser == 1.1 04:48:10 INFO - mozInstall == 1.12 04:48:10 INFO - mozcrash == 1.0 04:48:10 INFO - mozdebug == 0.1 04:48:10 INFO - mozdevice == 0.49 04:48:10 INFO - mozfile == 1.2 04:48:10 INFO - mozhttpd == 0.7 04:48:10 INFO - mozinfo == 0.9 04:48:10 INFO - mozleak == 0.1 04:48:10 INFO - mozlog == 3.4 04:48:10 INFO - moznetwork == 0.27 04:48:10 INFO - mozprocess == 0.25 04:48:10 INFO - mozprofile == 0.28 04:48:10 INFO - mozrunner == 6.13 04:48:10 INFO - mozscreenshot == 0.1 04:48:10 INFO - mozsystemmonitor == 0.3 04:48:10 INFO - moztest == 0.8 04:48:10 INFO - mozversion == 1.4 04:48:10 INFO - psutil == 3.1.1 04:48:10 INFO - requests == 1.2.3 04:48:10 INFO - wsgiref == 0.1.2 04:48:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48: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')]} 04:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48: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')]} 04:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:10 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 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:48:10 INFO - Using env: {'DISPLAY': ':0', 04:48:10 INFO - 'HOME': '/home/cltbld', 04:48:10 INFO - 'LANG': 'en_US.UTF-8', 04:48:10 INFO - 'LANGUAGE': 'en_US:en', 04:48:10 INFO - 'LOGNAME': 'cltbld', 04:48:10 INFO - 'MAIL': '/var/mail/cltbld', 04:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:10 INFO - 'MOZ_NO_REMOTE': '1', 04:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:10 INFO - 'NO_EM_RESTART': '1', 04:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:10 INFO - 'PWD': '/builds/slave/test', 04:48:10 INFO - 'SHELL': '/bin/bash', 04:48:10 INFO - 'SHLVL': '1', 04:48:10 INFO - 'TERM': 'linux', 04:48:10 INFO - 'TMOUT': '86400', 04:48:10 INFO - 'USER': 'cltbld', 04:48:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:10 INFO - '_': '/tools/buildbot/bin/python'} 04:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:48:10 INFO - Cleaning up... 04:48:10 INFO - Return code: 0 04:48:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:48: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')]} 04:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48: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')]} 04:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:48: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'] in /builds/slave/test/build 04:48: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 04:48:10 INFO - Using env: {'DISPLAY': ':0', 04:48:10 INFO - 'HOME': '/home/cltbld', 04:48:10 INFO - 'LANG': 'en_US.UTF-8', 04:48:10 INFO - 'LANGUAGE': 'en_US:en', 04:48:10 INFO - 'LOGNAME': 'cltbld', 04:48:10 INFO - 'MAIL': '/var/mail/cltbld', 04:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:10 INFO - 'MOZ_NO_REMOTE': '1', 04:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:10 INFO - 'NO_EM_RESTART': '1', 04:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:10 INFO - 'PWD': '/builds/slave/test', 04:48:10 INFO - 'SHELL': '/bin/bash', 04:48:10 INFO - 'SHLVL': '1', 04:48:10 INFO - 'TERM': 'linux', 04:48:10 INFO - 'TMOUT': '86400', 04:48:10 INFO - 'USER': 'cltbld', 04:48:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:10 INFO - '_': '/tools/buildbot/bin/python'} 04:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:48:10 INFO - Cleaning up... 04:48:11 INFO - Return code: 0 04:48:11 INFO - Running post-action listener: _resource_record_post_action 04:48:11 INFO - Running post-action listener: _start_resource_monitoring 04:48:11 INFO - Starting resource monitoring. 04:48:11 INFO - [mozharness: 2017-03-28 11:48:11.036071Z] Finished create-virtualenv step (success) 04:48:11 INFO - [mozharness: 2017-03-28 11:48:11.036588Z] Running install step. 04:48:11 INFO - Running pre-action listener: _resource_record_pre_action 04:48:11 INFO - Running main action method: install 04:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:11 INFO - Reading from file tmpfile_stdout 04:48:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:48:11 INFO - Reading from file tmpfile_stdout 04:48:11 INFO - Output received: 04:48:11 INFO - Usage: mozinstall [options] installer 04:48:11 INFO - Options: 04:48:11 INFO - -h, --help show this help message and exit 04:48:11 INFO - -d DEST, --destination=DEST 04:48:11 INFO - Directory to install application into. [default: 04:48:11 INFO - "/builds/slave/test"] 04:48:11 INFO - --app=APP Application being installed. [default: firefox] 04:48:11 INFO - mkdir: /builds/slave/test/build/application 04:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:48:27 INFO - Reading from file tmpfile_stdout 04:48:27 INFO - Output received: 04:48:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:48:27 INFO - Running post-action listener: _resource_record_post_action 04:48:27 INFO - [mozharness: 2017-03-28 11:48:27.392100Z] Finished install step (success) 04:48:27 INFO - [mozharness: 2017-03-28 11:48:27.392379Z] Running run-tests step. 04:48:27 INFO - Running pre-action listener: _resource_record_pre_action 04:48:27 INFO - Running main action method: run_tests 04:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:48:27 INFO - Python 2.7.3 04:48:27 INFO - Return code: 0 04:48:27 INFO - grabbing minidump binary from tooltool 04:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:27 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 0x2cc1400>, '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 0x2cc23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:48:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:48:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:48:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:48:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:48:27 INFO - Return code: 0 04:48:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:48:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:48:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:48:27 INFO - ENV: RUST_BACKTRACE is now 1 04:48:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:48:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:48:27 INFO - Using env: {'DISPLAY': ':0', 04:48:27 INFO - 'HOME': '/home/cltbld', 04:48:27 INFO - 'LANG': 'en_US.UTF-8', 04:48:27 INFO - 'LANGUAGE': 'en_US:en', 04:48:27 INFO - 'LOGNAME': 'cltbld', 04:48:27 INFO - 'MAIL': '/var/mail/cltbld', 04:48:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:48:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:27 INFO - 'MOZ_NO_REMOTE': '1', 04:48:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:27 INFO - 'NO_EM_RESTART': '1', 04:48:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:27 INFO - 'PWD': '/builds/slave/test', 04:48:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:48:27 INFO - 'RUST_BACKTRACE': '1', 04:48:27 INFO - 'SHELL': '/bin/bash', 04:48:27 INFO - 'SHLVL': '1', 04:48:27 INFO - 'TERM': 'linux', 04:48:27 INFO - 'TMOUT': '86400', 04:48:27 INFO - 'USER': 'cltbld', 04:48:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810', 04:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:27 INFO - '_': '/tools/buildbot/bin/python'} 04:48:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:48:27 INFO - mozversion application_buildid: 20170328110348 04:48:27 INFO - mozversion application_changeset: d4af7ec6cfcd9b81cd1f433a00b412de61e95b62 04:48:27 INFO - mozversion application_display_name: Nightly 04:48:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:48:27 INFO - mozversion application_name: Firefox 04:48:27 INFO - mozversion application_remotingname: firefox 04:48:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:48:27 INFO - mozversion application_vendor: Mozilla 04:48:27 INFO - mozversion application_version: 55.0a1 04:48:27 INFO - mozversion platform_buildid: 20170328110348 04:48:27 INFO - mozversion platform_changeset: d4af7ec6cfcd9b81cd1f433a00b412de61e95b62 04:48:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:48:27 INFO - mozversion platform_version: 55.0a1 04:48:27 INFO - using testdate: 1490701707 04:48:27 INFO - actual date: 1490701707 04:48:27 INFO - starting webserver on 'localhost:58416' 04:48:27 INFO - SUITE-START | Running 2 tests 04:48:27 INFO - TEST-START | dromaeo_css 04:48:27 INFO - operating with platform_type : linux_ 04:48:27 INFO - Initialising browser for dromaeo_css test... 04:48:27 INFO - TEST-INFO | started process 14540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkSECUr/profile http://localhost:58416/getInfo.html) 04:48:32 INFO - PID 14540 | __metrics Screen width/height:1600/1200 04:48:32 INFO - PID 14540 | colorDepth:24 04:48:32 INFO - PID 14540 | Browser inner width/height: 1024/697 04:48:32 INFO - PID 14540 | __metrics 04:48:33 ERROR - PID 14540 | 1490701713168 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 04:48:33 INFO - PID 14540 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:48:33 INFO - PID 14540 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:48:34 INFO - TEST-INFO | 14540: exit 0 04:48:34 INFO - Browser initialized. 04:48:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:48:34 INFO - TEST-INFO | started process 14638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkSECUr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:46 INFO - PID 14638 | RSS: Main: 168083456 04:48:46 INFO - PID 14638 | 04:51:53 INFO - PID 14638 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58416/tests/dromaeo/cssquery-ext.html) 04:51:54 INFO - PID 14638 | RSS: Main: 311001088 04:51:54 INFO - PID 14638 | 04:53:36 INFO - PID 14638 | ************************* 04:53:36 INFO - PID 14638 | A coding exception was thrown and uncaught in a Task. 04:53:36 INFO - PID 14638 | 04:53:36 ERROR - PID 14638 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:53:36 INFO - PID 14638 | Full stack: 04:53:36 INFO - PID 14638 | ************************* 04:53:36 INFO - PID 14638 | ************************* 04:53:36 INFO - PID 14638 | A coding exception was thrown and uncaught in a Task. 04:53:36 INFO - PID 14638 | 04:53:36 ERROR - PID 14638 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:53:36 INFO - PID 14638 | Full stack: 04:53:36 INFO - PID 14638 | ************************* 04:53:36 INFO - PID 14638 | ************************* 04:53:36 INFO - PID 14638 | A coding exception was thrown and uncaught in a Task. 04:53:36 INFO - PID 14638 | 04:53:36 ERROR - PID 14638 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:53:36 INFO - PID 14638 | Full stack: 04:53:36 INFO - PID 14638 | ************************* 04:53:36 INFO - PID 14638 | ************************* 04:53:36 INFO - PID 14638 | A coding exception was thrown and uncaught in a Task. 04:53:36 INFO - PID 14638 | 04:53:36 ERROR - PID 14638 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:53:36 INFO - PID 14638 | Full stack: 04:53:36 INFO - PID 14638 | ************************* 04:54:57 INFO - PID 14638 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-ext.html (next: http://localhost:58416/tests/dromaeo/cssquery-jquery.html) 04:54:58 INFO - PID 14638 | RSS: Main: 256774144 04:54:58 INFO - PID 14638 | 04:58:00 INFO - PID 14638 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58416/tests/dromaeo/cssquery-mootools.html) 04:58:01 INFO - PID 14638 | RSS: Main: 205070336 04:58:01 INFO - PID 14638 | 05:01:03 INFO - PID 14638 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58416/tests/dromaeo/cssquery-prototype.html) 05:01:04 INFO - PID 14638 | RSS: Main: 205955072 05:01:04 INFO - PID 14638 | 05:04:07 INFO - PID 14638 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58416/tests/dromaeo/cssquery-yui.html) 05:04:08 INFO - PID 14638 | RSS: Main: 215543808 05:04:08 INFO - PID 14638 | 05:07:10 INFO - PID 14638 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-yui.html (next: http://localhost:58416/tests/dromaeo/cssquery-dojo.html) 05:07:11 INFO - PID 14638 | RSS: Main: 306507776 05:07:11 INFO - PID 14638 | 05:07:11 INFO - PID 14638 | __start_tp_report 05:07:11 INFO - PID 14638 | _x_x_mozilla_page_load 05:07:11 INFO - PID 14638 | _x_x_mozilla_page_load_details 05:07:11 INFO - PID 14638 | |i|pagename|runs| 05:07:11 INFO - PID 14638 | |0;dojo.html;2703.553913604255;2710.2817753295367;2747.162115554755;2748.2717079973822;2766.7786577073834;5016.949830501694;5142.228665700147;5193.870153246166;5198;5219;5092.312537807404;5105.974470127653;5130.769115389807;5132.846014619558;5148.227765835127;4637.65217608679;4673.228917228653;4694.483606803249;4715.952840471586;4748;4731.7634118293945;4751.263554149113;4772.832950846721;4803.327534145223;4850.830220942268;4763.428388593374;4772.093302272575;4786.760661966888;4789.066132104241;4833.806647734104;4618.976905115486;4629.467611224685;4743.644226683013;4748.810047598109;4759.595434388081;4686.250199968023;4692.671512994092;4714.245720684708;4734.502877197879;4739.526047395233;5079.466656001104;5081.034603425374;5086.338775959139;5087.440381558025;5128.102582048126;5386.165144402585;5544.16837474378;5546.86132846678;5604.887902241932;5607.299087614048;5517.889642207174;5604.887902241973;5697.914531282034;5730.169125476783;5745.109508026263;5239.607029472805;5245.842624721265;5252.185911183773;5252.684838909601;5263.605229607795;5783.306003279633;5805.448482394166;5806.622569533051;5810.593258471867;5864.06175011996;5295.364556253275;5425.83722488326;5426.131818909034;5436.592255580847;5552.861178470571;5362.678239305654;5659.773609055674;5660.490555849911;5688.914666280009;5715.428457154251;5443.972780136153;5455.536279416294;5545.112781954868;5581.10702287632;5583.218349431083;5579.46995035471;5583.05088135018;5604.187392828017;5615.943840561624;5650.7739690412745;4577.931331030038;4624.953750462452;4633.837815676435;4770.379850619397;4772.7136371817105;3999.320115580358;4048.129652124748;4069.064115253508;4074.4499492568125;4099.3031184698075;4754.738489383117;4766;4766.547178018082;4789.736564488987;4808.3989501312335;5642.548596112301;5646.689432081275;5651.4348565143155;5653.773849045992;5690.971545142331;4624.121416930772;4693.155232058194;4695.624350051988;4762.64280178988;4857.951420485821;4926.33494478248;5033.748312584356;5102.872428189251;5104.259882317117;5104.387473503203;5227.477252274742;5240.5807535397835;5242.135047717084;5245.790168393221;5247.134222853339;5626.212330273683;5657.377688454185;5677.829665110054;5687.146927960839;5689.516391106802;5047.1419858623385;5106.080905437057;5111.974440127776;5174.068667639711;5211.530962213419;5588.832335029955;5589.860253493695;5591.524720398812;5612.803551875665;5642.238297829905;5653.321601407857;5655.4910058094965;5656.406077361818;5656.406077361818;5656.85857853557;5172.870678233075;5224.346956630421;5254.632175747814;5501.257330260523;5510.6969116698965;5322.254884316121;5338.3060202173465;5351.010063138332;5353.625246232727;5365.839024829262;5282.683039017517;5296.152615581488;5338.958903013875;5406.729663516887;5417.783288668409;5543.5010849022165;5543.77824887;5544.473275039026;5548;5563.888722225452;5149.279100925798;5151.845444636667;5152.27868098474;5153.45888681683;5198.948010519846 05:07:11 INFO - PID 14638 | |1;ext.html;582.8659408336083;641.7433026789283;656.7340227207981;1072.0940805019757;1077.9299345542534;24488.632670509935;30987;31143.532847007256;31208;31327.373452530963;31677.208069798267;31796.523052154236;31809;31911;32078.679213207863;5080.517350851682;5126.641135120543;7047.85904281914;7192.856142877139;7195;6976.755813546527;7094.964525177367;7100.147982242138;7108.715651373939;7110;7095.113110861143;7102.183248926388;7150.928490715104;7172.139343278814;7192.31672991065;7080.398166155857;7134.607596582186;7144.85710285794;7165.605891675956;7190.28097190282;7014.579125252501;7259.89110163348;7265.89101163483;7268.745593904188;7273.8545229095125;32696.182595435068;32955.34089318224;33001.00996970095;33024;33083.6691633083;2633.091583403742;2658.255688407249;2659.4149287156793;2677.290518012728;2711.7288271172924;23227;23314.300570982898;23515.7648423517;23873.76126238733;24215.273541793773;2534.721180670125;2593.818432709711;2594.805389595788;2614;2616.856072915989;149861;150337.9999999989;150363;150791;150828;42151.15697686029;42326.36510452346;42437;42438.78780606077;42484.57515424868;44746.55253447489;44768;44817.551824481336;44860.3270950936;44907;12683.23900565969;13056.934715326552;13070.477180912847;13076.215427074216;13084.28036458004;8776.912230877737;8868;9826.361286516496;10494.42280674555;10546.419946902994;12595.559155429515;12603.306818124907;12639.1784534005;12675.302858342695;12763.489460421479;5036.6726162799305;5043.319151914445;5079.187330027178;5082.415522214993;5137.588992880561;841.7937605286621;858.9785255368665;892.7723430525175;898.8831451911341;912.0788004115891;18680.626387472174;18843.340483083026;19484.80515194858;19575.902120489307;19930.601387972158;957.5212393803098;961.274237950343;964.9710508684751;965.9951700241594;977.2768151567789;12834.743305133845;13705.73855313862;13720.588382348546;13829.654258643614;13933.58199254024;167665;167671;168054;168093;168324;38190.23619527594;38248.087595620666;38276.42585361222;38311.80844095762;38399.42400863989;1215.7629262293945;1255.8932490738207;1256.8437037925314;1263.418827339434;1266.65167079054;21968.45078872977;22156.34716709509;22810.42973925665;22968.425789354733;23050.884745576164;29084.709152909047;29136.7086329134;29230.123096307147;29248.56127158137;29275.268118297212;196463;196587;196732;197060;197438;21506.67739983933;21772.564548709255;26373.208803735917;29245.268868278465;29381.559276611297;36809;36929.63070369262;36941;37256.62743372531;37882.81058594689;28094.297642558282;30376.392472150874;30393.240168995068;30517.389652206388;31176.220594484414;29945;30229.243496462026;31102.844485777427;31652.36695266128;31851.20371990626;32353;32923;33017.33965320632;33107;33386;27357.72642273552;27372.45255094847;27531.17406477809;27597.31006724848;28427.857860710563;22657.546849062597;23675;23759.52480950406;23840.880795596604;24099.879500602387 05:07:11 INFO - PID 14638 | |2;jquery.html;424.2412608219914;426.41155205815977;432.312622929542;440.27794417155866;447.26201767084285;16795.1602419879;16994.660106797855;17050.658986820257;17473.126343682798;17631.559211019732;17693.292268309284;17792.46622601324;17984.73022904654;18030.18864151113;18069.81930180698;5395.676259424427;5533.22534845121;5579.163125531162;5619.353774315945;5746.109353050284;5656.2364080849175;5672.659640421588;5676.943230567683;5676.943230567704;5683.488486036256;5433.402325744165;5532.806351777688;5564.304461942257;5628.915566266509;5652.717364131798;5666.065099258617;5683.715814209294;5724.341700704389;5728.283964504437;5731.684757338366;5027.924581131286;5137.229415587654;5143.639945203838;5143.717095559743;5145.125328694131;21393.893030534902;22430;22479.775202247933;22595.887020564955;22788.4677874928;1540.2375823967095;1558.8908776385658;1571.7642353647045;1603.070219272819;1605.727026405514;12196.14626976112;13188.736225275537;13241.536546220932;13522.12106213093;13832.446702131903;1735.6181640039297;1750.9737353939702;1796.9281228750833;1799.9640007199914;1816.4096668582763;88956;90128;90591;91043.08956910412;93443.06556934412;10661.893381066246;10866.67399978002;11045.558177672963;11096.778064438828;11176.944115279372;15307.693846123015;15345.462908798361;15353;15357;15372.846271537364;7463.141738700119;7701.884471732928;7714.382849372037;7845.646945887449;7924.405669574805;7127.859542473179;7170.282971702893;7329.816754581178;7361.779146625609;7412.703491860373;6786.389224969677;6816.318368163144;6831.248562658104;6921.861562768717;6955.791326260221;2053.3429302623017;2054.41449186984;2089.822365098953;2091.623507768586;2214.136486770161;838.153465000354;884.9247813935759;889.8665200220019;899.1233547291339;904.3488688144525;15812.92093539525;16329.510114696579;16861.156942153088;16882;16942.23759930806;865.8138500222483;888.7289376740156;899.6446403670514;904.3353135445442;910.0671811393242;8365.562384450157;8600.397972142015;8799.208071273617;9000.684976025808;9174.908250917406;459393;460943;462736;470657;474795;93823;94065.5296723512;98161;98340.26555751046;98622;1069.9732506687394;1117.2179474367974;1135.5003798328873;1138.0383575878534;1142.8000099982637;14012.299385030912;14161.645958851112;14179.858201417854;14246.928765356108;15013.174275414956;42352.78823605862;42358.15283694247;42763;43172.352414714434;44107.55892441035;56935.71532142313;58007.709961449924;58255;59058.704706476194;59655.70172149112;6883.724651013903;6889.379955804002;8028.518288902685;8254.752357429286;8266.958665206635;12102;12411.689707757378;12703.555375561811;12763.553275635308;13059.477620895437;9306.441613503212;9420.434773913586;9775.560099795668;10979.725506862073;11017.338959662446;9958.800823983625;9996.600135994478;10032.448215348226;10047.547860346156;10230.59077636916;10930.344179348946;10990.780184396428;11068.889311106786;11180.652063066847;11516.654500365003;7674.155842857393;7943.44395892282;7944.656326383615;8017.238362355567;8185.345172386314;10510.842337364793;10631.20265980039;10686.839697404701;10818;10915.23593348458 05:07:11 INFO - PID 14638 | |3;mootools.html;1119.5745616665665;1245.6636708088813;1299.603620895627;1324.3973991833716;1324.8410190777106;7924.128345881955;8994.4153630014;9149.90850091498;9210.861837072449;9213.309001824857;9050.637974481013;9145.359824812265;9156;9467.90532094679;9484.383515071533;1812.954676133094;2164.2641501889393;2206.944826379345;2212.9557408851815;2214.534947660985;1922.202286051287;2168.2844661261747;2211.6903633491324;2224.833137514685;2230.2194232018824;2166.978330216701;2168.6313326734494;2192.440927563469;2195.560887822434;2195.9451013724624;1797.9640407191914;1862.2178684952353;2119.34300366886;2124.4901223706197;2125.0968338456173;2097.800708932649;2174.945626359338;2175.0973346061364;2183.8908054597205;2184.1263494602126;9151.862722059175;9237.261019118454;9239.16847483723;9250.953745231298;9277.907220927771;5182.222666600002;5370.973145134289;5382.434844341366;5388.649737767033;5392.164214546751;2967.896123635662;3133.27934575049;3202.247471844115;3204.3270913108277;3208.598925134358;938.4047119896136;1044.5195210203315;1069.310294859819;1074.8280275156017;1088.2110469909253;14230.573082807532;14291.785623215661;14297.142171469744;14308.570742877626;14312.284385780773;4793.856184314476;4963.329950456642;5008;5067.619928505377;5113.284140220372;10553.525091370906;10630.681079567625;10637.893621063846;10642.25504214713;10654.680359589225;5251.10731175701;5252.028374750607;5253.080710875582;5259.921101183485;5269.841904742864;4819.59033482151;4932.802687892444;5056.443791182967;5076.086304465158;5134.974325128351;3499.9650003500146;3655;3685.617893290016;3693.298273328059;3693.981530092386;1086.4893500054961;1096.4079397125463;1101.5924108080062;1115.2806439846254;1126.1947707389256;674.6087269383746;690.2028157478121;697.1738489889395;705.3792662457005;723.735836419703;5171.3535808024;5172.27588137661;5247.475252474722;5269.604779641466;5304.38999515053;533.3493138371181;543.2042058384486;549.7416214379235;555.1561626327959;570.6633086478997;3184.172115250052;3353.5305057292;3445.776024558396;3543.114221444639;3636.9818150909077;11755.88244117565;12299;12306;12346.974991127232;12355.135140540257;11798.941005294919;12011.819822702666;12234.81647775284;12260.44827982743;12278.631641050782;8948.194662480408;9085.454872707658;9087.636494540277;9091.681791137411;9096.8635470468;5326.467353264643;5336.946630533645;5403.8108666196495;5429.809956651498;5509.201165830852;10732.14142868553;10769.461526923465;10777.46112694378;10795.946020269848;10825.891741082803;11119.221654484109;11126.721831954266;11191.104711623213;11220;11285;7216.097987751531;7307.634618269171;7331.560106393634;7332.41340692754;7333.596652184181;8721.694740684046;8724.43291186071;8819.559022049;8898.599563019809;8912.598933047899;7520.586367749607;7559.886601700869;7614.466987311057;7678.1937896522295;7684.385249179941;7342.889856652261;7485.288897554724;7487.737929172453;7488.213737557696;7602.6198690066385;6479.708413121515;6529.5102867284195;6542.509311801729;6545.083688283549;6582.440492558187;4961.231009193581;5039.899202016012;5063.240513922941;5124.8206312778875;5128.923066153936;5035.84892453227;5104.336436263262;5105.566026887756;5162.612804039637;5179.896402072013 05:07:11 INFO - PID 14638 | |4;prototype.html;397.0530285269631;399.40289267545023;401.8211895706411;403.63067792969434;407.37264612496756;5360.517553420192;5429.809956651513;5483.341998960121;5525.281713377265;5530.5022547970675;4815.638827087965;5301.595077304517;5304.681719096847;5390.6226564140525;5435.42927992561;4281.079567892903;4282.42187304713;4285.44289242398;4302.612764851163;4313.396124542566;4290.849820256291;4296.957030429687;4297.763623000734;4301.935470967922;4321.308590625501;4202.873913782591;4252.277112890816;4258.574142585748;4299.839043458264;4312.870613881589;4211.7472951623;4241.34259189823;4251.489821221442;4263.850765223202;4288.76411797351;3835.6547910688173;3849.480320156771;3855.7879316637573;3864.53625564934;3891.6497515223764;4963.60291176705;5169.741512924339;5171.974140129313;5188.351456067991;5196.662216955886;4951.727654978975;4974.9751251243515;4979.427365852901;4980.850574482735;4998.075356059141;5667.404922483162;5667.8583035424035;5670.68811215383;5671.971640141773;5674.687892165929;3823.1397935464574;4252.255855225354;4272.487301523837;4273.3162693969125;4297.462817147856;5652.802151924663;5810.244668193108;5834.854128646775;5877.206577112078;6025.698715064229;4082.4284600156;4108.4864391951005;4136.544980052192;4138.751674899516;4146.232946904832;4176.874693759192;4189.643880270211;4191.161767646483;4200.327947528381;4205.894852628709;4408.338749187647;4468.486124095771;4537.75042372666;4555.977220113945;4600.97699511507;5639.774409023593;5642.492175704207;5666.490015898589;5685.459881311269;5688.630239034533;1422.7994943360723;1430.5851303121979;1442.473497173524;1448.9422721413428;1455.3990610328765;957.6025949231131;974.6491263145263;982.1357205658975;982.7543114221445;987.76293689514;4957.82647607332;4961.826336078292;4976.800927962913;4979.4771548987555;4979.551840334315;5877.647341159544;5881.558883083786;5893.528517718572;5895.317630478122;5923.437273459014;4814.350062741555;4900.705957642553;4901.554041557749;4927.457979622239;4972.751362431936;3077.6768439313996;3102.472579661463;3108.9067327980197;3112.474887305204;3128.1397615655424;5210.869728256748;5470.753816078286;5476.698781566973;5500.87232117415;5504.80733174337;6069.388713715332;6079.604825686316;6084.756609735649;6108.35862234459;6112.480439162632;5488.670679759148;5492.423295553909;5502.58730595207;5529.502344788908;5539.390667026543;5742.224799651994;5895.469407753323;5896.611872191769;5910.852228694317;5956.463918247206;5794.449527294901;5817.621854579439;5824.301083869963;5825.854353641193;5844.853878653068;5188.9740551297;5226.0815846633905;5360.919586206288;5382.811601594082;5491.039068163135;4021.3565829467143;4094.877153685394;4124.381342798604;4131.814068366871;4134.297169481256;5867.442592953663;5881.500072493886;5889.852753681193;5902.026165682614;5906.379830117776;5431.321084864392;5712.628679136009;5726.112452569859;5726.484616384545;5749.655020698771;5701.173329867229;5722.656640601577;5726.427357264407;5733.598648094593;5744.0522313817755;5378.327709036371;5580.9071598150695;5622.943770562242;5643.746031428514;5686.658800471985;5733.4266573344;5750.424957504216;5754.741036653444;5778.624389414675;5781.248437703071;5310.442403547572;5315.946840531546;5329.493698098674;5335.466453354634;5337.599680023936 05:07:11 INFO - PID 14638 | |5;yui.html;668.5186665600767;692.3734020711258;704.9295070492948;706.6572712234562;732.3372348025036;10814.080803131734;11113.833292500609;11115.777684446317;11413.771724565504;11453.427328633556;11380.487878045487;11409.37248451335;11716.355600441972;11777.470013849375;11846.111541634391;813.7070654564367;831.4470876866907;835.4987007795335;835.5738573327616;835.9122292159327;814.5112932240638;830.4145577367972;836.3643630840544;838.2623291503469;840.0675250471971;878.97802554936;880.7665968518347;881.2465342132481;881.5107615273521;881.8633111867639;875.5053394831963;877.662100091463;878.2447095497898;880.6697488441835;880.9779755506131;650.8503044299838;652.100101859431;652.719330687804;652.8694261147789;653.121551513214;11516.25144365622;11517.25137866036;11555;11606.24559403636;11816.231944923553;13520.93239533796;13721.656958576015;13867.791983120262;13957.651058723512;14073.437062517487;10167.440790756506;10474.895251047468;10557.366558006544;10770.192235582363;10853.945730271376;2572.0611976628397;2598.8180827342094;2602.323395917056;2635.9472810543875;2637.07702304192;65474.3452565473;66990.33009669889;67615;67873.3212667877;68689.3131068688;10760.677179684622;10929.398883061349;10967.287126336922;11085.334879907232;11085.785122314599;22763.08947642109;22789.430264243194;22796.316110516713;22797.316080517612;22804.657930131063;6156.29202641693;6240.963615152214;6351.047342898602;6354.682265886687;6375.0437434384285;3132.7807053506035;3218.3563287342627;3222.758293128025;3241.1410976091356;3299.785513941586;3462.2210002749684;3531.4173161428075;3536.5932917714276;3690.2988432197794;3903.6486716195677;697.2051860878603;700.166801506206;700.2332445971653;716.8136284565946;723.1791916175074;528.2155998342458;549.9807506737245;556.5408537956122;562.5752556819575;565.9434056594307;8355.289800367036;8466.830663386698;8475.203182949612;8546.273566746771;8629.352798540134;523.3544432891769;547.4716898193262;548.9086580129718;553.2199598566002;555.5250261026764;3648.927021459556;3850.537935447708;3958.089639382958;3989.122393073519;4092.46797916269;60971.390286097456;61978.703194521186;62884.37115628785;65203.347966520676;65330;39789.40315895264;40085;48517.27224091641;50434.747826261366;50467.49532504701;40982.1803563927;44207.55792442099;48326.75836620865;48340.758296208296;48522;8914.465132092095;9457.858132128162;9478.146966773023;9546.236301096034;9568.521573921136;24302.878485608166;24708.505829882943;24779.628305575072;25382.746172538038;25457.49085018326;29497;40140;42029;42222.57777422186;43146.13707725891;11553.30680159193;11657.475413606238;11762.94118529402;11912.52349905994;12443.315617641116;11952.392509199999;12382.318972456602;12408.81386779181;12704;12741.299228542519;11634.6509604712;11787.248231962656;11789.115816313639;12048.578299759467;12068.577599783965;11542.365169915734;11747.118966077407;11808.468618911998;11953.581624643095;12343.485575610854;10743.355398676105;10993.450327483433;11047.392393418439;11064.22550421495;11178.217524773188;7905.683772649029;8192.713255036046;8289.709860154866;8297.543635100128;8506.74479765608;8894.42186257891;9333.906660933304;9432.952835236054;9434.952825236105;9443.858342124737 05:07:11 INFO - PID 14638 | __end_tp_report 05:07:11 INFO - PID 14638 | __start_cc_report 05:07:11 INFO - PID 14638 | _x_x_mozilla_cycle_collect,1594 05:07:11 INFO - PID 14638 | __end_cc_report 05:07:11 INFO - PID 14638 | __startTimestamp1490702831172__endTimestamp 05:07:11 INFO - PID 14638 | 05:07:11 INFO - PID 14638 | ------- Summary: start ------- 05:07:11 INFO - PID 14638 | Number of tests: 6 05:07:11 INFO - PID 14638 | 05:07:11 INFO - PID 14638 | [#0] dojo.html Cycles:165 Average:5127.36 Median:5227.48 stddev:587.07 (11.2%) stddev-sans-first:557.23 05:07:11 INFO - PID 14638 | Values: 2703.6 2710.3 2747.2 2748.3 2766.8 5016.9 5142.2 5193.9 5198.0 5219.0 5092.3 5106.0 5130.8 5132.8 5148.2 4637.7 4673.2 4694.5 4716.0 4748.0 4731.8 4751.3 4772.8 4803.3 4850.8 4763.4 4772.1 4786.8 4789.1 4833.8 4619.0 4629.5 4743.6 4748.8 4759.6 4686.3 4692.7 4714.2 4734.5 4739.5 5079.5 5081.0 5086.3 5087.4 5128.1 5386.2 5544.2 5546.9 5604.9 5607.3 5517.9 5604.9 5697.9 5730.2 5745.1 5239.6 5245.8 5252.2 5252.7 5263.6 5783.3 5805.4 5806.6 5810.6 5864.1 5295.4 5425.8 5426.1 5436.6 5552.9 5362.7 5659.8 5660.5 5688.9 5715.4 5444.0 5455.5 5545.1 5581.1 5583.2 5579.5 5583.1 5604.2 5615.9 5650.8 4577.9 4625.0 4633.8 4770.4 4772.7 3999.3 4048.1 4069.1 4074.4 4099.3 4754.7 4766.0 4766.5 4789.7 4808.4 5642.5 5646.7 5651.4 5653.8 5691.0 4624.1 4693.2 4695.6 4762.6 4858.0 4926.3 5033.7 5102.9 5104.3 5104.4 5227.5 5240.6 5242.1 5245.8 5247.1 5626.2 5657.4 5677.8 5687.1 5689.5 5047.1 5106.1 5112.0 5174.1 5211.5 5588.8 5589.9 5591.5 5612.8 5642.2 5653.3 5655.5 5656.4 5656.4 5656.9 5172.9 5224.3 5254.6 5501.3 5510.7 5322.3 5338.3 5351.0 5353.6 5365.8 5282.7 5296.2 5339.0 5406.7 5417.8 5543.5 5543.8 5544.5 5548.0 5563.9 5149.3 5151.8 5152.3 5153.5 5198.9 05:07:11 INFO - PID 14638 | 05:07:11 INFO - PID 14638 | [#1] ext.html Cycles:180 Average:31563.75 Median:30752.19 stddev:44694.88 (145.3%) stddev-sans-first:44759.72 05:07:11 INFO - PID 14638 | Values: 582.9 641.7 656.7 1072.1 1077.9 24488.6 30987.0 31143.5 31208.0 31327.4 31677.2 31796.5 31809.0 31911.0 32078.7 5080.5 5126.6 7047.9 7192.9 7195.0 6976.8 7095.0 7100.1 7108.7 7110.0 7095.1 7102.2 7150.9 7172.1 7192.3 7080.4 7134.6 7144.9 7165.6 7190.3 7014.6 7259.9 7265.9 7268.7 7273.9 32696.2 32955.3 33001.0 33024.0 33083.7 2633.1 2658.3 2659.4 2677.3 2711.7 23227.0 23314.3 23515.8 23873.8 24215.3 2534.7 2593.8 2594.8 2614.0 2616.9 149861.0 150338.0 150363.0 150791.0 150828.0 42151.2 42326.4 42437.0 42438.8 42484.6 44746.6 44768.0 44817.6 44860.3 44907.0 12683.2 13056.9 13070.5 13076.2 13084.3 8776.9 8868.0 9826.4 10494.4 10546.4 12595.6 12603.3 12639.2 12675.3 12763.5 5036.7 5043.3 5079.2 5082.4 5137.6 841.8 859.0 892.8 898.9 912.1 18680.6 18843.3 19484.8 19575.9 19930.6 957.5 961.3 965.0 966.0 977.3 12834.7 13705.7 13720.6 13829.7 13933.6 167665.0 167671.0 168054.0 168093.0 168324.0 38190.2 38248.1 38276.4 38311.8 38399.4 1215.8 1255.9 1256.8 1263.4 1266.7 21968.5 22156.3 22810.4 22968.4 23050.9 29084.7 29136.7 29230.1 29248.6 29275.3 196463.0 196587.0 196732.0 197060.0 197438.0 21506.7 21772.6 26373.2 29245.3 29381.6 36809.0 36929.6 36941.0 37256.6 37882.8 28094.3 30376.4 30393.2 30517.4 31176.2 29945.0 30229.2 31102.8 31652.4 31851.2 32353.0 32923.0 33017.3 33107.0 33386.0 27357.7 27372.5 27531.2 27597.3 28427.9 22657.5 23675.0 23759.5 23840.9 24099.9 05:07:11 INFO - PID 14638 | 05:07:11 INFO - PID 14638 | [#2] jquery.html Cycles:180 Average:28323.04 Median:460168.00 stddev:77339.65 (16.8%) stddev-sans-first:77528.24 05:07:11 INFO - PID 14638 | Values: 424.2 426.4 432.3 440.3 447.3 16795.2 16994.7 17050.7 17473.1 17631.6 17693.3 17792.5 17984.7 18030.2 18069.8 5395.7 5533.2 5579.2 5619.4 5746.1 5656.2 5672.7 5676.9 5676.9 5683.5 5433.4 5532.8 5564.3 5628.9 5652.7 5666.1 5683.7 5724.3 5728.3 5731.7 5027.9 5137.2 5143.6 5143.7 5145.1 21393.9 22430.0 22479.8 22595.9 22788.5 1540.2 1558.9 1571.8 1603.1 1605.7 12196.1 13188.7 13241.5 13522.1 13832.4 1735.6 1751.0 1796.9 1800.0 1816.4 88956.0 90128.0 90591.0 91043.1 93443.1 10661.9 10866.7 11045.6 11096.8 11176.9 15307.7 15345.5 15353.0 15357.0 15372.8 7463.1 7701.9 7714.4 7845.6 7924.4 7127.9 7170.3 7329.8 7361.8 7412.7 6786.4 6816.3 6831.2 6921.9 6955.8 2053.3 2054.4 2089.8 2091.6 2214.1 838.2 884.9 889.9 899.1 904.3 15812.9 16329.5 16861.2 16882.0 16942.2 865.8 888.7 899.6 904.3 910.1 8365.6 8600.4 8799.2 9000.7 9174.9 459393.0 460943.0 462736.0 470657.0 474795.0 93823.0 94065.5 98161.0 98340.3 98622.0 1070.0 1117.2 1135.5 1138.0 1142.8 14012.3 14161.6 14179.9 14246.9 15013.2 42352.8 42358.2 42763.0 43172.4 44107.6 56935.7 58007.7 58255.0 59058.7 59655.7 6883.7 6889.4 8028.5 8254.8 8267.0 12102.0 12411.7 12703.6 12763.6 13059.5 9306.4 9420.4 9775.6 10979.7 11017.3 9958.8 9996.6 10032.4 10047.5 10230.6 10930.3 10990.8 11068.9 11180.7 11516.7 7674.2 7943.4 7944.7 8017.2 8185.3 10510.8 10631.2 10686.8 10818.0 10915.2 05:07:11 INFO - PID 14638 | 05:07:11 INFO - PID 14638 | [#3] mootools.html Cycles:180 Average:5898.01 Median:5037.87 stddev:3734.73 (74.1%) stddev-sans-first:3727.94 05:07:11 INFO - PID 14638 | Values: 1119.6 1245.7 1299.6 1324.4 1324.8 7924.1 8994.4 9149.9 9210.9 9213.3 9050.6 9145.4 9156.0 9467.9 9484.4 1813.0 2164.3 2206.9 2213.0 2214.5 1922.2 2168.3 2211.7 2224.8 2230.2 2167.0 2168.6 2192.4 2195.6 2195.9 1798.0 1862.2 2119.3 2124.5 2125.1 2097.8 2174.9 2175.1 2183.9 2184.1 9151.9 9237.3 9239.2 9251.0 9277.9 5182.2 5371.0 5382.4 5388.6 5392.2 2967.9 3133.3 3202.2 3204.3 3208.6 938.4 1044.5 1069.3 1074.8 1088.2 14230.6 14291.8 14297.1 14308.6 14312.3 4793.9 4963.3 5008.0 5067.6 5113.3 10553.5 10630.7 10637.9 10642.3 10654.7 5251.1 5252.0 5253.1 5259.9 5269.8 4819.6 4932.8 5056.4 5076.1 5135.0 3500.0 3655.0 3685.6 3693.3 3694.0 1086.5 1096.4 1101.6 1115.3 1126.2 674.6 690.2 697.2 705.4 723.7 5171.4 5172.3 5247.5 5269.6 5304.4 533.3 543.2 549.7 555.2 570.7 3184.2 3353.5 3445.8 3543.1 3637.0 11755.9 12299.0 12306.0 12347.0 12355.1 11798.9 12011.8 12234.8 12260.4 12278.6 8948.2 9085.5 9087.6 9091.7 9096.9 5326.5 5336.9 5403.8 5429.8 5509.2 10732.1 10769.5 10777.5 10795.9 10825.9 11119.2 11126.7 11191.1 11220.0 11285.0 7216.1 7307.6 7331.6 7332.4 7333.6 8721.7 8724.4 8819.6 8898.6 8912.6 7520.6 7559.9 7614.5 7678.2 7684.4 7342.9 7485.3 7487.7 7488.2 7602.6 6479.7 6529.5 6542.5 6545.1 6582.4 4961.2 5039.9 5063.2 5124.8 5128.9 5035.8 5104.3 5105.6 5162.6 5179.9 05:07:11 INFO - PID 14638 | 05:07:11 INFO - PID 14638 | [#4] prototype.html Cycles:180 Average:4716.75 Median:5307.56 stddev:1358.72 (25.6%) stddev-sans-first:1323.28 05:07:11 INFO - PID 14638 | Values: 397.1 399.4 401.8 403.6 407.4 5360.5 5429.8 5483.3 5525.3 5530.5 4815.6 5301.6 5304.7 5390.6 5435.4 4281.1 4282.4 4285.4 4302.6 4313.4 4290.8 4297.0 4297.8 4301.9 4321.3 4202.9 4252.3 4258.6 4299.8 4312.9 4211.7 4241.3 4251.5 4263.9 4288.8 3835.7 3849.5 3855.8 3864.5 3891.6 4963.6 5169.7 5172.0 5188.4 5196.7 4951.7 4975.0 4979.4 4980.9 4998.1 5667.4 5667.9 5670.7 5672.0 5674.7 3823.1 4252.3 4272.5 4273.3 4297.5 5652.8 5810.2 5834.9 5877.2 6025.7 4082.4 4108.5 4136.5 4138.8 4146.2 4176.9 4189.6 4191.2 4200.3 4205.9 4408.3 4468.5 4537.8 4556.0 4601.0 5639.8 5642.5 5666.5 5685.5 5688.6 1422.8 1430.6 1442.5 1448.9 1455.4 957.6 974.6 982.1 982.8 987.8 4957.8 4961.8 4976.8 4979.5 4979.6 5877.6 5881.6 5893.5 5895.3 5923.4 4814.4 4900.7 4901.6 4927.5 4972.8 3077.7 3102.5 3108.9 3112.5 3128.1 5210.9 5470.8 5476.7 5500.9 5504.8 6069.4 6079.6 6084.8 6108.4 6112.5 5488.7 5492.4 5502.6 5529.5 5539.4 5742.2 5895.5 5896.6 5910.9 5956.5 5794.4 5817.6 5824.3 5825.9 5844.9 5189.0 5226.1 5360.9 5382.8 5491.0 4021.4 4094.9 4124.4 4131.8 4134.3 5867.4 5881.5 5889.9 5902.0 5906.4 5431.3 5712.6 5726.1 5726.5 5749.7 5701.2 5722.7 5726.4 5733.6 5744.1 5378.3 5580.9 5622.9 5643.7 5686.7 5733.4 5750.4 5754.7 5778.6 5781.2 5310.4 5315.9 5329.5 5335.5 5337.6 05:07:11 INFO - PID 14638 | 05:07:11 INFO - PID 14638 | [#5] yui.html Cycles:180 Average:13893.29 Median:42125.79 stddev:17119.82 (40.6%) stddev-sans-first:17139.04 05:07:11 INFO - PID 14638 | Values: 668.5 692.4 704.9 706.7 732.3 10814.1 11113.8 11115.8 11413.8 11453.4 11380.5 11409.4 11716.4 11777.5 11846.1 813.7 831.4 835.5 835.6 835.9 814.5 830.4 836.4 838.3 840.1 879.0 880.8 881.2 881.5 881.9 875.5 877.7 878.2 880.7 881.0 650.9 652.1 652.7 652.9 653.1 11516.3 11517.3 11555.0 11606.2 11816.2 13520.9 13721.7 13867.8 13957.7 14073.4 10167.4 10474.9 10557.4 10770.2 10853.9 2572.1 2598.8 2602.3 2635.9 2637.1 65474.3 66990.3 67615.0 67873.3 68689.3 10760.7 10929.4 10967.3 11085.3 11085.8 22763.1 22789.4 22796.3 22797.3 22804.7 6156.3 6241.0 6351.0 6354.7 6375.0 3132.8 3218.4 3222.8 3241.1 3299.8 3462.2 3531.4 3536.6 3690.3 3903.6 697.2 700.2 700.2 716.8 723.2 528.2 550.0 556.5 562.6 565.9 8355.3 8466.8 8475.2 8546.3 8629.4 523.4 547.5 548.9 553.2 555.5 3648.9 3850.5 3958.1 3989.1 4092.5 60971.4 61978.7 62884.4 65203.3 65330.0 39789.4 40085.0 48517.3 50434.7 50467.5 40982.2 44207.6 48326.8 48340.8 48522.0 8914.5 9457.9 9478.1 9546.2 9568.5 24302.9 24708.5 24779.6 25382.7 25457.5 29497.0 40140.0 42029.0 42222.6 43146.1 11553.3 11657.5 11762.9 11912.5 12443.3 11952.4 12382.3 12408.8 12704.0 12741.3 11634.7 11787.2 11789.1 12048.6 12068.6 11542.4 11747.1 11808.5 11953.6 12343.5 10743.4 10993.5 11047.4 11064.2 11178.2 7905.7 8192.7 8289.7 8297.5 8506.7 8894.4 9333.9 9433.0 9435.0 9443.9 05:07:11 INFO - PID 14638 | -------- Summary: end -------- 05:07:11 INFO - PID 14638 | 05:07:12 INFO - TEST-INFO | 14638: exit 0 05:07:12 INFO - TEST-OK | dromaeo_css | took 1124373ms 05:07:12 INFO - TEST-START | kraken 05:07:12 INFO - operating with platform_type : linux_ 05:07:12 INFO - Initialising browser for kraken test... 05:07:12 INFO - TEST-INFO | started process 14974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6FrnQ8/profile http://localhost:58416/getInfo.html) 05:07:16 INFO - PID 14974 | __metrics Screen width/height:1600/1200 05:07:16 INFO - PID 14974 | colorDepth:24 05:07:16 INFO - PID 14974 | Browser inner width/height: 1024/697 05:07:16 INFO - PID 14974 | __metrics 05:07:17 ERROR - PID 14974 | 1490702837382 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:07:17 INFO - PID 14974 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:07:17 INFO - PID 14974 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:07:18 INFO - TEST-INFO | 14974: exit 0 05:07:18 INFO - Browser initialized. 05:07:18 INFO - Running cycle 1/1 for kraken test... 05:07:18 INFO - TEST-INFO | started process 15072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6FrnQ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:30 INFO - PID 15072 | RSS: Main: 167120896 05:07:30 INFO - PID 15072 | 05:07:33 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58416/tests/kraken/driver.html?testName=audio-beat-detection) 05:07:34 INFO - PID 15072 | RSS: Main: 226041856 05:07:34 INFO - PID 15072 | 05:07:37 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58416/tests/kraken/driver.html?testName=audio-dft) 05:07:37 INFO - PID 15072 | RSS: Main: 205287424 05:07:37 INFO - PID 15072 | 05:07:41 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58416/tests/kraken/driver.html?testName=audio-fft) 05:07:41 INFO - PID 15072 | RSS: Main: 288784384 05:07:41 INFO - PID 15072 | 05:07:43 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58416/tests/kraken/driver.html?testName=audio-oscillator) 05:07:44 INFO - PID 15072 | RSS: Main: 199352320 05:07:44 INFO - PID 15072 | 05:07:46 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:47 INFO - PID 15072 | RSS: Main: 204320768 05:07:47 INFO - PID 15072 | 05:07:50 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58416/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:51 INFO - PID 15072 | RSS: Main: 242872320 05:07:51 INFO - PID 15072 | 05:07:54 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58416/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:55 INFO - PID 15072 | RSS: Main: 237645824 05:07:55 INFO - PID 15072 | 05:07:58 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58416/tests/kraken/driver.html?testName=json-parse-financial) 05:07:59 INFO - PID 15072 | RSS: Main: 242065408 05:07:59 INFO - PID 15072 | 05:08:00 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:08:01 INFO - PID 15072 | RSS: Main: 202444800 05:08:01 INFO - PID 15072 | 05:08:03 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:08:04 INFO - PID 15072 | RSS: Main: 210440192 05:08:04 INFO - PID 15072 | 05:08:06 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:08:06 INFO - PID 15072 | RSS: Main: 220401664 05:08:06 INFO - PID 15072 | 05:08:09 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:08:10 INFO - PID 15072 | RSS: Main: 228118528 05:08:10 INFO - PID 15072 | 05:08:13 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:08:14 INFO - PID 15072 | RSS: Main: 223744000 05:08:14 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58416/tests/kraken/driver.html?testName=ai-astar) 05:08:16 INFO - PID 15072 | RSS: Main: 293896192 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | __start_tp_report 05:08:16 INFO - PID 15072 | _x_x_mozilla_page_load 05:08:16 INFO - PID 15072 | _x_x_mozilla_page_load_details 05:08:16 INFO - PID 15072 | |i|pagename|runs| 05:08:16 INFO - PID 15072 | |0;ai-astar;104;112;112;110;113;112;113;114;112;112 05:08:16 INFO - PID 15072 | |1;audio-beat-detection;150;124;127;162;126;125;126;124;150;142 05:08:16 INFO - PID 15072 | |2;audio-dft;169;171;175;171;166;166;167;164;166;172 05:08:16 INFO - PID 15072 | |3;audio-fft;75;75;76;112;75;75;75;76;93;75 05:08:16 INFO - PID 15072 | |4;audio-oscillator;85;85;115;86;85;85;100;85;84;106 05:08:16 INFO - PID 15072 | |5;imaging-gaussian-blur;114;114;114;114;114;114;115;115;114;114 05:08:16 INFO - PID 15072 | |6;imaging-darkroom;150;151;152;151;152;152;151;150;149;149 05:08:16 INFO - PID 15072 | |7;imaging-desaturate;95;95;95;96;94;94;94;95;94;99 05:08:16 INFO - PID 15072 | |8;json-parse-financial;64;64;65;62;64;65;65;66;65;64 05:08:16 INFO - PID 15072 | |9;json-stringify-tinderbox;55;56;56;56;55;56;56;57;56;57 05:08:16 INFO - PID 15072 | |10;stanford-crypto-aes;83;82;90;82;85;82;91;83;83;81 05:08:16 INFO - PID 15072 | |11;stanford-crypto-ccm;152;144;133;152;132;132;134;133;183;143 05:08:16 INFO - PID 15072 | |12;stanford-crypto-pbkdf2;187;193;197;192;193;194;194;195;193;190 05:08:16 INFO - PID 15072 | |13;stanford-crypto-sha256-iterative;71;70;72;70;70;74;71;71;72;69 05:08:16 INFO - PID 15072 | __end_tp_report 05:08:16 INFO - PID 15072 | __start_cc_report 05:08:16 INFO - PID 15072 | _x_x_mozilla_cycle_collect,2016 05:08:16 INFO - PID 15072 | __end_cc_report 05:08:16 INFO - PID 15072 | __startTimestamp1490702896508__endTimestamp 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | ------- Summary: start ------- 05:08:16 INFO - PID 15072 | Number of tests: 14 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.80 (2.5%) stddev-sans-first:1.09 05:08:16 INFO - PID 15072 | Values: 104.0 112.0 112.0 110.0 113.0 112.0 113.0 114.0 112.0 112.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:134.50 stddev:14.11 (10.5%) stddev-sans-first:13.97 05:08:16 INFO - PID 15072 | Values: 150.0 124.0 127.0 162.0 126.0 125.0 126.0 124.0 150.0 142.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#2] audio-dft Cycles:10 Average:168.70 Median:170.00 stddev:3.47 (2.0%) stddev-sans-first:3.67 05:08:16 INFO - PID 15072 | Values: 169.0 171.0 175.0 171.0 166.0 166.0 167.0 164.0 166.0 172.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:12.34 (16.5%) stddev-sans-first:12.91 05:08:16 INFO - PID 15072 | Values: 75.0 75.0 76.0 112.0 75.0 75.0 75.0 76.0 93.0 75.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:85.00 stddev:11.22 (13.2%) stddev-sans-first:11.64 05:08:16 INFO - PID 15072 | Values: 85.0 85.0 115.0 86.0 85.0 85.0 100.0 85.0 84.0 106.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:08:16 INFO - PID 15072 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 114.0 114.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 05:08:16 INFO - PID 15072 | Values: 150.0 151.0 152.0 151.0 152.0 152.0 151.0 150.0 149.0 149.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.52 (1.6%) stddev-sans-first:1.62 05:08:16 INFO - PID 15072 | Values: 95.0 95.0 95.0 96.0 94.0 94.0 94.0 95.0 94.0 99.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 05:08:16 INFO - PID 15072 | Values: 64.0 64.0 65.0 62.0 64.0 65.0 65.0 66.0 65.0 64.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 05:08:16 INFO - PID 15072 | Values: 55.0 56.0 56.0 56.0 55.0 56.0 56.0 57.0 56.0 57.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:3.49 (4.2%) stddev-sans-first:3.67 05:08:16 INFO - PID 15072 | Values: 83.0 82.0 90.0 82.0 85.0 82.0 91.0 83.0 83.0 81.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:143.50 stddev:15.92 (11.1%) stddev-sans-first:16.60 05:08:16 INFO - PID 15072 | Values: 152.0 144.0 133.0 152.0 132.0 132.0 134.0 133.0 183.0 143.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.80 Median:193.50 stddev:2.74 (1.4%) stddev-sans-first:1.94 05:08:16 INFO - PID 15072 | Values: 187.0 193.0 197.0 192.0 193.0 194.0 194.0 195.0 193.0 190.0 05:08:16 INFO - PID 15072 | 05:08:16 INFO - PID 15072 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.41 (2.0%) stddev-sans-first:1.50 05:08:16 INFO - PID 15072 | Values: 71.0 70.0 72.0 70.0 70.0 74.0 71.0 71.0 72.0 69.0 05:08:16 INFO - PID 15072 | -------- Summary: end -------- 05:08:16 INFO - PID 15072 | 05:08:17 INFO - TEST-INFO | 15072: exit 0 05:08:17 INFO - TEST-OK | kraken | took 65598ms 05:08:17 INFO - SUITE-END | took 1189s 05:08:18 INFO - Completed test suite (00:19:50) 05:08:18 INFO - javascript benchmark 05:08:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6528.979747783096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2703.553913604255, 2710.2817753295367, 2747.162115554755, 2748.2717079973822, 2766.7786577073834, 5016.949830501694, 5142.228665700147, 5193.870153246166, 5198.0, 5219.0, 5092.312537807404, 5105.974470127653, 5130.769115389807, 5132.846014619558, 5148.227765835127, 4637.65217608679, 4673.228917228653, 4694.483606803249, 4715.952840471586, 4748.0, 4731.7634118293945, 4751.263554149113, 4772.832950846721, 4803.327534145223, 4850.830220942268, 4763.428388593374, 4772.093302272575, 4786.760661966888, 4789.066132104241, 4833.806647734104, 4618.976905115486, 4629.467611224685, 4743.644226683013, 4748.810047598109, 4759.595434388081, 4686.250199968023, 4692.671512994092, 4714.245720684708, 4734.502877197879, 4739.526047395233, 5079.466656001104, 5081.034603425374, 5086.338775959139, 5087.440381558025, 5128.102582048126, 5386.165144402585, 5544.16837474378, 5546.86132846678, 5604.887902241932, 5607.299087614048, 5517.889642207174, 5604.887902241973, 5697.914531282034, 5730.169125476783, 5745.109508026263, 5239.607029472805, 5245.842624721265, 5252.185911183773, 5252.684838909601, 5263.605229607795, 5783.306003279633, 5805.448482394166, 5806.622569533051, 5810.593258471867, 5864.06175011996, 5295.364556253275, 5425.83722488326, 5426.131818909034, 5436.592255580847, 5552.861178470571, 5362.678239305654, 5659.773609055674, 5660.490555849911, 5688.914666280009, 5715.428457154251, 5443.972780136153, 5455.536279416294, 5545.112781954868, 5581.10702287632, 5583.218349431083, 5579.46995035471, 5583.05088135018, 5604.187392828017, 5615.943840561624, 5650.7739690412745, 4577.931331030038, 4624.953750462452, 4633.837815676435, 4770.379850619397, 4772.7136371817105, 3999.320115580358, 4048.129652124748, 4069.064115253508, 4074.4499492568125, 4099.3031184698075, 4754.738489383117, 4766.0, 4766.547178018082, 4789.736564488987, 4808.3989501312335, 5642.548596112301, 5646.689432081275, 5651.4348565143155, 5653.773849045992, 5690.971545142331, 4624.121416930772, 4693.155232058194, 4695.624350051988, 4762.64280178988, 4857.951420485821, 4926.33494478248, 5033.748312584356, 5102.872428189251, 5104.259882317117, 5104.387473503203, 5227.477252274742, 5240.5807535397835, 5242.135047717084, 5245.790168393221, 5247.134222853339, 5626.212330273683, 5657.377688454185, 5677.829665110054, 5687.146927960839, 5689.516391106802, 5047.1419858623385, 5106.080905437057, 5111.974440127776, 5174.068667639711, 5211.530962213419, 5588.832335029955, 5589.860253493695, 5591.524720398812, 5612.803551875665, 5642.238297829905, 5653.321601407857, 5655.4910058094965, 5656.406077361818, 5656.406077361818, 5656.85857853557, 5172.870678233075, 5224.346956630421, 5254.632175747814, 5501.257330260523, 5510.6969116698965, 5322.254884316121, 5338.3060202173465, 5351.010063138332, 5353.625246232727, 5365.839024829262, 5282.683039017517, 5296.152615581488, 5338.958903013875, 5406.729663516887, 5417.783288668409, 5543.5010849022165, 5543.77824887, 5544.473275039026, 5548.0, 5563.888722225452, 5149.279100925798, 5151.845444636667, 5152.27868098474, 5153.45888681683, 5198.948010519846], "value": 5085.990899028739, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.8659408336083, 641.7433026789283, 656.7340227207981, 1072.0940805019757, 1077.9299345542534, 24488.632670509935, 30987.0, 31143.532847007256, 31208.0, 31327.373452530963, 31677.208069798267, 31796.523052154236, 31809.0, 31911.0, 32078.679213207863, 5080.517350851682, 5126.641135120543, 7047.85904281914, 7192.856142877139, 7195.0, 6976.755813546527, 7094.964525177367, 7100.147982242138, 7108.715651373939, 7110.0, 7095.113110861143, 7102.183248926388, 7150.928490715104, 7172.139343278814, 7192.31672991065, 7080.398166155857, 7134.607596582186, 7144.85710285794, 7165.605891675956, 7190.28097190282, 7014.579125252501, 7259.89110163348, 7265.89101163483, 7268.745593904188, 7273.8545229095125, 32696.182595435068, 32955.34089318224, 33001.00996970095, 33024.0, 33083.6691633083, 2633.091583403742, 2658.255688407249, 2659.4149287156793, 2677.290518012728, 2711.7288271172924, 23227.0, 23314.300570982898, 23515.7648423517, 23873.76126238733, 24215.273541793773, 2534.721180670125, 2593.818432709711, 2594.805389595788, 2614.0, 2616.856072915989, 149861.0, 150337.9999999989, 150363.0, 150791.0, 150828.0, 42151.15697686029, 42326.36510452346, 42437.0, 42438.78780606077, 42484.57515424868, 44746.55253447489, 44768.0, 44817.551824481336, 44860.3270950936, 44907.0, 12683.23900565969, 13056.934715326552, 13070.477180912847, 13076.215427074216, 13084.28036458004, 8776.912230877737, 8868.0, 9826.361286516496, 10494.42280674555, 10546.419946902994, 12595.559155429515, 12603.306818124907, 12639.1784534005, 12675.302858342695, 12763.489460421479, 5036.6726162799305, 5043.319151914445, 5079.187330027178, 5082.415522214993, 5137.588992880561, 841.7937605286621, 858.9785255368665, 892.7723430525175, 898.8831451911341, 912.0788004115891, 18680.626387472174, 18843.340483083026, 19484.80515194858, 19575.902120489307, 19930.601387972158, 957.5212393803098, 961.274237950343, 964.9710508684751, 965.9951700241594, 977.2768151567789, 12834.743305133845, 13705.73855313862, 13720.588382348546, 13829.654258643614, 13933.58199254024, 167665.0, 167671.0, 168054.0, 168093.0, 168324.0, 38190.23619527594, 38248.087595620666, 38276.42585361222, 38311.80844095762, 38399.42400863989, 1215.7629262293945, 1255.8932490738207, 1256.8437037925314, 1263.418827339434, 1266.65167079054, 21968.45078872977, 22156.34716709509, 22810.42973925665, 22968.425789354733, 23050.884745576164, 29084.709152909047, 29136.7086329134, 29230.123096307147, 29248.56127158137, 29275.268118297212, 196463.0, 196587.0, 196732.0, 197060.0, 197438.0, 21506.67739983933, 21772.564548709255, 26373.208803735917, 29245.268868278465, 29381.559276611297, 36809.0, 36929.63070369262, 36941.0, 37256.62743372531, 37882.81058594689, 28094.297642558282, 30376.392472150874, 30393.240168995068, 30517.389652206388, 31176.220594484414, 29945.0, 30229.243496462026, 31102.844485777427, 31652.36695266128, 31851.20371990626, 32353.0, 32923.0, 33017.33965320632, 33107.0, 33386.0, 27357.72642273552, 27372.45255094847, 27531.17406477809, 27597.31006724848, 28427.857860710563, 22657.546849062597, 23675.0, 23759.52480950406, 23840.880795596604, 24099.879500602387], "value": 14536.353803017291, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.2412608219914, 426.41155205815977, 432.312622929542, 440.27794417155866, 447.26201767084285, 16795.1602419879, 16994.660106797855, 17050.658986820257, 17473.126343682798, 17631.559211019732, 17693.292268309284, 17792.46622601324, 17984.73022904654, 18030.18864151113, 18069.81930180698, 5395.676259424427, 5533.22534845121, 5579.163125531162, 5619.353774315945, 5746.109353050284, 5656.2364080849175, 5672.659640421588, 5676.943230567683, 5676.943230567704, 5683.488486036256, 5433.402325744165, 5532.806351777688, 5564.304461942257, 5628.915566266509, 5652.717364131798, 5666.065099258617, 5683.715814209294, 5724.341700704389, 5728.283964504437, 5731.684757338366, 5027.924581131286, 5137.229415587654, 5143.639945203838, 5143.717095559743, 5145.125328694131, 21393.893030534902, 22430.0, 22479.775202247933, 22595.887020564955, 22788.4677874928, 1540.2375823967095, 1558.8908776385658, 1571.7642353647045, 1603.070219272819, 1605.727026405514, 12196.14626976112, 13188.736225275537, 13241.536546220932, 13522.12106213093, 13832.446702131903, 1735.6181640039297, 1750.9737353939702, 1796.9281228750833, 1799.9640007199914, 1816.4096668582763, 88956.0, 90128.0, 90591.0, 91043.08956910412, 93443.06556934412, 10661.893381066246, 10866.67399978002, 11045.558177672963, 11096.778064438828, 11176.944115279372, 15307.693846123015, 15345.462908798361, 15353.0, 15357.0, 15372.846271537364, 7463.141738700119, 7701.884471732928, 7714.382849372037, 7845.646945887449, 7924.405669574805, 7127.859542473179, 7170.282971702893, 7329.816754581178, 7361.779146625609, 7412.703491860373, 6786.389224969677, 6816.318368163144, 6831.248562658104, 6921.861562768717, 6955.791326260221, 2053.3429302623017, 2054.41449186984, 2089.822365098953, 2091.623507768586, 2214.136486770161, 838.153465000354, 884.9247813935759, 889.8665200220019, 899.1233547291339, 904.3488688144525, 15812.92093539525, 16329.510114696579, 16861.156942153088, 16882.0, 16942.23759930806, 865.8138500222483, 888.7289376740156, 899.6446403670514, 904.3353135445442, 910.0671811393242, 8365.562384450157, 8600.397972142015, 8799.208071273617, 9000.684976025808, 9174.908250917406, 459393.0, 460943.0, 462736.0, 470657.0, 474795.0, 93823.0, 94065.5296723512, 98161.0, 98340.26555751046, 98622.0, 1069.9732506687394, 1117.2179474367974, 1135.5003798328873, 1138.0383575878534, 1142.8000099982637, 14012.299385030912, 14161.645958851112, 14179.858201417854, 14246.928765356108, 15013.174275414956, 42352.78823605862, 42358.15283694247, 42763.0, 43172.352414714434, 44107.55892441035, 56935.71532142313, 58007.709961449924, 58255.0, 59058.704706476194, 59655.70172149112, 6883.724651013903, 6889.379955804002, 8028.518288902685, 8254.752357429286, 8266.958665206635, 12102.0, 12411.689707757378, 12703.555375561811, 12763.553275635308, 13059.477620895437, 9306.441613503212, 9420.434773913586, 9775.560099795668, 10979.725506862073, 11017.338959662446, 9958.800823983625, 9996.600135994478, 10032.448215348226, 10047.547860346156, 10230.59077636916, 10930.344179348946, 10990.780184396428, 11068.889311106786, 11180.652063066847, 11516.654500365003, 7674.155842857393, 7943.44395892282, 7944.656326383615, 8017.238362355567, 8185.345172386314, 10510.842337364793, 10631.20265980039, 10686.839697404701, 10818.0, 10915.23593348458], "value": 8877.12185959373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1119.5745616665665, 1245.6636708088813, 1299.603620895627, 1324.3973991833716, 1324.8410190777106, 7924.128345881955, 8994.4153630014, 9149.90850091498, 9210.861837072449, 9213.309001824857, 9050.637974481013, 9145.359824812265, 9156.0, 9467.90532094679, 9484.383515071533, 1812.954676133094, 2164.2641501889393, 2206.944826379345, 2212.9557408851815, 2214.534947660985, 1922.202286051287, 2168.2844661261747, 2211.6903633491324, 2224.833137514685, 2230.2194232018824, 2166.978330216701, 2168.6313326734494, 2192.440927563469, 2195.560887822434, 2195.9451013724624, 1797.9640407191914, 1862.2178684952353, 2119.34300366886, 2124.4901223706197, 2125.0968338456173, 2097.800708932649, 2174.945626359338, 2175.0973346061364, 2183.8908054597205, 2184.1263494602126, 9151.862722059175, 9237.261019118454, 9239.16847483723, 9250.953745231298, 9277.907220927771, 5182.222666600002, 5370.973145134289, 5382.434844341366, 5388.649737767033, 5392.164214546751, 2967.896123635662, 3133.27934575049, 3202.247471844115, 3204.3270913108277, 3208.598925134358, 938.4047119896136, 1044.5195210203315, 1069.310294859819, 1074.8280275156017, 1088.2110469909253, 14230.573082807532, 14291.785623215661, 14297.142171469744, 14308.570742877626, 14312.284385780773, 4793.856184314476, 4963.329950456642, 5008.0, 5067.619928505377, 5113.284140220372, 10553.525091370906, 10630.681079567625, 10637.893621063846, 10642.25504214713, 10654.680359589225, 5251.10731175701, 5252.028374750607, 5253.080710875582, 5259.921101183485, 5269.841904742864, 4819.59033482151, 4932.802687892444, 5056.443791182967, 5076.086304465158, 5134.974325128351, 3499.9650003500146, 3655.0, 3685.617893290016, 3693.298273328059, 3693.981530092386, 1086.4893500054961, 1096.4079397125463, 1101.5924108080062, 1115.2806439846254, 1126.1947707389256, 674.6087269383746, 690.2028157478121, 697.1738489889395, 705.3792662457005, 723.735836419703, 5171.3535808024, 5172.27588137661, 5247.475252474722, 5269.604779641466, 5304.38999515053, 533.3493138371181, 543.2042058384486, 549.7416214379235, 555.1561626327959, 570.6633086478997, 3184.172115250052, 3353.5305057292, 3445.776024558396, 3543.114221444639, 3636.9818150909077, 11755.88244117565, 12299.0, 12306.0, 12346.974991127232, 12355.135140540257, 11798.941005294919, 12011.819822702666, 12234.81647775284, 12260.44827982743, 12278.631641050782, 8948.194662480408, 9085.454872707658, 9087.636494540277, 9091.681791137411, 9096.8635470468, 5326.467353264643, 5336.946630533645, 5403.8108666196495, 5429.809956651498, 5509.201165830852, 10732.14142868553, 10769.461526923465, 10777.46112694378, 10795.946020269848, 10825.891741082803, 11119.221654484109, 11126.721831954266, 11191.104711623213, 11220.0, 11285.0, 7216.097987751531, 7307.634618269171, 7331.560106393634, 7332.41340692754, 7333.596652184181, 8721.694740684046, 8724.43291186071, 8819.559022049, 8898.599563019809, 8912.598933047899, 7520.586367749607, 7559.886601700869, 7614.466987311057, 7678.1937896522295, 7684.385249179941, 7342.889856652261, 7485.288897554724, 7487.737929172453, 7488.213737557696, 7602.6198690066385, 6479.708413121515, 6529.5102867284195, 6542.509311801729, 6545.083688283549, 6582.440492558187, 4961.231009193581, 5039.899202016012, 5063.240513922941, 5124.8206312778875, 5128.923066153936, 5035.84892453227, 5104.336436263262, 5105.566026887756, 5162.612804039637, 5179.896402072013], "value": 4450.3301801289745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.0530285269631, 399.40289267545023, 401.8211895706411, 403.63067792969434, 407.37264612496756, 5360.517553420192, 5429.809956651513, 5483.341998960121, 5525.281713377265, 5530.5022547970675, 4815.638827087965, 5301.595077304517, 5304.681719096847, 5390.6226564140525, 5435.42927992561, 4281.079567892903, 4282.42187304713, 4285.44289242398, 4302.612764851163, 4313.396124542566, 4290.849820256291, 4296.957030429687, 4297.763623000734, 4301.935470967922, 4321.308590625501, 4202.873913782591, 4252.277112890816, 4258.574142585748, 4299.839043458264, 4312.870613881589, 4211.7472951623, 4241.34259189823, 4251.489821221442, 4263.850765223202, 4288.76411797351, 3835.6547910688173, 3849.480320156771, 3855.7879316637573, 3864.53625564934, 3891.6497515223764, 4963.60291176705, 5169.741512924339, 5171.974140129313, 5188.351456067991, 5196.662216955886, 4951.727654978975, 4974.9751251243515, 4979.427365852901, 4980.850574482735, 4998.075356059141, 5667.404922483162, 5667.8583035424035, 5670.68811215383, 5671.971640141773, 5674.687892165929, 3823.1397935464574, 4252.255855225354, 4272.487301523837, 4273.3162693969125, 4297.462817147856, 5652.802151924663, 5810.244668193108, 5834.854128646775, 5877.206577112078, 6025.698715064229, 4082.4284600156, 4108.4864391951005, 4136.544980052192, 4138.751674899516, 4146.232946904832, 4176.874693759192, 4189.643880270211, 4191.161767646483, 4200.327947528381, 4205.894852628709, 4408.338749187647, 4468.486124095771, 4537.75042372666, 4555.977220113945, 4600.97699511507, 5639.774409023593, 5642.492175704207, 5666.490015898589, 5685.459881311269, 5688.630239034533, 1422.7994943360723, 1430.5851303121979, 1442.473497173524, 1448.9422721413428, 1455.3990610328765, 957.6025949231131, 974.6491263145263, 982.1357205658975, 982.7543114221445, 987.76293689514, 4957.82647607332, 4961.826336078292, 4976.800927962913, 4979.4771548987555, 4979.551840334315, 5877.647341159544, 5881.558883083786, 5893.528517718572, 5895.317630478122, 5923.437273459014, 4814.350062741555, 4900.705957642553, 4901.554041557749, 4927.457979622239, 4972.751362431936, 3077.6768439313996, 3102.472579661463, 3108.9067327980197, 3112.474887305204, 3128.1397615655424, 5210.869728256748, 5470.753816078286, 5476.698781566973, 5500.87232117415, 5504.80733174337, 6069.388713715332, 6079.604825686316, 6084.756609735649, 6108.35862234459, 6112.480439162632, 5488.670679759148, 5492.423295553909, 5502.58730595207, 5529.502344788908, 5539.390667026543, 5742.224799651994, 5895.469407753323, 5896.611872191769, 5910.852228694317, 5956.463918247206, 5794.449527294901, 5817.621854579439, 5824.301083869963, 5825.854353641193, 5844.853878653068, 5188.9740551297, 5226.0815846633905, 5360.919586206288, 5382.811601594082, 5491.039068163135, 4021.3565829467143, 4094.877153685394, 4124.381342798604, 4131.814068366871, 4134.297169481256, 5867.442592953663, 5881.500072493886, 5889.852753681193, 5902.026165682614, 5906.379830117776, 5431.321084864392, 5712.628679136009, 5726.112452569859, 5726.484616384545, 5749.655020698771, 5701.173329867229, 5722.656640601577, 5726.427357264407, 5733.598648094593, 5744.0522313817755, 5378.327709036371, 5580.9071598150695, 5622.943770562242, 5643.746031428514, 5686.658800471985, 5733.4266573344, 5750.424957504216, 5754.741036653444, 5778.624389414675, 5781.248437703071, 5310.442403547572, 5315.946840531546, 5329.493698098674, 5335.466453354634, 5337.599680023936], "value": 4303.34163406224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5186665600767, 692.3734020711258, 704.9295070492948, 706.6572712234562, 732.3372348025036, 10814.080803131734, 11113.833292500609, 11115.777684446317, 11413.771724565504, 11453.427328633556, 11380.487878045487, 11409.37248451335, 11716.355600441972, 11777.470013849375, 11846.111541634391, 813.7070654564367, 831.4470876866907, 835.4987007795335, 835.5738573327616, 835.9122292159327, 814.5112932240638, 830.4145577367972, 836.3643630840544, 838.2623291503469, 840.0675250471971, 878.97802554936, 880.7665968518347, 881.2465342132481, 881.5107615273521, 881.8633111867639, 875.5053394831963, 877.662100091463, 878.2447095497898, 880.6697488441835, 880.9779755506131, 650.8503044299838, 652.100101859431, 652.719330687804, 652.8694261147789, 653.121551513214, 11516.25144365622, 11517.25137866036, 11555.0, 11606.24559403636, 11816.231944923553, 13520.93239533796, 13721.656958576015, 13867.791983120262, 13957.651058723512, 14073.437062517487, 10167.440790756506, 10474.895251047468, 10557.366558006544, 10770.192235582363, 10853.945730271376, 2572.0611976628397, 2598.8180827342094, 2602.323395917056, 2635.9472810543875, 2637.07702304192, 65474.3452565473, 66990.33009669889, 67615.0, 67873.3212667877, 68689.3131068688, 10760.677179684622, 10929.398883061349, 10967.287126336922, 11085.334879907232, 11085.785122314599, 22763.08947642109, 22789.430264243194, 22796.316110516713, 22797.316080517612, 22804.657930131063, 6156.29202641693, 6240.963615152214, 6351.047342898602, 6354.682265886687, 6375.0437434384285, 3132.7807053506035, 3218.3563287342627, 3222.758293128025, 3241.1410976091356, 3299.785513941586, 3462.2210002749684, 3531.4173161428075, 3536.5932917714276, 3690.2988432197794, 3903.6486716195677, 697.2051860878603, 700.166801506206, 700.2332445971653, 716.8136284565946, 723.1791916175074, 528.2155998342458, 549.9807506737245, 556.5408537956122, 562.5752556819575, 565.9434056594307, 8355.289800367036, 8466.830663386698, 8475.203182949612, 8546.273566746771, 8629.352798540134, 523.3544432891769, 547.4716898193262, 548.9086580129718, 553.2199598566002, 555.5250261026764, 3648.927021459556, 3850.537935447708, 3958.089639382958, 3989.122393073519, 4092.46797916269, 60971.390286097456, 61978.703194521186, 62884.37115628785, 65203.347966520676, 65330.0, 39789.40315895264, 40085.0, 48517.27224091641, 50434.747826261366, 50467.49532504701, 40982.1803563927, 44207.55792442099, 48326.75836620865, 48340.758296208296, 48522.0, 8914.465132092095, 9457.858132128162, 9478.146966773023, 9546.236301096034, 9568.521573921136, 24302.878485608166, 24708.505829882943, 24779.628305575072, 25382.746172538038, 25457.49085018326, 29497.0, 40140.0, 42029.0, 42222.57777422186, 43146.13707725891, 11553.30680159193, 11657.475413606238, 11762.94118529402, 11912.52349905994, 12443.315617641116, 11952.392509199999, 12382.318972456602, 12408.81386779181, 12704.0, 12741.299228542519, 11634.6509604712, 11787.248231962656, 11789.115816313639, 12048.578299759467, 12068.577599783965, 11542.365169915734, 11747.118966077407, 11808.468618911998, 11953.581624643095, 12343.485575610854, 10743.355398676105, 10993.450327483433, 11047.392393418439, 11064.22550421495, 11178.217524773188, 7905.683772649029, 8192.713255036046, 8289.709860154866, 8297.543635100128, 8506.74479765608, 8894.42186257891, 9333.906660933304, 9432.952835236054, 9434.952825236105, 9443.858342124737], "value": 6162.211054574588, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 110.0, 113.0, 112.0, 113.0, 114.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 127.0, 162.0, 126.0, 125.0, 126.0, 124.0, 150.0, 142.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 175.0, 171.0, 166.0, 166.0, 167.0, 164.0, 166.0, 172.0], "value": 168.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 112.0, 75.0, 75.0, 75.0, 76.0, 93.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 86.0, 85.0, 85.0, 100.0, 85.0, 84.0, 106.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 151.0, 152.0, 152.0, 151.0, 150.0, 149.0, 149.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 62.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 57.0, 56.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 90.0, 82.0, 85.0, 82.0, 91.0, 83.0, 83.0, 81.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 144.0, 133.0, 152.0, 132.0, 132.0, 134.0, 133.0, 183.0, 143.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 193.0, 197.0, 192.0, 193.0, 194.0, 194.0, 195.0, 193.0, 190.0], "value": 192.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 70.0, 70.0, 74.0, 71.0, 71.0, 72.0, 69.0], "value": 71.0, "unit": "score"}]}]} 05:08:18 INFO - Return code: 0 05:08:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:08:18 ERROR - # TBPL SUCCESS # 05:08:18 INFO - Running post-action listener: _resource_record_post_action 05:08:18 INFO - [mozharness: 2017-03-28 12:08:18.288943Z] Finished run-tests step (success) 05:08:18 INFO - Running post-run listener: _resource_record_post_run 05:08:18 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370937856; Read time: 12; Write time: 282268 05:08:18 INFO - TinderboxPrint: CPU usage
13.0% 05:08:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:08:18 INFO - TinderboxPrint: I/O write bytes / time
370,937,856 / 282,268 05:08:18 INFO - TinderboxPrint: CPU idle
8,380.4 (87.0%) 05:08:18 INFO - TinderboxPrint: CPU user
1,205.2 (12.5%) 05:08:18 INFO - TinderboxPrint: Swap in / out
0 / 0 05:08:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108060672; Read time: 0; Write time: 98400 05:08:18 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 262877184; Read time: 0; Write time: 183868 05:08:18 INFO - Running post-run listener: _upload_blobber_files 05:08:18 INFO - Blob upload gear active. 05:08:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:08: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 05:08: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:08: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:08:19 INFO - (blobuploader) - INFO - Open directory for files ... 05:08:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:08:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:20 INFO - (blobuploader) - INFO - Done attempting. 05:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:08:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:20 INFO - (blobuploader) - INFO - Done attempting. 05:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:08:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:08:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:21 INFO - (blobuploader) - INFO - Done attempting. 05:08:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:08:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:08:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:25 INFO - (blobuploader) - INFO - Done attempting. 05:08:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:08:25 INFO - Return code: 0 05:08:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:08:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:08:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcb1b5faebdd17d078f3f338d8e43f139eb18cd51f99fb581890d5c3b9825fc06771a2c833a9fba9ba66d7fdad5bd9e278808fe650d64b2b74062b43a87c4eda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2590cac38c3342121ad607a2731f868f7442e31f12673862b361a31fcc0eadb0c1d4d488c9bdff5add2bda22761e24e175662a4da8eaec9f3de744b086b9495c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6542c448d2052a9ae07e1e21bf3e882647c04f44fe4ef759b6a6f525290b1a31e03809978246ce24914d17f8c4a7d3e85ab92e4dc5a27d3dacae3a0882a74ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fe243be1937890fecfb7810123a85b598d8d23dbca65f8d1d5fe0d764705f247b59c79acfad5c493de8f18d4850f73538ea137b6a84ab58b2317a57ceb3026f"} 05:08:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:08:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:08:25 INFO - Contents: 05:08:25 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcb1b5faebdd17d078f3f338d8e43f139eb18cd51f99fb581890d5c3b9825fc06771a2c833a9fba9ba66d7fdad5bd9e278808fe650d64b2b74062b43a87c4eda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2590cac38c3342121ad607a2731f868f7442e31f12673862b361a31fcc0eadb0c1d4d488c9bdff5add2bda22761e24e175662a4da8eaec9f3de744b086b9495c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6542c448d2052a9ae07e1e21bf3e882647c04f44fe4ef759b6a6f525290b1a31e03809978246ce24914d17f8c4a7d3e85ab92e4dc5a27d3dacae3a0882a74ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fe243be1937890fecfb7810123a85b598d8d23dbca65f8d1d5fe0d764705f247b59c79acfad5c493de8f18d4850f73538ea137b6a84ab58b2317a57ceb3026f"} 05:08:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:08:25 INFO - Copying logs to upload dir... 05:08:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:08:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.858880 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-28 05:08:24.863868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 05:08:24.867544) ========= 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=14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcb1b5faebdd17d078f3f338d8e43f139eb18cd51f99fb581890d5c3b9825fc06771a2c833a9fba9ba66d7fdad5bd9e278808fe650d64b2b74062b43a87c4eda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2590cac38c3342121ad607a2731f868f7442e31f12673862b361a31fcc0eadb0c1d4d488c9bdff5add2bda22761e24e175662a4da8eaec9f3de744b086b9495c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6542c448d2052a9ae07e1e21bf3e882647c04f44fe4ef759b6a6f525290b1a31e03809978246ce24914d17f8c4a7d3e85ab92e4dc5a27d3dacae3a0882a74ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fe243be1937890fecfb7810123a85b598d8d23dbca65f8d1d5fe0d764705f247b59c79acfad5c493de8f18d4850f73538ea137b6a84ab58b2317a57ceb3026f"} build_url:https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/Dgu31funR72svcAOHHmVlQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcb1b5faebdd17d078f3f338d8e43f139eb18cd51f99fb581890d5c3b9825fc06771a2c833a9fba9ba66d7fdad5bd9e278808fe650d64b2b74062b43a87c4eda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2590cac38c3342121ad607a2731f868f7442e31f12673862b361a31fcc0eadb0c1d4d488c9bdff5add2bda22761e24e175662a4da8eaec9f3de744b086b9495c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6542c448d2052a9ae07e1e21bf3e882647c04f44fe4ef759b6a6f525290b1a31e03809978246ce24914d17f8c4a7d3e85ab92e4dc5a27d3dacae3a0882a74ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fe243be1937890fecfb7810123a85b598d8d23dbca65f8d1d5fe0d764705f247b59c79acfad5c493de8f18d4850f73538ea137b6a84ab58b2317a57ceb3026f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 05:08:24.892722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 05:08:24.893106) ========= 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=14ef55db36f7623abb31b9cf000001d5-1490701638.540095-956455810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 05:08:24.978980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 05:08:24.979307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 05:08:24.979930) ========= ========= Total master_lag: 0.18 =========