builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1491426451.3 results: success (0) revision: 9ffcfb1564d12239e9878026a92ffb58ba391d89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.302056) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.302515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.302830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.317526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.317883) ========= 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=745a4373a2a16df560f216e000000264-1491426450.696988-566554197 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 14:07:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 228M=0s 2017-04-05 14:07:31 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.413137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.413449) ========= 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=745a4373a2a16df560f216e000000264-1491426450.696988-566554197 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017532 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.462920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:31.463354) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ffcfb1564d12239e9878026a92ffb58ba391d89 --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 9ffcfb1564d12239e9878026a92ffb58ba391d89 --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=745a4373a2a16df560f216e000000264-1491426450.696988-566554197 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 14:07:31,545 truncating revision to first 12 chars 2017-04-05 14:07:31,545 Setting DEBUG logging. 2017-04-05 14:07:31,545 attempt 1/10 2017-04-05 14:07:31,545 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ffcfb1564d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 14:07:32,067 unpacking tar archive at: mozilla-central-9ffcfb1564d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.822240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:32.299115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:32.299430) ========= script_repo_revision: 9ffcfb1564d12239e9878026a92ffb58ba391d89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:32.299812) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:32.300076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 14:07:32.309243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-04-05 14:07:32.309581) ========= /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=745a4373a2a16df560f216e000000264-1491426450.696988-566554197 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:32 INFO - MultiFileLogger online at 20170405 14:07:32 in /builds/slave/test 14:07:32 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 14:07:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:32 INFO - {'append_to_log': False, 14:07:32 INFO - 'base_work_dir': '/builds/slave/test', 14:07:32 INFO - 'blob_upload_branch': 'Firefox', 14:07:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:32 INFO - 'branch': 'Firefox', 14:07:32 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:32 INFO - 'config_files': ('talos/linux_config.py',), 14:07:32 INFO - 'default_actions': ('clobber', 14:07:32 INFO - 'read-buildbot-config', 14:07:32 INFO - 'download-and-extract', 14:07:32 INFO - 'populate-webroot', 14:07:32 INFO - 'create-virtualenv', 14:07:32 INFO - 'install', 14:07:32 INFO - 'run-tests'), 14:07:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:32 INFO - 'download_minidump_stackwalk': True, 14:07:32 INFO - 'download_symbols': 'ondemand', 14:07:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:32 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:32 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:32 INFO - 'gecko_profile': False, 14:07:32 INFO - 'gecko_profile_interval': 0, 14:07:32 INFO - 'installer_path': 'installer.exe', 14:07:32 INFO - 'log_level': 'info', 14:07:32 INFO - 'log_name': 'talos', 14:07:32 INFO - 'log_to_console': True, 14:07:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:32 INFO - 'opt_config_files': (), 14:07:32 INFO - 'pip_index': False, 14:07:32 INFO - 'suite': 'dromaeojs', 14:07:32 INFO - 'system_bits': '32', 14:07:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:32 INFO - 'title': 'talos-linux64-ix-032', 14:07:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:32 INFO - 'use_talos_json': True, 14:07:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:32 INFO - 'work_dir': 'build'} 14:07:32 INFO - [mozharness: 2017-04-05 21:07:32.495816Z] Running clobber step. 14:07:32 INFO - Running pre-action listener: _resource_record_pre_action 14:07:32 INFO - Running main action method: clobber 14:07:32 INFO - rmtree: /builds/slave/test/build 14:07:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:33 INFO - Running post-action listener: _resource_record_post_action 14:07:33 INFO - [mozharness: 2017-04-05 21:07:33.419532Z] Finished clobber step (success) 14:07:33 INFO - [mozharness: 2017-04-05 21:07:33.419633Z] Running read-buildbot-config step. 14:07:33 INFO - Running pre-action listener: _resource_record_pre_action 14:07:33 INFO - Running main action method: read_buildbot_config 14:07:33 INFO - Using buildbot properties: 14:07:33 INFO - { 14:07:33 INFO - "project": "", 14:07:33 INFO - "product": "firefox", 14:07:33 INFO - "who": "kwierso@gmail.com", 14:07:33 INFO - "installer_path": "public/build/target.tar.bz2", 14:07:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 14:07:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:07:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 14:07:33 INFO - "stage_platform": "linux64-stylo", 14:07:33 INFO - "basedir": "/builds/slave/test", 14:07:33 INFO - "buildnumber": 11, 14:07:33 INFO - "platform": "ubuntu64_hw_stylo", 14:07:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:07:33 INFO - "slavebuilddir": "test", 14:07:33 INFO - "taskId": "CzJtS8yESZyGnUN1wgy_1g", 14:07:33 INFO - "branch": "mozilla-central", 14:07:33 INFO - "script_repo_revision": "production", 14:07:33 INFO - "revision": "9ffcfb1564d12239e9878026a92ffb58ba391d89", 14:07:33 INFO - "slavename": "talos-linux64-ix-032", 14:07:33 INFO - "repo_path": "mozilla-central" 14:07:33 INFO - } 14:07:33 INFO - Finding installer, test and symbols from parent task. 14:07:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CzJtS8yESZyGnUN1wgy_1g'}, attempt #1 14:07:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CzJtS8yESZyGnUN1wgy_1g'}, attempt #1 14:07:34 INFO - Task dependencies: DJW-VgxJRgO3FiZj1UKV6w 14:07:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w'}, attempt #1 14:07:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.tar.bz2 14:07:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/test_packages.json 14:07:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.crashreporter-symbols.zip 14:07:34 INFO - Running post-action listener: _resource_record_post_action 14:07:34 INFO - [mozharness: 2017-04-05 21:07:34.813743Z] Finished read-buildbot-config step (success) 14:07:34 INFO - [mozharness: 2017-04-05 21:07:34.813961Z] Running download-and-extract step. 14:07:34 INFO - Running pre-action listener: _resource_record_pre_action 14:07:34 INFO - Running main action method: download_and_extract 14:07:34 INFO - mkdir: /builds/slave/test/build/tests 14:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:34 INFO - trying https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.test_packages.json 14:07:34 INFO - Downloading https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:07:35 INFO - Downloaded 986 bytes. 14:07:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:07:35 INFO - Using the following test package requirements: 14:07:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:07:35 INFO - u'common': [u'target.common.tests.zip'], 14:07:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:07:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:07:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:07:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:07:35 INFO - u'mozbase': [u'target.common.tests.zip'], 14:07:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:07:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:07:35 INFO - u'web-platform': [u'target.common.tests.zip', 14:07:35 INFO - u'target.web-platform.tests.zip'], 14:07:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:07:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:07:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.common.tests.zip 14:07:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:07:35 INFO - Fetch https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.common.tests.zip into memory 14:07:36 INFO - Expected file size: 58243126 14:07:36 INFO - Obtained file size: 58243126 14:07:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:07:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.common.tests.zip 14:07:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:07:46 INFO - Fetch https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.common.tests.zip into memory 14:07:47 INFO - Expected file size: 58243126 14:07:47 INFO - Obtained file size: 58243126 14:07:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.talos.tests.zip 14:07:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:07:58 INFO - Fetch https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.talos.tests.zip into memory 14:07:58 INFO - Expected file size: 14404152 14:07:58 INFO - Obtained file size: 14404152 14:07: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')]} 14:07:59 INFO - trying https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.tar.bz2 14:07:59 INFO - Downloading https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:08:00 INFO - Downloaded 58955996 bytes. 14:08:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.tar.bz2 14:08:00 INFO - mkdir: /builds/slave/test/properties 14:08:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:08:00 INFO - Writing to file /builds/slave/test/properties/build_url 14:08:00 INFO - Contents: 14:08:00 INFO - build_url:https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.tar.bz2 14:08:00 INFO - Running post-action listener: _resource_record_post_action 14:08:00 INFO - Running post-action listener: set_extra_try_arguments 14:08:00 INFO - [mozharness: 2017-04-05 21:08:00.162609Z] Finished download-and-extract step (success) 14:08:00 INFO - [mozharness: 2017-04-05 21:08:00.162705Z] Running populate-webroot step. 14:08:00 INFO - Running pre-action listener: _resource_record_pre_action 14:08:00 INFO - Running main action method: populate_webroot 14:08:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:08:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:08:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:08:00 INFO - '--tppagecycles', 14:08:00 INFO - '7'], 14:08:00 INFO - 'tests': ['tsvgm']}}, 14:08:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:08:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:08:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:08:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:08:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:08:00 INFO - 'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:08:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:08:00 INFO - 'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['damp', 'tps']}, 14:08:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:08:00 INFO - 'tests': ['damp', 'tps']}, 14:08:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['dromaeo_dom']}, 14:08:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:08:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['basic_compositor_video']}, 14:08:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:08:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['a11yr', 14:08:00 INFO - 'ts_paint', 14:08:00 INFO - 'tpaint', 14:08:00 INFO - 'sessionrestore', 14:08:00 INFO - 'sessionrestore_no_auto_restore', 14:08:00 INFO - 'tabpaint']}, 14:08:00 INFO - 'other-e10s': {'tests': ['a11yr', 14:08:00 INFO - 'ts_paint', 14:08:00 INFO - 'tpaint', 14:08:00 INFO - 'sessionrestore', 14:08:00 INFO - 'sessionrestore_no_auto_restore', 14:08:00 INFO - 'tabpaint']}, 14:08:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:08:00 INFO - 'ts_paint', 14:08:00 INFO - 'tpaint', 14:08:00 INFO - 'sessionrestore', 14:08:00 INFO - 'sessionrestore_no_auto_restore', 14:08:00 INFO - 'tabpaint']}, 14:08:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:08:00 INFO - 'ts_paint', 14:08:00 INFO - 'tpaint', 14:08:00 INFO - 'sessionrestore', 14:08:00 INFO - 'sessionrestore_no_auto_restore', 14:08:00 INFO - 'tabpaint']}, 14:08:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['a11yr', 14:08:00 INFO - 'ts_paint', 14:08:00 INFO - 'tpaint', 14:08:00 INFO - 'sessionrestore', 14:08:00 INFO - 'sessionrestore_no_auto_restore', 14:08:00 INFO - 'tabpaint']}, 14:08:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['a11yr', 14:08:00 INFO - 'ts_paint', 14:08:00 INFO - 'tpaint', 14:08:00 INFO - 'sessionrestore', 14:08:00 INFO - 'sessionrestore_no_auto_restore', 14:08:00 INFO - 'tabpaint']}, 14:08:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['tsvgx', 14:08:00 INFO - 'tsvgr_opacity', 14:08:00 INFO - 'tart', 14:08:00 INFO - 'tscrollx', 14:08:00 INFO - 'cart', 14:08:00 INFO - 'tsvg_static']}, 14:08:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:08:00 INFO - 'tsvgr_opacity', 14:08:00 INFO - 'tart', 14:08:00 INFO - 'tscrollx', 14:08:00 INFO - 'cart', 14:08:00 INFO - 'tsvg_static']}, 14:08:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:08:00 INFO - 'talos_options': ['--disable-e10s'], 14:08:00 INFO - 'tests': ['tp5o']}, 14:08:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:08:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:08:00 INFO - 'talos_options': ['--disable-e10s', 14:08:00 INFO - '--xperf_path', 14:08:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:00 INFO - 'tests': ['tp5n']}, 14:08:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:08:00 INFO - 'talos_options': ['--xperf_path', 14:08:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:00 INFO - 'tests': ['tp5n']}}, 14:08:00 INFO - 'talos.zip': {'path': '', 14:08:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:08:00 INFO - Running post-action listener: _resource_record_post_action 14:08:00 INFO - [mozharness: 2017-04-05 21:08:00.175793Z] Finished populate-webroot step (success) 14:08:00 INFO - [mozharness: 2017-04-05 21:08:00.175883Z] Running create-virtualenv step. 14:08:00 INFO - Running pre-action listener: _resource_record_pre_action 14:08:00 INFO - Running main action method: create_virtualenv 14:08:00 INFO - Creating virtualenv /builds/slave/test/build/venv 14:08:00 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 14:08:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:08:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:08:00 INFO - Using real prefix '/usr' 14:08:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:08:00 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:02 INFO - Installing pip.................done. 14:08:02 INFO - Return code: 0 14:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:08:02 INFO - Reading from file tmpfile_stdout 14:08:02 INFO - Output received: 14:08:02 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) 14:08:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:02 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:02 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 14:08:02 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 14:08:02 INFO - Using env: {'DISPLAY': ':0', 14:08:02 INFO - 'HOME': '/home/cltbld', 14:08:02 INFO - 'LANG': 'en_US.UTF-8', 14:08:02 INFO - 'LANGUAGE': 'en_US:en', 14:08:02 INFO - 'LOGNAME': 'cltbld', 14:08:02 INFO - 'MAIL': '/var/mail/cltbld', 14:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:02 INFO - 'MOZ_NO_REMOTE': '1', 14:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:02 INFO - 'NO_EM_RESTART': '1', 14:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:02 INFO - 'PWD': '/builds/slave/test', 14:08:02 INFO - 'SHELL': '/bin/bash', 14:08:02 INFO - 'SHLVL': '1', 14:08:02 INFO - 'TERM': 'linux', 14:08:02 INFO - 'TMOUT': '86400', 14:08:02 INFO - 'USER': 'cltbld', 14:08:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:02 INFO - '_': '/tools/buildbot/bin/python'} 14:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:03 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 14:08:03 INFO - Cleaning up... 14:08:03 INFO - Return code: 0 14:08:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:03 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:03 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 14:08:03 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 14:08:03 INFO - Using env: {'DISPLAY': ':0', 14:08:03 INFO - 'HOME': '/home/cltbld', 14:08:03 INFO - 'LANG': 'en_US.UTF-8', 14:08:03 INFO - 'LANGUAGE': 'en_US:en', 14:08:03 INFO - 'LOGNAME': 'cltbld', 14:08:03 INFO - 'MAIL': '/var/mail/cltbld', 14:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:03 INFO - 'MOZ_NO_REMOTE': '1', 14:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:03 INFO - 'NO_EM_RESTART': '1', 14:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:03 INFO - 'PWD': '/builds/slave/test', 14:08:03 INFO - 'SHELL': '/bin/bash', 14:08:03 INFO - 'SHLVL': '1', 14:08:03 INFO - 'TERM': 'linux', 14:08:03 INFO - 'TMOUT': '86400', 14:08:03 INFO - 'USER': 'cltbld', 14:08:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:03 INFO - '_': '/tools/buildbot/bin/python'} 14:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:03 INFO - Downloading/unpacking psutil>=3.1.1 14:08:03 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 14:08:03 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 14:08:03 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 14:08:03 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 14:08:03 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 14:08:03 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 14:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:05 INFO - Installing collected packages: psutil 14:08:05 INFO - Running setup.py install for psutil 14:08:05 INFO - building 'psutil._psutil_linux' extension 14:08:05 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 14:08:05 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 14:08:05 INFO - building 'psutil._psutil_posix' extension 14:08:05 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 14:08:05 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 14:08:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:06 INFO - Successfully installed psutil 14:08:06 INFO - Cleaning up... 14:08:06 INFO - Return code: 0 14:08:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:06 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:06 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 14:08:06 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 14:08:06 INFO - Using env: {'DISPLAY': ':0', 14:08:06 INFO - 'HOME': '/home/cltbld', 14:08:06 INFO - 'LANG': 'en_US.UTF-8', 14:08:06 INFO - 'LANGUAGE': 'en_US:en', 14:08:06 INFO - 'LOGNAME': 'cltbld', 14:08:06 INFO - 'MAIL': '/var/mail/cltbld', 14:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:06 INFO - 'MOZ_NO_REMOTE': '1', 14:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:06 INFO - 'NO_EM_RESTART': '1', 14:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:06 INFO - 'PWD': '/builds/slave/test', 14:08:06 INFO - 'SHELL': '/bin/bash', 14:08:06 INFO - 'SHLVL': '1', 14:08:06 INFO - 'TERM': 'linux', 14:08:06 INFO - 'TMOUT': '86400', 14:08:06 INFO - 'USER': 'cltbld', 14:08:06 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:06 INFO - '_': '/tools/buildbot/bin/python'} 14:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:08:06 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 14:08:06 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 14:08:06 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 14:08:06 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 14:08:06 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 14:08:06 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 14:08:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:08:08 INFO - Installing collected packages: mozsystemmonitor 14:08:08 INFO - Running setup.py install for mozsystemmonitor 14:08:08 INFO - Successfully installed mozsystemmonitor 14:08:08 INFO - Cleaning up... 14:08:08 INFO - Return code: 0 14:08:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:08:08 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')]} 14:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:08 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')]} 14:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:08 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:08 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 14:08:08 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 14:08:08 INFO - Using env: {'DISPLAY': ':0', 14:08:08 INFO - 'HOME': '/home/cltbld', 14:08:08 INFO - 'LANG': 'en_US.UTF-8', 14:08:08 INFO - 'LANGUAGE': 'en_US:en', 14:08:08 INFO - 'LOGNAME': 'cltbld', 14:08:08 INFO - 'MAIL': '/var/mail/cltbld', 14:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:08 INFO - 'MOZ_NO_REMOTE': '1', 14:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:08 INFO - 'NO_EM_RESTART': '1', 14:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:08 INFO - 'PWD': '/builds/slave/test', 14:08:08 INFO - 'SHELL': '/bin/bash', 14:08:08 INFO - 'SHLVL': '1', 14:08:08 INFO - 'TERM': 'linux', 14:08:08 INFO - 'TMOUT': '86400', 14:08:08 INFO - 'USER': 'cltbld', 14:08:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:08 INFO - '_': '/tools/buildbot/bin/python'} 14:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:08 INFO - Downloading/unpacking jsonschema==2.5.1 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:08:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:08:10 INFO - warning: no files found matching '*.txt' 14:08:11 INFO - no previously-included directories found matching 'build' 14:08:11 INFO - no previously-included directories found matching 'dist' 14:08:11 INFO - no previously-included directories found matching '.git*' 14:08:11 INFO - Installing collected packages: jsonschema, functools32 14:08:11 INFO - Running setup.py install for functools32 14:08:11 INFO - warning: no files found matching '*.txt' 14:08:11 INFO - no previously-included directories found matching 'build' 14:08:11 INFO - no previously-included directories found matching 'dist' 14:08:11 INFO - no previously-included directories found matching '.git*' 14:08:11 INFO - Successfully installed jsonschema functools32 14:08:11 INFO - Cleaning up... 14:08:11 INFO - Return code: 0 14:08:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:08:11 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')]} 14:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:11 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')]} 14:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:11 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:11 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 14:08:11 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 14:08:11 INFO - Using env: {'DISPLAY': ':0', 14:08:11 INFO - 'HOME': '/home/cltbld', 14:08:11 INFO - 'LANG': 'en_US.UTF-8', 14:08:11 INFO - 'LANGUAGE': 'en_US:en', 14:08:11 INFO - 'LOGNAME': 'cltbld', 14:08:11 INFO - 'MAIL': '/var/mail/cltbld', 14:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:11 INFO - 'MOZ_NO_REMOTE': '1', 14:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:11 INFO - 'NO_EM_RESTART': '1', 14:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:11 INFO - 'PWD': '/builds/slave/test', 14:08:11 INFO - 'SHELL': '/bin/bash', 14:08:11 INFO - 'SHLVL': '1', 14:08:11 INFO - 'TERM': 'linux', 14:08:11 INFO - 'TMOUT': '86400', 14:08:11 INFO - 'USER': 'cltbld', 14:08:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:11 INFO - '_': '/tools/buildbot/bin/python'} 14:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:08:11 INFO - Cleaning up... 14:08:11 INFO - Return code: 0 14:08:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:08:11 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')]} 14:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:11 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')]} 14:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:11 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:11 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 14:08:11 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 14:08:11 INFO - Using env: {'DISPLAY': ':0', 14:08:11 INFO - 'HOME': '/home/cltbld', 14:08:11 INFO - 'LANG': 'en_US.UTF-8', 14:08:11 INFO - 'LANGUAGE': 'en_US:en', 14:08:11 INFO - 'LOGNAME': 'cltbld', 14:08:11 INFO - 'MAIL': '/var/mail/cltbld', 14:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:11 INFO - 'MOZ_NO_REMOTE': '1', 14:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:11 INFO - 'NO_EM_RESTART': '1', 14:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:11 INFO - 'PWD': '/builds/slave/test', 14:08:11 INFO - 'SHELL': '/bin/bash', 14:08:11 INFO - 'SHLVL': '1', 14:08:11 INFO - 'TERM': 'linux', 14:08:11 INFO - 'TMOUT': '86400', 14:08:11 INFO - 'USER': 'cltbld', 14:08:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:11 INFO - '_': '/tools/buildbot/bin/python'} 14:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:13 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:08:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08:14 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 14:08:14 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 14:08:14 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 14:08:14 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 14:08:14 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 14:08:14 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 14:08:14 INFO - Downloading docopt-0.6.1.tar.gz 14:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:14 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:14 INFO - Running setup.py install for blobuploader 14:08:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:08:14 INFO - Running setup.py install for requests 14:08:14 INFO - Running setup.py install for docopt 14:08:15 INFO - Successfully installed blobuploader requests docopt 14:08:15 INFO - Cleaning up... 14:08:15 INFO - Return code: 0 14:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:15 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')]} 14:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:15 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')]} 14:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:15 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:15 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 14:08:15 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 14:08:15 INFO - Using env: {'DISPLAY': ':0', 14:08:15 INFO - 'HOME': '/home/cltbld', 14:08:15 INFO - 'LANG': 'en_US.UTF-8', 14:08:15 INFO - 'LANGUAGE': 'en_US:en', 14:08:15 INFO - 'LOGNAME': 'cltbld', 14:08:15 INFO - 'MAIL': '/var/mail/cltbld', 14:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:15 INFO - 'MOZ_NO_REMOTE': '1', 14:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:15 INFO - 'NO_EM_RESTART': '1', 14:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:15 INFO - 'PWD': '/builds/slave/test', 14:08:15 INFO - 'SHELL': '/bin/bash', 14:08:15 INFO - 'SHLVL': '1', 14:08:15 INFO - 'TERM': 'linux', 14:08:15 INFO - 'TMOUT': '86400', 14:08:15 INFO - 'USER': 'cltbld', 14:08:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:15 INFO - '_': '/tools/buildbot/bin/python'} 14:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:15 INFO - Running setup.py (path:/tmp/pip-JLE57u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:15 INFO - Running setup.py (path:/tmp/pip-fW6ZMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:15 INFO - Running setup.py (path:/tmp/pip-dRdKde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:15 INFO - Running setup.py (path:/tmp/pip-Mpz92B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:15 INFO - Running setup.py (path:/tmp/pip-CRlS7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:15 INFO - Running setup.py (path:/tmp/pip-jrwX5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:15 INFO - Running setup.py (path:/tmp/pip-OiYUcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:15 INFO - Running setup.py (path:/tmp/pip-1KGWf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:15 INFO - Running setup.py (path:/tmp/pip-QkyiHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:15 INFO - Running setup.py (path:/tmp/pip-UavmW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:16 INFO - Running setup.py (path:/tmp/pip-BLBP0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:16 INFO - Running setup.py (path:/tmp/pip-5o4XS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:16 INFO - Running setup.py (path:/tmp/pip-QmKyr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:16 INFO - Running setup.py (path:/tmp/pip-8prOXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:16 INFO - Running setup.py (path:/tmp/pip-DjqetA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:16 INFO - Running setup.py (path:/tmp/pip-EcB9cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:16 INFO - Running setup.py (path:/tmp/pip-gjd51G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:16 INFO - Running setup.py install for manifestparser 14:08:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:16 INFO - Running setup.py install for mozcrash 14:08:16 INFO - Running setup.py install for mozdebug 14:08:16 INFO - Running setup.py install for mozdevice 14:08:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:16 INFO - Running setup.py install for mozfile 14:08:17 INFO - Running setup.py install for mozhttpd 14:08:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozinfo 14:08:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozInstall 14:08:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozleak 14:08:17 INFO - Running setup.py install for mozlog 14:08:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for moznetwork 14:08:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozprocess 14:08:17 INFO - Running setup.py install for mozprofile 14:08:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozrunner 14:08:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozscreenshot 14:08:18 INFO - Running setup.py install for moztest 14:08:18 INFO - Running setup.py install for mozversion 14:08:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:18 INFO - Cleaning up... 14:08:18 INFO - Return code: 0 14:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:18 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')]} 14:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:18 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')]} 14:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:18 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:18 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 14:08:18 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 14:08:18 INFO - Using env: {'DISPLAY': ':0', 14:08:18 INFO - 'HOME': '/home/cltbld', 14:08:18 INFO - 'LANG': 'en_US.UTF-8', 14:08:18 INFO - 'LANGUAGE': 'en_US:en', 14:08:18 INFO - 'LOGNAME': 'cltbld', 14:08:18 INFO - 'MAIL': '/var/mail/cltbld', 14:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:18 INFO - 'MOZ_NO_REMOTE': '1', 14:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:18 INFO - 'NO_EM_RESTART': '1', 14:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:18 INFO - 'PWD': '/builds/slave/test', 14:08:18 INFO - 'SHELL': '/bin/bash', 14:08:18 INFO - 'SHLVL': '1', 14:08:18 INFO - 'TERM': 'linux', 14:08:18 INFO - 'TMOUT': '86400', 14:08:18 INFO - 'USER': 'cltbld', 14:08:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:18 INFO - '_': '/tools/buildbot/bin/python'} 14:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:18 INFO - Running setup.py (path:/tmp/pip-8pZKry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:18 INFO - Running setup.py (path:/tmp/pip-UaGqRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:18 INFO - Running setup.py (path:/tmp/pip-_y8O94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:18 INFO - Running setup.py (path:/tmp/pip-GRqzDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:18 INFO - Running setup.py (path:/tmp/pip-4VhBWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:18 INFO - Running setup.py (path:/tmp/pip-qbiAG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:18 INFO - Running setup.py (path:/tmp/pip-xDfTeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:19 INFO - Running setup.py (path:/tmp/pip-0Cr8jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:19 INFO - Running setup.py (path:/tmp/pip-xGATsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:19 INFO - Running setup.py (path:/tmp/pip-hqzcPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:19 INFO - Running setup.py (path:/tmp/pip-I663N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:19 INFO - Running setup.py (path:/tmp/pip-a8wdzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:19 INFO - Running setup.py (path:/tmp/pip-ZtYUk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:19 INFO - Running setup.py (path:/tmp/pip-xuQdCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:19 INFO - Running setup.py (path:/tmp/pip-6u6Ac0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:19 INFO - Running setup.py (path:/tmp/pip-iYnoOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:19 INFO - Running setup.py (path:/tmp/pip-CHAz4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:19 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)) 14:08:19 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)) 14:08:19 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)) 14:08:19 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)) 14:08:19 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)) 14:08:19 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)) 14:08:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:19 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 14:08:19 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 14:08:19 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 14:08:19 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 14:08:19 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 14:08:19 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 14:08:21 INFO - Downloading blessings-1.6.tar.gz 14:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:21 INFO - Installing collected packages: blessings 14:08:21 INFO - Running setup.py install for blessings 14:08:22 INFO - Successfully installed blessings 14:08:22 INFO - Cleaning up... 14:08:22 INFO - Return code: 0 14:08:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:22 INFO - Reading from file tmpfile_stdout 14:08:22 INFO - Current package versions: 14:08:22 INFO - argparse == 1.2.1 14:08:22 INFO - blessings == 1.6 14:08:22 INFO - blobuploader == 1.2.4 14:08:22 INFO - docopt == 0.6.1 14:08:22 INFO - functools32 == 3.2.3-2 14:08:22 INFO - jsonschema == 2.5.1 14:08:22 INFO - manifestparser == 1.1 14:08:22 INFO - mozInstall == 1.12 14:08:22 INFO - mozcrash == 1.0 14:08:22 INFO - mozdebug == 0.1 14:08:22 INFO - mozdevice == 0.49 14:08:22 INFO - mozfile == 1.2 14:08:22 INFO - mozhttpd == 0.7 14:08:22 INFO - mozinfo == 0.9 14:08:22 INFO - mozleak == 0.1 14:08:22 INFO - mozlog == 3.4 14:08:22 INFO - moznetwork == 0.27 14:08:22 INFO - mozprocess == 0.25 14:08:22 INFO - mozprofile == 0.28 14:08:22 INFO - mozrunner == 6.13 14:08:22 INFO - mozscreenshot == 0.1 14:08:22 INFO - mozsystemmonitor == 0.3 14:08:22 INFO - moztest == 0.8 14:08:22 INFO - mozversion == 1.4 14:08:22 INFO - psutil == 3.1.1 14:08:22 INFO - requests == 1.2.3 14:08:22 INFO - wsgiref == 0.1.2 14:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:22 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:22 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 14:08:22 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 14:08:22 INFO - Using env: {'DISPLAY': ':0', 14:08:22 INFO - 'HOME': '/home/cltbld', 14:08:22 INFO - 'LANG': 'en_US.UTF-8', 14:08:22 INFO - 'LANGUAGE': 'en_US:en', 14:08:22 INFO - 'LOGNAME': 'cltbld', 14:08:22 INFO - 'MAIL': '/var/mail/cltbld', 14:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:22 INFO - 'MOZ_NO_REMOTE': '1', 14:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:22 INFO - 'NO_EM_RESTART': '1', 14:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:22 INFO - 'PWD': '/builds/slave/test', 14:08:22 INFO - 'SHELL': '/bin/bash', 14:08:22 INFO - 'SHLVL': '1', 14:08:22 INFO - 'TERM': 'linux', 14:08:22 INFO - 'TMOUT': '86400', 14:08:22 INFO - 'USER': 'cltbld', 14:08:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:22 INFO - '_': '/tools/buildbot/bin/python'} 14:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 INFO - Cleaning up... 14:08:22 INFO - Return code: 0 14:08:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:22 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, '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': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', '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 14:08:22 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 14:08:22 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 14:08:22 INFO - Using env: {'DISPLAY': ':0', 14:08:22 INFO - 'HOME': '/home/cltbld', 14:08:22 INFO - 'LANG': 'en_US.UTF-8', 14:08:22 INFO - 'LANGUAGE': 'en_US:en', 14:08:22 INFO - 'LOGNAME': 'cltbld', 14:08:22 INFO - 'MAIL': '/var/mail/cltbld', 14:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:22 INFO - 'MOZ_NO_REMOTE': '1', 14:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:22 INFO - 'NO_EM_RESTART': '1', 14:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:22 INFO - 'PWD': '/builds/slave/test', 14:08:22 INFO - 'SHELL': '/bin/bash', 14:08:22 INFO - 'SHLVL': '1', 14:08:22 INFO - 'TERM': 'linux', 14:08:22 INFO - 'TMOUT': '86400', 14:08:22 INFO - 'USER': 'cltbld', 14:08:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:22 INFO - '_': '/tools/buildbot/bin/python'} 14:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:08:22 INFO - Cleaning up... 14:08:22 INFO - Return code: 0 14:08:22 INFO - Running post-action listener: _resource_record_post_action 14:08:22 INFO - Running post-action listener: _start_resource_monitoring 14:08:22 INFO - Starting resource monitoring. 14:08:22 INFO - [mozharness: 2017-04-05 21:08:22.800764Z] Finished create-virtualenv step (success) 14:08:22 INFO - [mozharness: 2017-04-05 21:08:22.801225Z] Running install step. 14:08:22 INFO - Running pre-action listener: _resource_record_pre_action 14:08:22 INFO - Running main action method: install 14:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:23 INFO - Reading from file tmpfile_stdout 14:08:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:08:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:08:23 INFO - Reading from file tmpfile_stdout 14:08:23 INFO - Output received: 14:08:23 INFO - Usage: mozinstall [options] installer 14:08:23 INFO - Options: 14:08:23 INFO - -h, --help show this help message and exit 14:08:23 INFO - -d DEST, --destination=DEST 14:08:23 INFO - Directory to install application into. [default: 14:08:23 INFO - "/builds/slave/test"] 14:08:23 INFO - --app=APP Application being installed. [default: firefox] 14:08:23 INFO - mkdir: /builds/slave/test/build/application 14:08:23 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'] 14:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:08:38 INFO - Reading from file tmpfile_stdout 14:08:38 INFO - Output received: 14:08:38 INFO - /builds/slave/test/build/application/firefox/firefox 14:08:38 INFO - Running post-action listener: _resource_record_post_action 14:08:38 INFO - [mozharness: 2017-04-05 21:08:38.265929Z] Finished install step (success) 14:08:38 INFO - [mozharness: 2017-04-05 21:08:38.266203Z] Running run-tests step. 14:08:38 INFO - Running pre-action listener: _resource_record_pre_action 14:08:38 INFO - Running main action method: run_tests 14:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:38 INFO - Python 2.7.3 14:08:38 INFO - Return code: 0 14:08:38 INFO - grabbing minidump binary from tooltool 14:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:38 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 0x2555400>, '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 0x25563b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:38 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 14:08:38 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 14:08:38 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 14:08:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:38 INFO - Return code: 0 14:08:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:08:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:38 INFO - ENV: RUST_BACKTRACE is now 1 14:08:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:08:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:38 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/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 14:08:38 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/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 14:08:38 INFO - Using env: {'DISPLAY': ':0', 14:08:38 INFO - 'HOME': '/home/cltbld', 14:08:38 INFO - 'LANG': 'en_US.UTF-8', 14:08:38 INFO - 'LANGUAGE': 'en_US:en', 14:08:38 INFO - 'LOGNAME': 'cltbld', 14:08:38 INFO - 'MAIL': '/var/mail/cltbld', 14:08:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:38 INFO - 'MOZ_NO_REMOTE': '1', 14:08:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:38 INFO - 'NO_EM_RESTART': '1', 14:08:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:38 INFO - 'PWD': '/builds/slave/test', 14:08:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:38 INFO - 'RUST_BACKTRACE': '1', 14:08:38 INFO - 'SHELL': '/bin/bash', 14:08:38 INFO - 'SHLVL': '1', 14:08:38 INFO - 'TERM': 'linux', 14:08:38 INFO - 'TMOUT': '86400', 14:08:38 INFO - 'USER': 'cltbld', 14:08:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1491426450.696988-566554197', 14:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:38 INFO - '_': '/tools/buildbot/bin/python'} 14:08:38 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/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 14:08:38 INFO - mozversion application_buildid: 20170405202045 14:08:38 INFO - mozversion application_changeset: 9ffcfb1564d12239e9878026a92ffb58ba391d89 14:08:38 INFO - mozversion application_display_name: Nightly 14:08:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:38 INFO - mozversion application_name: Firefox 14:08:38 INFO - mozversion application_remotingname: firefox 14:08:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:08:38 INFO - mozversion application_vendor: Mozilla 14:08:38 INFO - mozversion application_version: 55.0a1 14:08:38 INFO - mozversion platform_buildid: 20170405202045 14:08:38 INFO - mozversion platform_changeset: 9ffcfb1564d12239e9878026a92ffb58ba391d89 14:08:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:08:38 INFO - mozversion platform_version: 55.0a1 14:08:38 INFO - using testdate: 1491426518 14:08:38 INFO - actual date: 1491426518 14:08:38 INFO - starting webserver on 'localhost:36731' 14:08:38 INFO - SUITE-START | Running 2 tests 14:08:38 INFO - TEST-START | dromaeo_css 14:08:38 INFO - operating with platform_type : linux_ 14:08:38 INFO - Initialising browser for dromaeo_css test... 14:08:38 INFO - TEST-INFO | started process 30047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PxqG8/profile http://localhost:36731/getInfo.html) 14:08:42 INFO - PID 30047 | __metrics Screen width/height:1600/1200 14:08:42 INFO - PID 30047 | colorDepth:24 14:08:42 INFO - PID 30047 | Browser inner width/height: 1024/697 14:08:42 INFO - PID 30047 | __metrics 14:08:43 INFO - PID 30047 | 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" 14:08:43 INFO - PID 30047 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:45 INFO - TEST-INFO | 30047: exit 0 14:08:45 INFO - Browser initialized. 14:08:45 INFO - Running cycle 1/1 for dromaeo_css test... 14:08:45 INFO - TEST-INFO | started process 30145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PxqG8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:57 INFO - PID 30145 | RSS: Main: 171048960 14:08:57 INFO - PID 30145 | 14:12:04 INFO - PID 30145 | Cycle 1(1): loaded http://localhost:36731/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36731/tests/dromaeo/cssquery-ext.html) 14:12:06 INFO - PID 30145 | RSS: Main: 337874944 14:12:06 INFO - PID 30145 | 14:13:47 INFO - PID 30145 | ************************* 14:13:47 INFO - PID 30145 | A coding exception was thrown and uncaught in a Task. 14:13:47 INFO - PID 30145 | 14:13:47 ERROR - PID 30145 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:13:47 INFO - PID 30145 | Full stack: 14:13:47 INFO - PID 30145 | ************************* 14:13:47 INFO - PID 30145 | ************************* 14:13:47 INFO - PID 30145 | A coding exception was thrown and uncaught in a Task. 14:13:47 INFO - PID 30145 | 14:13:47 ERROR - PID 30145 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:13:47 INFO - PID 30145 | Full stack: 14:13:47 INFO - PID 30145 | ************************* 14:13:47 INFO - PID 30145 | ************************* 14:13:47 INFO - PID 30145 | A coding exception was thrown and uncaught in a Task. 14:13:47 INFO - PID 30145 | 14:13:47 ERROR - PID 30145 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:13:47 INFO - PID 30145 | Full stack: 14:13:47 INFO - PID 30145 | ************************* 14:13:47 INFO - PID 30145 | ************************* 14:13:47 INFO - PID 30145 | A coding exception was thrown and uncaught in a Task. 14:13:47 INFO - PID 30145 | 14:13:47 ERROR - PID 30145 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:13:47 INFO - PID 30145 | Full stack: 14:13:47 INFO - PID 30145 | ************************* 14:15:09 INFO - PID 30145 | Cycle 1(1): loaded http://localhost:36731/tests/dromaeo/cssquery-ext.html (next: http://localhost:36731/tests/dromaeo/cssquery-jquery.html) 14:15:09 INFO - PID 30145 | RSS: Main: 253833216 14:15:09 INFO - PID 30145 | 14:18:11 INFO - PID 30145 | Cycle 1(1): loaded http://localhost:36731/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36731/tests/dromaeo/cssquery-mootools.html) 14:18:12 INFO - PID 30145 | RSS: Main: 201367552 14:18:12 INFO - PID 30145 | 14:21:14 INFO - PID 30145 | Cycle 1(1): loaded http://localhost:36731/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36731/tests/dromaeo/cssquery-prototype.html) 14:21:15 INFO - PID 30145 | RSS: Main: 265900032 14:21:15 INFO - PID 30145 | 14:24:18 INFO - PID 30145 | Cycle 1(1): loaded http://localhost:36731/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36731/tests/dromaeo/cssquery-yui.html) 14:24:19 INFO - PID 30145 | RSS: Main: 213159936 14:24:19 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | Cycle 1(1): loaded http://localhost:36731/tests/dromaeo/cssquery-yui.html (next: http://localhost:36731/tests/dromaeo/cssquery-dojo.html) 14:27:22 INFO - PID 30145 | RSS: Main: 294481920 14:27:22 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | __start_tp_report 14:27:22 INFO - PID 30145 | _x_x_mozilla_page_load 14:27:22 INFO - PID 30145 | _x_x_mozilla_page_load_details 14:27:22 INFO - PID 30145 | |i|pagename|runs| 14:27:22 INFO - PID 30145 | |0;dojo.html;2626.9211923642297;2673.8663066846652;2675.3980354420246;2730.1127133681553;2735.8221715588493;5130.153524668434;5202.817901373448;5237.79048838046;5268.63119581629;5298.682079075254;5244.449332820056;5254.343207099113;5260.684358938466;5296.788128474856;5304.124819404803;4387.49543802462;4657.836975705843;4741.90516189676;4749.976250118744;4787.281907713854;4689.155951928668;4724.97637511812;4754.405699287589;4763.356946812188;4814.614830813544;4609.492955774862;4617.953820461786;4664.673472856902;4665.230237010889;4699.318598803155;4652.488226295105;4695.741734204617;4705.035467729107;4726.409198850144;4738.19450693383;4610.700304480198;4618.6536009799065;4636.188666983298;4655.045715628322;4658.976705116486;4998.075356059141;5106.719130447824;5116.616253780981;5121.257417674454;5163.793448262065;5588.552915766729;5593.860153496154;5608.383077861432;5609.971950140223;5613;5627.887442251132;5631.690257035862;5633.577481688849;5634.887302253973;5640;5174.53429191367;5206.114960456732;5234.9476505235225;5327.946720532823;5329.733513324319;5700.971495142498;5790.334111577223;5850.765969361263;5881.470667639933;5896.233489646319;5516.696581688046;5526.392096869341;5529.834104976857;5608.383077861432;5615.578831587565;5648.406917273709;5654.85862853432;5655.151727240865;5659.179418984307;5661;5490.039243132436;5562.972185139049;5584.329880414376;5591.273134492571;5602.243697100921;5593.720313984366;5594.216809646653;5611.775528978795;5616.66300022;5652.3217213934595;4585.518520555361;4603.125406172817;4604.286335617984;4605.884852878705;4648.349231107648;3903.531576210873;3907.8632247871756;3908.9609103909165;3937.1928754605237;3940.3498422760495;4802.063597598504;4829.73436460998;4864.027194561102;4866.31871537985;4874.317595536628;5684.971575142098;5696.914546281809;5702.429757024264;5702.429757024347;5707.34365547959;4741.2414013758325;4835.153848076572;4856.660033797601;4866.7079975200895;4912.508749125131;4936.086823937583;4954.8761280968265;5025.899482010339;5034.320366750442;5038.647294689336;5306.9203961941375;5333.813316533902;5349.625526213284;5355.919661205163;5359.732013399393;5611.775528978795;5677.233573467529;5693.202951586698;5694.288213973254;5756.597038207286;5232.607554433509;5296.126139186991;5303.946960530346;5320.813771517978;5352.973235133955;5544.279243698294;5549.112142057252;5577.051901176728;5590.776368945197;5608.9158662619275;5560.443955604407;5641.379448260606;5645.604807663424;5661.207430959586;5663.603547751618;5448.891022179455;5484.91772623403;5534.363548191848;5536.944630553643;5541.833744987657;5480.972595136999;5506.366767821752;5510.641808282448;5540.307461567304;5549.889002219852;5315.388730296066;5394.083005889087;5396.757145928521;5410.269613602113;5428.212909128233;5503.229547863222;5507.063799154073;5507.614466987273;5522.861928451821;5567.526760225264;5319.547838433777;5336.866578335573;5362.276092727432;5375.919361209507;5380.031594313061 14:27:22 INFO - PID 30145 | |1;ext.html;648.2642201101748;706.9858602827943;730.5032577847063;1064.8988346107121;1079.6167360586987;27542.5868611971;33542.832285838565;34149.82925085374;34302.48546271802;34478.48282275768;36710.63289367112;37106.443403348974;37172.814135929286;37190;37240;5517.475839795213;7203.171635261946;7348.5958272295;7364.5949472778975;7371.815704607401;5667.829965101054;6921.134858142732;7047.330503602149;7073.257307982665;7099.68051437684;7162.355388015078;7222.025026621392;7224.385927196168;7225.855482890339;7227;7123.928760712379;7189.065421495225;7191.532550384209;7197.388222001084;7200.423966082727;7186.748463803742;7241.456890733163;7248.891266631004;7249.456290778213;7278.96360518194;33381.33237335264;33708.83145584256;33768.49347259793;33810.49284260738;33879.49180762266;2951.2769371503905;2988.2977500287416;2989.088328059941;2990.282332240247;2992;25720.228393148234;25782.355441114123;25783.871080644665;25813.483730325475;25875.094371697087;2888.00363874463;2920.3867187890355;2927.6047733556125;2941.132365952028;2952.852357382122;152335.2383238088;152957.23521382434;152987;153041;153136;43412.34881476781;43512.56487435148;43535.56464435315;43564.564354356684;43622.781886091005;45871.770641147246;45916;45983.31025034627;45989.54010459853;46062.30906536405;13613.795793062915;13667.794983075262;13688.726225475435;13714;13747.243901585509;8680.652773888974;8786.824263514694;11048.558057677763;11072.557097716;11092.279001864854;10292.330998485075;10395.220358472994;10399.636012739518;11691.824622630667;12034.578789742318;5063.569596584258;5147.7683504242395;5197.350331208599;5274.472552744772;5285.63000589955;869.5826003518347;889.2441424788877;900.2617853360313;908.7864351877304;930.06993006993;19524;20167.59664806725;20307.796922030888;20484.897575512026;20582.794172058388;969.3553786731885;973.4694591447678;996.4220751963844;1026.0406519903913;1028.475477506462;10610.310329828537;10809.513571889283;11279.774404511863;11314;11338.603148889913;230440;231755;232611;232737;233288;41538.792306038275;41960;41989;42046.57953420488;42055.36916946248;1238.120934136755;1313.343328335832;1315.6316231455016;1319.630503459033;1329.3751936589788;19796.20815167435;19832.70250946266;20298.79701203028;20699.689504657745;20792.37622871316;31092.378152436373;31131.221719456287;31139.688603114584;31192.688073119887;31473.213169670027;228097;229553;229684;230526;231392;29621.555676664437;29685;29886.701132988394;29972;30345.393092138474;29758.85120574383;30267.69732302737;32271;36192.93720910464;36838.8158059208;26609;27598;28213.717862821108;28286.71713282841;28332.71667283301;27232.863835680695;27253;27777.861110694317;28311.29221769472;28706;30118.3976320468;30160.396792064475;30174.54738178973;30295.848520757256;30864.537031944088;26797;26869.462610748065;26944.865275673495;27069.458610828067;27712.58431123575;20781;21866.344009679735;22119;22815.543689125792;22879.656805147602 14:27:22 INFO - PID 30145 | |2;jquery.html;402.79054891456445;403.79204709574554;412.1447995409526;418.9413482112504;421.687950916322;12044.795520447951;17781.37765178219;18592.90703546484;18633.906830465847;18815.71776423355;17844.64310713785;18119.547011324692;19321.323753668625;19982.200711971505;20130.49673758157;5413.106837371829;5505;5554.750036248379;5589.636673616202;5593.888122237553;5496.4778346057265;5585.469380408875;5585.58108141891;5587.3015873015875;5589.441055894398;5350.8394748157425;5514.641548299368;5530.695811730353;5541.639793413416;5574.247476590669;5468.453154684539;5567.415421380758;5590.440955904418;5622.943770562324;5625.6905870177125;4972;5048.899022019576;5050.141475949097;5053.1157047516535;5055.797768089272;22675.659865102036;22790.772092279032;22929.6242225467;23037.424064398358;23169.53660926789;1636.8608668263212;1666.2501874156678;1676.6730487554933;1677.4464426739146;1681.6888875557938;14761.630959226106;14973.625659358495;15021.474248401253;15028.624284392869;15151.242437878172;2052.79472052795;2114.270576651053;2115.8307335413283;2130.691049797786;2140.5183833637307;85151;86961.5651921749;87145;88163.55918220432;89549.10450895473;10769.730756731144;10800.94599527013;10940.726481837859;10952.397618131079;11111.833062601525;14279.78580321296;15262.923685381724;15277.541673749805;15295.388184472497;15300;7105.502614816914;7735.7679269622;7739.110002349802;7969.561674107979;8034.718784842503;7247.782566523013;7293.452991025694;7402.29678180572;7479.289467500579;7488.625568721543;6976.127984002;7008.614526201108;7047.577145371294;7122.394596459359;7130.500864939509;1938.9127489263017;1956.2957335359258;2026.1996511377922;2035.8880261585755;2126.5109024924354;817.4972391979009;854.8204876975781;865.6234537976001;866.0733015673295;899.5097671768901;16941.32234710598;17032.041315248658;17667.469975900745;17883.463496095137;18003;874.2175752701423;890.1587999340561;890.7951171230524;894.8926128864578;908.8000639859221;9045.864312035324;9421.293402994803;9679.806403872024;9747.756306092404;9789.9021009789;453540;453760;473388;474175;476325;86371;87106.56446717726;87275.56362218148;88077.55961220153;88261;1055.9419231942318;1070.1706177712335;1098.758273179899;1104.111190491662;1104.6244276945877;14810.62973425673;14824.110553366832;15090.24548772535;15193.924030379778;15299.578604868751;38051.61948380481;38539.229215414976;38631.80684096562;39016.60983390243;39874.401883971186;44966.29637350975;45959.54040459553;53408.46591534035;54098;54542.454575455326;6476.838079048061;8097.1093179749005;8182.22268884455;8453.154684531497;8637.481751094954;13255.469781209029;13482.595522134352;13494.32528373597;13678.384472698554;13723.45106195741;10695.197860160364;11121.332720036824;11268;11329.433528323387;11835.881641183478;10480.528376222936;11005.61480348184;11039.889601104207;11187.720306992065;11366.374849383363;10375.758058177042;11418.82871756941;11636.592719255124;12199.69500762488;12209.328486933304;7918.485298455582;7980.441369104107;7984.481008734414;8087.231712987257;8438.409311348147;10755.623553175601;10792.460376981277;10803.783924321628;11038.503267352828;11589.768204636028 14:27:22 INFO - PID 30145 | |3;mootools.html;1312.5340504121036;1353.4247944623532;1375.5804479633707;1380.7928810678397;1392.9094608850417;9795.559199836007;10247.743806404844;10295.279330446872;10314.329568578038;10337.534810933506;9964;10319.690409287714;10363.326383785048;10367.274290799647;10381.273310868242;2220.3338998300487;2282.052948026567;2282.3038973113194;2282.8173746100356;2282.82878784091;1892.7350170976074;1966.6853303471448;2183.683365911942;2282.805961493275;2284.6573014047945;2001.9699704504444;2016.8386529077638;2029.2491778042072;2145.7639659637425;2233.9553208935813;2117.4177101297114;2119.756228033765;2122.4163355077476;2122.968155477669;2124.16095642222;2095.402810199086;2108.114591871418;2122.734658167729;2123.702681624574;2125.3730149605904;9643.758906027335;9928.602855885829;9943;9943.105120539187;9962.551685174185;5601.80393686219;5762.394948530427;5787.826365209051;5806.44838740319;5806.5354771618595;3188.1551388881967;3337.0656216259486;3398.677125673057;3404.778689385182;3444.0356700123757;1058.9205809564237;1064.2124827627576;1070.68414817629;1107.6234080412698;1116.5143162724241;14251.928740356232;14653.487127950471;14658.41366345345;14662.413503459955;14683.853161468462;4713.528647135259;5003.874903127451;5056.418511871108;5059.569936555434;5091.338126043591;12434;12434.129610927148;12455.065870059781;12473.126881118234;12496.937515312366;5676.602637815313;5678.858028549319;5680.204771332017;5690.260266165372;5700.515456186271;4996;5009.89980200394;5011.774470148852;5046.7476626168545;5056.570191533688;4006.2187873364996;4070.9389359159636;4121.2993791055;4187.099773548702;4194.0563373240775;1228.8893999540085;1254.0155977557574;1259.9811002834965;1276.7765641012786;1281.4681907008487;610.9725062372204;699.646678427391;707.9646017699198;732.1616748822569;741.8664640364786;5051;5174.767135478913;5399.406065332811;5451.563874890078;5478.616496845262;843.9831203376021;845.7124577643631;856.2978357746588;856.8457677618088;861.7630151708205;3318.7345012399433;3321.485169798685;3348.6986171244703;3370.321009099675;3486.0587641336697;12608.49566017349;12784.744305113845;13022.934885325702;13026.153300035467;13035;12758.80861787074;12883.613491595268;12911.677208069874;12998.285094319903;13001.659701253677;8889.777755556162;9033.412828166149;9040;9097.454152750724;9107.635694572144;5831.067029275296;5878.147668587945;5931.051031834886;5962.16529685853;6077.969610151921;11040.061594764215;11056.281341712764;11088.390138542458;11099.889001109885;11207.215494915277;11333.150013748836;11451.141164412536;11940.76118477643;11976.341301228516;12026.218295810744;8209.589520524069;8321.459105158145;8328.250457458858;8334.458260213067;8344.499330040217;8688.26149777276;8722.302215822592;8733;8778.51718155482;8811.206991370807;7532.623368831646;7539.886901696588;7612.505187162817;7616.162222155448;7886.842263154819;6285.779997700059;7597.240275972358;7755.573443460664;8007.319377852715;8021.2379823916635;6754.223264324665;6821.863562728817;6821.931780682328;6827.668604622051;6829.385355318045;4869;5070.188769796962;5165.276861239505;5205.596263869202;5212.635115541876;5250.159974404077;5329.813456529003;5401.945980540144;5501.862453438696;5525.751341189576 14:27:22 INFO - PID 30145 | |4;prototype.html;371.75092687899104;385.1776457263741;391.7434080677157;397.4058782120729;404.07870056271713;5265.499777521139;5299.735013249337;5318.627696061272;5324.227986941891;5344.305240318763;5212.1660534314515;5226.484319547327;5227.869303267411;5237.685738855662;5241.39723931748;4032.3749818778138;4112;4115.403266526352;4137.110521237933;4145.481814773153;4103.281925663012;4110.705127884722;4112.074783173792;4126.938095928564;4137.027798467358;4103.015276333674;4115.259253334399;4115.444415003981;4115.682981445939;4128.8348466061325;4016.6544207690167;4091.9181616367505;4109.794510274489;4119.340905455143;4129.132882094764;3675.246574452231;3704.5369328833895;3708.684761795251;3711.3669985206425;3748.8687895923786;5032.622553308516;5041.495850414965;5050.671706339076;5052.924206136874;5056.924146137811;4754.809807607691;4833.516648335173;4862.270659401082;4872.975635121802;4879.194932836078;5511.173324001392;5528.944710552883;5540.390557038762;5546.362168350611;5558.388577256498;4169.874903752892;4173.351526147185;4177.4778152730905;4178.310578754502;4178.997040710238;5535.640183388107;5666.546676265889;5729.799457019026;5749.683767392792;5769.740361683735;4276.743395396286;4281.336392859112;4284.4430224070675;4290.613844753987;4302.65578753699;4341.283688191413;4348.303941649572;4359.978200108979;4363.3018717005125;4372.278574035248;4473.731576105444;4525.841595544206;4819.2530157825595;4831.057943700945;4835.347228124228;5428.267183930119;5496.972515137399;5507.531859791962;5509.889802204014;5510.752016159283;1498;1523.5353217268619;1523.6647937453743;1524.885633577464;1526.008094738429;1028.5063169678597;1079.7192729890128;1080.9675709728722;1087.6791346552786;1102.211918478276;4843.564079232886;4846.733429661332;4859.659823812299;4871.805127794849;4889.535494128123;5644.57665675076;5661.518770904437;5683.772649094072;5685.488306052475;5696;4699.8271099541025;4851.902961940741;4866;4876.609871210295;4889.168841296988;2974.6430428348303;3005.4890668586395;3008.909732708022;3016.2610160510817;3026.803257788237;5281.151596941117;5354.651947623392;5384.623076384615;5388.67667939917;5399.271098401744;5711.543076553866;5792.304923409218;5843.970780146072;5847.386024467455;5862.443067908542;5348.786048558014;5354.973225133927;5357.357117145967;5360.865978350573;5364.9731751341;5533.667979921218;5631.887362252814;5687.374388817309;5689.6586204827845;5715.942840571541;5566.443355664401;5588.329400471969;5590.357108932525;5605.551555875439;5610.635308704921;5095.286659867696;5260.447652996533;5262.605304602247;5270.420253772006;5345.625806193529;4036.5761595033273;4174;4187.790610469525;4278.743275403485;4292.313229883203;5673.347565030074;5693.174489698888;5728.54171666274;5734.483896449339;5734.627249228787;5307.150855863043;5546.278983732089;5549.7780088796;5564.081926482085;5583.274174357308;5534.225208470898;5535.944640553543;5543.77824887;5561.328484073398;5568.832935011957;5269.208469120517;5413.485718856702;5443.482869127427;5448.318960129984;5460.180972854104;5545;5555.111182210827;5563.13771365439;5575;5576.553875689854;5397.649152805055;5401.918971215357;5425.864353391197;5436.700981445901;5437.891242175056 14:27:22 INFO - PID 30145 | |5;yui.html;742.6286856571711;746.8468963862407;765.9961700191499;767.110152223421;774.8489044636294;11861.822072668907;11917.404129793498;12210.32843193624;12309.692257693561;12324.691882702926;13263.137896036751;13590.932045339785;13603.251821149834;13610.523631672893;13625;663.5156335874814;815.8776183572452;907.0521305236027;918.7519369770191;929.9023602521739;939.9812003759921;940.6284517615537;941.5904081724437;942.797298580805;943.9339246252765;986.6250824686609;987.2151639446657;987.5852142100299;987.7234374375187;987.8419452887539;977.081543349253;977.130353984954;977.2719324103552;977.8533220016983;980.1472718734675;723.424877222604;724.1238101896658;724.5869854183118;725.4160400877291;726.0561270348526;11865.466054027504;11917.404129793476;11974.161808673396;12069.879301207051;12729;13134.868651313556;13137.802932955918;13859;13872.028957972945;14007.369668364949;13427.12723672958;13621.455141794317;13732.107413018122;13741.793873091812;13852.376643051088;2743.0947787230166;2750.4911591355462;2751.339678477171;2752.0367871245103;2865.4555634429394;61699.38300617026;63427.68286158586;64030;64545.3545464544;65180.674096629686;10279.588816447407;10366.222533310032;10423.843642345371;10491.632792852213;10577.100946419641;21630.783692163193;21643.35069947904;21653.891730541247;21663;21676.24133155332;6287.779927702509;6291.55959082869;6410.487161027107;6461.967690161613;6572.4084832365315;3422.6748458896363;3460.8788692395647;3472.340255351475;3490.1798077451776;3521.454174602941;3585.4980302757635;3637.2907283079544;3641.10792855752;3664.3770559005034;3698.038509987369;648.7015972652538;661.0579923608934;661.3650895140719;661.9834504137339;664.0636702249805;513.4070148977936;524.590819161055;524.6301357542923;532.1034057612935;537.9381371142368;8248.340132789363;8584;8673.262772664395;8789.208971192624;9175.862362064574;558.6536347464598;559.7089513453063;560.1457776890275;561.3123923194137;572.699332850257;3755.248950209969;3774.471573979645;3812.5615554211067;3916.2754890345377;3935.5670876203594;64731.67634161799;64752.676236618514;65105;65744.67127664427;67429.66285168641;57557;57697;57737.422625774045;58000.70999644975;58291.417085829446;50597.74701126544;50835.237471437955;51230;51769;52243.477565224624;7617.162112167768;8006.119326873923;8031.196880311922;8109.59452027408;8138.1861813820515;26482;26527.734722652527;27388.726112739416;27541.173764787087;28130.859345703142;33237.833810830794;33361.66638333683;33443.33113337671;33585.32829343448;33960;11387.202895797214;11587.8261826071;11618.883811162119;11654.475548600503;11698.76602467963;12357.629271121881;12410.627681169579;12678.936605316914;12929.03895274597;13061;11089.722756931142;11638.185327027366;11645.534178632759;11766.352850593299;12019.158658893793;11038.944805275922;11406.657800266004;11578.189526733047;11688.123390745897;11930.245112848943;10429.322094063862;10924.726881828017;11011.504482298476;11394.658160255205;11406.201565890307;8622.223999840044;9037.1773148608;9134.634614615607;9141.314401419788;9205.309601780027;9025.025704503125;9741;9801.430101900818;9812.313138080266;9867.11195992364 14:27:22 INFO - PID 30145 | __end_tp_report 14:27:22 INFO - PID 30145 | __start_cc_report 14:27:22 INFO - PID 30145 | _x_x_mozilla_cycle_collect,1818 14:27:22 INFO - PID 30145 | __end_cc_report 14:27:22 INFO - PID 30145 | __startTimestamp1491427642665__endTimestamp 14:27:22 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | ------- Summary: start ------- 14:27:22 INFO - PID 30145 | Number of tests: 6 14:27:22 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | [#0] dojo.html Cycles:165 Average:5156.06 Median:5333.81 stddev:618.55 (11.6%) stddev-sans-first:587.77 14:27:22 INFO - PID 30145 | Values: 2626.9 2673.9 2675.4 2730.1 2735.8 5130.2 5202.8 5237.8 5268.6 5298.7 5244.4 5254.3 5260.7 5296.8 5304.1 4387.5 4657.8 4741.9 4750.0 4787.3 4689.2 4725.0 4754.4 4763.4 4814.6 4609.5 4618.0 4664.7 4665.2 4699.3 4652.5 4695.7 4705.0 4726.4 4738.2 4610.7 4618.7 4636.2 4655.0 4659.0 4998.1 5106.7 5116.6 5121.3 5163.8 5588.6 5593.9 5608.4 5610.0 5613.0 5627.9 5631.7 5633.6 5634.9 5640.0 5174.5 5206.1 5234.9 5327.9 5329.7 5701.0 5790.3 5850.8 5881.5 5896.2 5516.7 5526.4 5529.8 5608.4 5615.6 5648.4 5654.9 5655.2 5659.2 5661.0 5490.0 5563.0 5584.3 5591.3 5602.2 5593.7 5594.2 5611.8 5616.7 5652.3 4585.5 4603.1 4604.3 4605.9 4648.3 3903.5 3907.9 3909.0 3937.2 3940.3 4802.1 4829.7 4864.0 4866.3 4874.3 5685.0 5696.9 5702.4 5702.4 5707.3 4741.2 4835.2 4856.7 4866.7 4912.5 4936.1 4954.9 5025.9 5034.3 5038.6 5306.9 5333.8 5349.6 5355.9 5359.7 5611.8 5677.2 5693.2 5694.3 5756.6 5232.6 5296.1 5303.9 5320.8 5353.0 5544.3 5549.1 5577.1 5590.8 5608.9 5560.4 5641.4 5645.6 5661.2 5663.6 5448.9 5484.9 5534.4 5536.9 5541.8 5481.0 5506.4 5510.6 5540.3 5549.9 5315.4 5394.1 5396.8 5410.3 5428.2 5503.2 5507.1 5507.6 5522.9 5567.5 5319.5 5336.9 5362.3 5375.9 5380.0 14:27:22 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | [#1] ext.html Cycles:180 Average:34497.31 Median:2991.14 stddev:54313.73 (1815.8%) stddev-sans-first:54406.63 14:27:22 INFO - PID 30145 | Values: 648.3 707.0 730.5 1064.9 1079.6 27542.6 33542.8 34149.8 34302.5 34478.5 36710.6 37106.4 37172.8 37190.0 37240.0 5517.5 7203.2 7348.6 7364.6 7371.8 5667.8 6921.1 7047.3 7073.3 7099.7 7162.4 7222.0 7224.4 7225.9 7227.0 7123.9 7189.1 7191.5 7197.4 7200.4 7186.7 7241.5 7248.9 7249.5 7279.0 33381.3 33708.8 33768.5 33810.5 33879.5 2951.3 2988.3 2989.1 2990.3 2992.0 25720.2 25782.4 25783.9 25813.5 25875.1 2888.0 2920.4 2927.6 2941.1 2952.9 152335.2 152957.2 152987.0 153041.0 153136.0 43412.3 43512.6 43535.6 43564.6 43622.8 45871.8 45916.0 45983.3 45989.5 46062.3 13613.8 13667.8 13688.7 13714.0 13747.2 8680.7 8786.8 11048.6 11072.6 11092.3 10292.3 10395.2 10399.6 11691.8 12034.6 5063.6 5147.8 5197.4 5274.5 5285.6 869.6 889.2 900.3 908.8 930.1 19524.0 20167.6 20307.8 20484.9 20582.8 969.4 973.5 996.4 1026.0 1028.5 10610.3 10809.5 11279.8 11314.0 11338.6 230440.0 231755.0 232611.0 232737.0 233288.0 41538.8 41960.0 41989.0 42046.6 42055.4 1238.1 1313.3 1315.6 1319.6 1329.4 19796.2 19832.7 20298.8 20699.7 20792.4 31092.4 31131.2 31139.7 31192.7 31473.2 228097.0 229553.0 229684.0 230526.0 231392.0 29621.6 29685.0 29886.7 29972.0 30345.4 29758.9 30267.7 32271.0 36192.9 36838.8 26609.0 27598.0 28213.7 28286.7 28332.7 27232.9 27253.0 27777.9 28311.3 28706.0 30118.4 30160.4 30174.5 30295.8 30864.5 26797.0 26869.5 26944.9 27069.5 27712.6 20781.0 21866.3 22119.0 22815.5 22879.7 14:27:22 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | [#2] jquery.html Cycles:180 Average:27931.60 Median:403.29 stddev:77006.69 (19094.6%) stddev-sans-first:77194.97 14:27:22 INFO - PID 30145 | Values: 402.8 403.8 412.1 418.9 421.7 12044.8 17781.4 18592.9 18633.9 18815.7 17844.6 18119.5 19321.3 19982.2 20130.5 5413.1 5505.0 5554.8 5589.6 5593.9 5496.5 5585.5 5585.6 5587.3 5589.4 5350.8 5514.6 5530.7 5541.6 5574.2 5468.5 5567.4 5590.4 5622.9 5625.7 4972.0 5048.9 5050.1 5053.1 5055.8 22675.7 22790.8 22929.6 23037.4 23169.5 1636.9 1666.3 1676.7 1677.4 1681.7 14761.6 14973.6 15021.5 15028.6 15151.2 2052.8 2114.3 2115.8 2130.7 2140.5 85151.0 86961.6 87145.0 88163.6 89549.1 10769.7 10800.9 10940.7 10952.4 11111.8 14279.8 15262.9 15277.5 15295.4 15300.0 7105.5 7735.8 7739.1 7969.6 8034.7 7247.8 7293.5 7402.3 7479.3 7488.6 6976.1 7008.6 7047.6 7122.4 7130.5 1938.9 1956.3 2026.2 2035.9 2126.5 817.5 854.8 865.6 866.1 899.5 16941.3 17032.0 17667.5 17883.5 18003.0 874.2 890.2 890.8 894.9 908.8 9045.9 9421.3 9679.8 9747.8 9789.9 453540.0 453760.0 473388.0 474175.0 476325.0 86371.0 87106.6 87275.6 88077.6 88261.0 1055.9 1070.2 1098.8 1104.1 1104.6 14810.6 14824.1 15090.2 15193.9 15299.6 38051.6 38539.2 38631.8 39016.6 39874.4 44966.3 45959.5 53408.5 54098.0 54542.5 6476.8 8097.1 8182.2 8453.2 8637.5 13255.5 13482.6 13494.3 13678.4 13723.5 10695.2 11121.3 11268.0 11329.4 11835.9 10480.5 11005.6 11039.9 11187.7 11366.4 10375.8 11418.8 11636.6 12199.7 12209.3 7918.5 7980.4 7984.5 8087.2 8438.4 10755.6 10792.5 10803.8 11038.5 11589.8 14:27:22 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | [#3] mootools.html Cycles:180 Average:6225.98 Median:4154.20 stddev:3975.63 (95.7%) stddev-sans-first:3969.64 14:27:22 INFO - PID 30145 | Values: 1312.5 1353.4 1375.6 1380.8 1392.9 9795.6 10247.7 10295.3 10314.3 10337.5 9964.0 10319.7 10363.3 10367.3 10381.3 2220.3 2282.1 2282.3 2282.8 2282.8 1892.7 1966.7 2183.7 2282.8 2284.7 2002.0 2016.8 2029.2 2145.8 2234.0 2117.4 2119.8 2122.4 2123.0 2124.2 2095.4 2108.1 2122.7 2123.7 2125.4 9643.8 9928.6 9943.0 9943.1 9962.6 5601.8 5762.4 5787.8 5806.4 5806.5 3188.2 3337.1 3398.7 3404.8 3444.0 1058.9 1064.2 1070.7 1107.6 1116.5 14251.9 14653.5 14658.4 14662.4 14683.9 4713.5 5003.9 5056.4 5059.6 5091.3 12434.0 12434.1 12455.1 12473.1 12496.9 5676.6 5678.9 5680.2 5690.3 5700.5 4996.0 5009.9 5011.8 5046.7 5056.6 4006.2 4070.9 4121.3 4187.1 4194.1 1228.9 1254.0 1260.0 1276.8 1281.5 611.0 699.6 708.0 732.2 741.9 5051.0 5174.8 5399.4 5451.6 5478.6 844.0 845.7 856.3 856.8 861.8 3318.7 3321.5 3348.7 3370.3 3486.1 12608.5 12784.7 13022.9 13026.2 13035.0 12758.8 12883.6 12911.7 12998.3 13001.7 8889.8 9033.4 9040.0 9097.5 9107.6 5831.1 5878.1 5931.1 5962.2 6078.0 11040.1 11056.3 11088.4 11099.9 11207.2 11333.2 11451.1 11940.8 11976.3 12026.2 8209.6 8321.5 8328.3 8334.5 8344.5 8688.3 8722.3 8733.0 8778.5 8811.2 7532.6 7539.9 7612.5 7616.2 7886.8 6285.8 7597.2 7755.6 8007.3 8021.2 6754.2 6821.9 6821.9 6827.7 6829.4 4869.0 5070.2 5165.3 5205.6 5212.6 5250.2 5329.8 5401.9 5501.9 5525.8 14:27:22 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | [#4] prototype.html Cycles:180 Average:4626.36 Median:5153.73 stddev:1296.26 (25.2%) stddev-sans-first:1259.94 14:27:22 INFO - PID 30145 | Values: 371.8 385.2 391.7 397.4 404.1 5265.5 5299.7 5318.6 5324.2 5344.3 5212.2 5226.5 5227.9 5237.7 5241.4 4032.4 4112.0 4115.4 4137.1 4145.5 4103.3 4110.7 4112.1 4126.9 4137.0 4103.0 4115.3 4115.4 4115.7 4128.8 4016.7 4091.9 4109.8 4119.3 4129.1 3675.2 3704.5 3708.7 3711.4 3748.9 5032.6 5041.5 5050.7 5052.9 5056.9 4754.8 4833.5 4862.3 4873.0 4879.2 5511.2 5528.9 5540.4 5546.4 5558.4 4169.9 4173.4 4177.5 4178.3 4179.0 5535.6 5666.5 5729.8 5749.7 5769.7 4276.7 4281.3 4284.4 4290.6 4302.7 4341.3 4348.3 4360.0 4363.3 4372.3 4473.7 4525.8 4819.3 4831.1 4835.3 5428.3 5497.0 5507.5 5509.9 5510.8 1498.0 1523.5 1523.7 1524.9 1526.0 1028.5 1079.7 1081.0 1087.7 1102.2 4843.6 4846.7 4859.7 4871.8 4889.5 5644.6 5661.5 5683.8 5685.5 5696.0 4699.8 4851.9 4866.0 4876.6 4889.2 2974.6 3005.5 3008.9 3016.3 3026.8 5281.2 5354.7 5384.6 5388.7 5399.3 5711.5 5792.3 5844.0 5847.4 5862.4 5348.8 5355.0 5357.4 5360.9 5365.0 5533.7 5631.9 5687.4 5689.7 5715.9 5566.4 5588.3 5590.4 5605.6 5610.6 5095.3 5260.4 5262.6 5270.4 5345.6 4036.6 4174.0 4187.8 4278.7 4292.3 5673.3 5693.2 5728.5 5734.5 5734.6 5307.2 5546.3 5549.8 5564.1 5583.3 5534.2 5535.9 5543.8 5561.3 5568.8 5269.2 5413.5 5443.5 5448.3 5460.2 5545.0 5555.1 5563.1 5575.0 5576.6 5397.6 5401.9 5425.9 5436.7 5437.9 14:27:22 INFO - PID 30145 | 14:27:22 INFO - PID 30145 | [#5] yui.html Cycles:180 Average:14370.28 Median:50716.49 stddev:17767.69 (35.0%) stddev-sans-first:17788.06 14:27:22 INFO - PID 30145 | Values: 742.6 746.8 766.0 767.1 774.8 11861.8 11917.4 12210.3 12309.7 12324.7 13263.1 13590.9 13603.3 13610.5 13625.0 663.5 815.9 907.1 918.8 929.9 940.0 940.6 941.6 942.8 943.9 986.6 987.2 987.6 987.7 987.8 977.1 977.1 977.3 977.9 980.1 723.4 724.1 724.6 725.4 726.1 11865.5 11917.4 11974.2 12069.9 12729.0 13134.9 13137.8 13859.0 13872.0 14007.4 13427.1 13621.5 13732.1 13741.8 13852.4 2743.1 2750.5 2751.3 2752.0 2865.5 61699.4 63427.7 64030.0 64545.4 65180.7 10279.6 10366.2 10423.8 10491.6 10577.1 21630.8 21643.4 21653.9 21663.0 21676.2 6287.8 6291.6 6410.5 6462.0 6572.4 3422.7 3460.9 3472.3 3490.2 3521.5 3585.5 3637.3 3641.1 3664.4 3698.0 648.7 661.1 661.4 662.0 664.1 513.4 524.6 524.6 532.1 537.9 8248.3 8584.0 8673.3 8789.2 9175.9 558.7 559.7 560.1 561.3 572.7 3755.2 3774.5 3812.6 3916.3 3935.6 64731.7 64752.7 65105.0 65744.7 67429.7 57557.0 57697.0 57737.4 58000.7 58291.4 50597.7 50835.2 51230.0 51769.0 52243.5 7617.2 8006.1 8031.2 8109.6 8138.2 26482.0 26527.7 27388.7 27541.2 28130.9 33237.8 33361.7 33443.3 33585.3 33960.0 11387.2 11587.8 11618.9 11654.5 11698.8 12357.6 12410.6 12678.9 12929.0 13061.0 11089.7 11638.2 11645.5 11766.4 12019.2 11038.9 11406.7 11578.2 11688.1 11930.2 10429.3 10924.7 11011.5 11394.7 11406.2 8622.2 9037.2 9134.6 9141.3 9205.3 9025.0 9741.0 9801.4 9812.3 9867.1 14:27:22 INFO - PID 30145 | -------- Summary: end -------- 14:27:22 INFO - PID 30145 | 14:27:23 INFO - TEST-INFO | 30145: exit 0 14:27:23 INFO - TEST-OK | dromaeo_css | took 1124895ms 14:27:23 INFO - TEST-START | kraken 14:27:23 INFO - operating with platform_type : linux_ 14:27:23 INFO - Initialising browser for kraken test... 14:27:23 INFO - TEST-INFO | started process 30486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkaeOD6/profile http://localhost:36731/getInfo.html) 14:27:27 INFO - PID 30486 | __metrics Screen width/height:1600/1200 14:27:27 INFO - PID 30486 | colorDepth:24 14:27:27 INFO - PID 30486 | Browser inner width/height: 1024/697 14:27:27 INFO - PID 30486 | __metrics 14:27:29 INFO - PID 30486 | 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" 14:27:29 INFO - PID 30486 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:27:30 INFO - TEST-INFO | 30486: exit 0 14:27:30 INFO - Browser initialized. 14:27:30 INFO - Running cycle 1/1 for kraken test... 14:27:30 INFO - TEST-INFO | started process 30588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkaeOD6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:42 INFO - PID 30588 | RSS: Main: 171204608 14:27:42 INFO - PID 30588 | 14:27:45 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36731/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:46 INFO - PID 30588 | RSS: Main: 232062976 14:27:46 INFO - PID 30588 | 14:27:49 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36731/tests/kraken/driver.html?testName=audio-dft) 14:27:49 INFO - PID 30588 | RSS: Main: 211046400 14:27:49 INFO - PID 30588 | 14:27:52 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36731/tests/kraken/driver.html?testName=audio-fft) 14:27:53 INFO - PID 30588 | RSS: Main: 293904384 14:27:53 INFO - PID 30588 | 14:27:55 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36731/tests/kraken/driver.html?testName=audio-oscillator) 14:27:56 INFO - PID 30588 | RSS: Main: 206675968 14:27:56 INFO - PID 30588 | 14:27:58 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36731/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:59 INFO - PID 30588 | RSS: Main: 210046976 14:27:59 INFO - PID 30588 | 14:28:02 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36731/tests/kraken/driver.html?testName=imaging-darkroom) 14:28:03 INFO - PID 30588 | RSS: Main: 248737792 14:28:03 INFO - PID 30588 | 14:28:06 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36731/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:07 INFO - PID 30588 | RSS: Main: 244596736 14:28:07 INFO - PID 30588 | 14:28:10 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36731/tests/kraken/driver.html?testName=json-parse-financial) 14:28:10 INFO - PID 30588 | RSS: Main: 245764096 14:28:10 INFO - PID 30588 | 14:28:12 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36731/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:13 INFO - PID 30588 | RSS: Main: 208027648 14:28:13 INFO - PID 30588 | 14:28:14 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36731/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:15 INFO - PID 30588 | RSS: Main: 216731648 14:28:15 INFO - PID 30588 | 14:28:17 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36731/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:18 INFO - PID 30588 | RSS: Main: 224952320 14:28:18 INFO - PID 30588 | 14:28:21 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:21 INFO - PID 30588 | RSS: Main: 235802624 14:28:21 INFO - PID 30588 | 14:28:25 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:25 INFO - PID 30588 | RSS: Main: 230838272 14:28:25 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | Cycle 1(1): loaded http://localhost:36731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36731/tests/kraken/driver.html?testName=ai-astar) 14:28:27 INFO - PID 30588 | RSS: Main: 298987520 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | __start_tp_report 14:28:27 INFO - PID 30588 | _x_x_mozilla_page_load 14:28:27 INFO - PID 30588 | _x_x_mozilla_page_load_details 14:28:27 INFO - PID 30588 | |i|pagename|runs| 14:28:27 INFO - PID 30588 | |0;ai-astar;103;115;112;113;112;112;113;111;112;113 14:28:27 INFO - PID 30588 | |1;audio-beat-detection;148;125;124;172;125;130;125;123;151;124 14:28:27 INFO - PID 30588 | |2;audio-dft;165;164;164;164;164;167;165;167;164;165 14:28:27 INFO - PID 30588 | |3;audio-fft;74;79;80;107;76;76;78;75;92;76 14:28:27 INFO - PID 30588 | |4;audio-oscillator;84;84;118;92;88;94;105;89;88;109 14:28:27 INFO - PID 30588 | |5;imaging-gaussian-blur;125;113;113;115;114;114;114;114;115;114 14:28:27 INFO - PID 30588 | |6;imaging-darkroom;151;150;151;150;151;152;151;151;152;150 14:28:27 INFO - PID 30588 | |7;imaging-desaturate;95;95;94;95;94;94;94;94;95;95 14:28:27 INFO - PID 30588 | |8;json-parse-financial;54;54;53;54;55;54;54;55;54;55 14:28:27 INFO - PID 30588 | |9;json-stringify-tinderbox;55;56;57;56;56;57;56;56;56;57 14:28:27 INFO - PID 30588 | |10;stanford-crypto-aes;83;84;85;85;86;83;84;83;87;90 14:28:27 INFO - PID 30588 | |11;stanford-crypto-ccm;145;135;141;134;133;131;135;133;184;146 14:28:27 INFO - PID 30588 | |12;stanford-crypto-pbkdf2;194;197;196;193;200;213;196;194;189;198 14:28:27 INFO - PID 30588 | |13;stanford-crypto-sha256-iterative;71;74;76;71;73;71;72;71;71;71 14:28:27 INFO - PID 30588 | __end_tp_report 14:28:27 INFO - PID 30588 | __start_cc_report 14:28:27 INFO - PID 30588 | _x_x_mozilla_cycle_collect,2015 14:28:27 INFO - PID 30588 | __end_cc_report 14:28:27 INFO - PID 30588 | __startTimestamp1491427707915__endTimestamp 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | ------- Summary: start ------- 14:28:27 INFO - PID 30588 | Number of tests: 14 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.20 (2.8%) stddev-sans-first:1.13 14:28:27 INFO - PID 30588 | Values: 103.0 115.0 112.0 113.0 112.0 112.0 113.0 111.0 112.0 113.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:127.50 stddev:16.68 (13.1%) stddev-sans-first:16.98 14:28:27 INFO - PID 30588 | Values: 148.0 125.0 124.0 172.0 125.0 130.0 125.0 123.0 151.0 124.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 14:28:27 INFO - PID 30588 | Values: 165.0 164.0 164.0 164.0 164.0 167.0 165.0 167.0 164.0 165.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#3] audio-fft Cycles:10 Average:81.30 Median:77.00 stddev:10.38 (13.5%) stddev-sans-first:10.67 14:28:27 INFO - PID 30588 | Values: 74.0 79.0 80.0 107.0 76.0 76.0 78.0 75.0 92.0 76.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:88.00 stddev:11.60 (13.2%) stddev-sans-first:11.59 14:28:27 INFO - PID 30588 | Values: 84.0 84.0 118.0 92.0 88.0 94.0 105.0 89.0 88.0 109.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:114.00 stddev:3.54 (3.1%) stddev-sans-first:0.71 14:28:27 INFO - PID 30588 | Values: 125.0 113.0 113.0 115.0 114.0 114.0 114.0 114.0 115.0 114.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:28:27 INFO - PID 30588 | Values: 151.0 150.0 151.0 150.0 151.0 152.0 151.0 151.0 152.0 150.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:28:27 INFO - PID 30588 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 14:28:27 INFO - PID 30588 | Values: 54.0 54.0 53.0 54.0 55.0 54.0 54.0 55.0 54.0 55.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 14:28:27 INFO - PID 30588 | Values: 55.0 56.0 57.0 56.0 56.0 57.0 56.0 56.0 56.0 57.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.21 (2.6%) stddev-sans-first:2.22 14:28:27 INFO - PID 30588 | Values: 83.0 84.0 85.0 85.0 86.0 83.0 84.0 83.0 87.0 90.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:138.00 stddev:15.76 (11.4%) stddev-sans-first:16.67 14:28:27 INFO - PID 30588 | Values: 145.0 135.0 141.0 134.0 133.0 131.0 135.0 133.0 184.0 146.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.00 Median:196.50 stddev:6.38 (3.2%) stddev-sans-first:6.67 14:28:27 INFO - PID 30588 | Values: 194.0 197.0 196.0 193.0 200.0 213.0 196.0 194.0 189.0 198.0 14:28:27 INFO - PID 30588 | 14:28:27 INFO - PID 30588 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:71.50 stddev:1.73 (2.4%) stddev-sans-first:1.79 14:28:27 INFO - PID 30588 | Values: 71.0 74.0 76.0 71.0 73.0 71.0 72.0 71.0 71.0 71.0 14:28:27 INFO - PID 30588 | -------- Summary: end -------- 14:28:27 INFO - PID 30588 | 14:28:29 INFO - TEST-INFO | 30588: exit 0 14:28:29 INFO - TEST-OK | kraken | took 65807ms 14:28:29 INFO - SUITE-END | took 1190s 14:28:29 INFO - Completed test suite (00:19:50) 14:28:29 INFO - javascript benchmark 14:28:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6658.080091500704, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.9211923642297, 2673.8663066846652, 2675.3980354420246, 2730.1127133681553, 2735.8221715588493, 5130.153524668434, 5202.817901373448, 5237.79048838046, 5268.63119581629, 5298.682079075254, 5244.449332820056, 5254.343207099113, 5260.684358938466, 5296.788128474856, 5304.124819404803, 4387.49543802462, 4657.836975705843, 4741.90516189676, 4749.976250118744, 4787.281907713854, 4689.155951928668, 4724.97637511812, 4754.405699287589, 4763.356946812188, 4814.614830813544, 4609.492955774862, 4617.953820461786, 4664.673472856902, 4665.230237010889, 4699.318598803155, 4652.488226295105, 4695.741734204617, 4705.035467729107, 4726.409198850144, 4738.19450693383, 4610.700304480198, 4618.6536009799065, 4636.188666983298, 4655.045715628322, 4658.976705116486, 4998.075356059141, 5106.719130447824, 5116.616253780981, 5121.257417674454, 5163.793448262065, 5588.552915766729, 5593.860153496154, 5608.383077861432, 5609.971950140223, 5613.0, 5627.887442251132, 5631.690257035862, 5633.577481688849, 5634.887302253973, 5640.0, 5174.53429191367, 5206.114960456732, 5234.9476505235225, 5327.946720532823, 5329.733513324319, 5700.971495142498, 5790.334111577223, 5850.765969361263, 5881.470667639933, 5896.233489646319, 5516.696581688046, 5526.392096869341, 5529.834104976857, 5608.383077861432, 5615.578831587565, 5648.406917273709, 5654.85862853432, 5655.151727240865, 5659.179418984307, 5661.0, 5490.039243132436, 5562.972185139049, 5584.329880414376, 5591.273134492571, 5602.243697100921, 5593.720313984366, 5594.216809646653, 5611.775528978795, 5616.66300022, 5652.3217213934595, 4585.518520555361, 4603.125406172817, 4604.286335617984, 4605.884852878705, 4648.349231107648, 3903.531576210873, 3907.8632247871756, 3908.9609103909165, 3937.1928754605237, 3940.3498422760495, 4802.063597598504, 4829.73436460998, 4864.027194561102, 4866.31871537985, 4874.317595536628, 5684.971575142098, 5696.914546281809, 5702.429757024264, 5702.429757024347, 5707.34365547959, 4741.2414013758325, 4835.153848076572, 4856.660033797601, 4866.7079975200895, 4912.508749125131, 4936.086823937583, 4954.8761280968265, 5025.899482010339, 5034.320366750442, 5038.647294689336, 5306.9203961941375, 5333.813316533902, 5349.625526213284, 5355.919661205163, 5359.732013399393, 5611.775528978795, 5677.233573467529, 5693.202951586698, 5694.288213973254, 5756.597038207286, 5232.607554433509, 5296.126139186991, 5303.946960530346, 5320.813771517978, 5352.973235133955, 5544.279243698294, 5549.112142057252, 5577.051901176728, 5590.776368945197, 5608.9158662619275, 5560.443955604407, 5641.379448260606, 5645.604807663424, 5661.207430959586, 5663.603547751618, 5448.891022179455, 5484.91772623403, 5534.363548191848, 5536.944630553643, 5541.833744987657, 5480.972595136999, 5506.366767821752, 5510.641808282448, 5540.307461567304, 5549.889002219852, 5315.388730296066, 5394.083005889087, 5396.757145928521, 5410.269613602113, 5428.212909128233, 5503.229547863222, 5507.063799154073, 5507.614466987273, 5522.861928451821, 5567.526760225264, 5319.547838433777, 5336.866578335573, 5362.276092727432, 5375.919361209507, 5380.031594313061], "value": 5109.857993297509, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.2642201101748, 706.9858602827943, 730.5032577847063, 1064.8988346107121, 1079.6167360586987, 27542.5868611971, 33542.832285838565, 34149.82925085374, 34302.48546271802, 34478.48282275768, 36710.63289367112, 37106.443403348974, 37172.814135929286, 37190.0, 37240.0, 5517.475839795213, 7203.171635261946, 7348.5958272295, 7364.5949472778975, 7371.815704607401, 5667.829965101054, 6921.134858142732, 7047.330503602149, 7073.257307982665, 7099.68051437684, 7162.355388015078, 7222.025026621392, 7224.385927196168, 7225.855482890339, 7227.0, 7123.928760712379, 7189.065421495225, 7191.532550384209, 7197.388222001084, 7200.423966082727, 7186.748463803742, 7241.456890733163, 7248.891266631004, 7249.456290778213, 7278.96360518194, 33381.33237335264, 33708.83145584256, 33768.49347259793, 33810.49284260738, 33879.49180762266, 2951.2769371503905, 2988.2977500287416, 2989.088328059941, 2990.282332240247, 2992.0, 25720.228393148234, 25782.355441114123, 25783.871080644665, 25813.483730325475, 25875.094371697087, 2888.00363874463, 2920.3867187890355, 2927.6047733556125, 2941.132365952028, 2952.852357382122, 152335.2383238088, 152957.23521382434, 152987.0, 153041.0, 153136.0, 43412.34881476781, 43512.56487435148, 43535.56464435315, 43564.564354356684, 43622.781886091005, 45871.770641147246, 45916.0, 45983.31025034627, 45989.54010459853, 46062.30906536405, 13613.795793062915, 13667.794983075262, 13688.726225475435, 13714.0, 13747.243901585509, 8680.652773888974, 8786.824263514694, 11048.558057677763, 11072.557097716, 11092.279001864854, 10292.330998485075, 10395.220358472994, 10399.636012739518, 11691.824622630667, 12034.578789742318, 5063.569596584258, 5147.7683504242395, 5197.350331208599, 5274.472552744772, 5285.63000589955, 869.5826003518347, 889.2441424788877, 900.2617853360313, 908.7864351877304, 930.06993006993, 19524.0, 20167.59664806725, 20307.796922030888, 20484.897575512026, 20582.794172058388, 969.3553786731885, 973.4694591447678, 996.4220751963844, 1026.0406519903913, 1028.475477506462, 10610.310329828537, 10809.513571889283, 11279.774404511863, 11314.0, 11338.603148889913, 230440.0, 231755.0, 232611.0, 232737.0, 233288.0, 41538.792306038275, 41960.0, 41989.0, 42046.57953420488, 42055.36916946248, 1238.120934136755, 1313.343328335832, 1315.6316231455016, 1319.630503459033, 1329.3751936589788, 19796.20815167435, 19832.70250946266, 20298.79701203028, 20699.689504657745, 20792.37622871316, 31092.378152436373, 31131.221719456287, 31139.688603114584, 31192.688073119887, 31473.213169670027, 228097.0, 229553.0, 229684.0, 230526.0, 231392.0, 29621.555676664437, 29685.0, 29886.701132988394, 29972.0, 30345.393092138474, 29758.85120574383, 30267.69732302737, 32271.0, 36192.93720910464, 36838.8158059208, 26609.0, 27598.0, 28213.717862821108, 28286.71713282841, 28332.71667283301, 27232.863835680695, 27253.0, 27777.861110694317, 28311.29221769472, 28706.0, 30118.3976320468, 30160.396792064475, 30174.54738178973, 30295.848520757256, 30864.537031944088, 26797.0, 26869.462610748065, 26944.865275673495, 27069.458610828067, 27712.58431123575, 20781.0, 21866.344009679735, 22119.0, 22815.543689125792, 22879.656805147602], "value": 14901.71698834851, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.79054891456445, 403.79204709574554, 412.1447995409526, 418.9413482112504, 421.687950916322, 12044.795520447951, 17781.37765178219, 18592.90703546484, 18633.906830465847, 18815.71776423355, 17844.64310713785, 18119.547011324692, 19321.323753668625, 19982.200711971505, 20130.49673758157, 5413.106837371829, 5505.0, 5554.750036248379, 5589.636673616202, 5593.888122237553, 5496.4778346057265, 5585.469380408875, 5585.58108141891, 5587.3015873015875, 5589.441055894398, 5350.8394748157425, 5514.641548299368, 5530.695811730353, 5541.639793413416, 5574.247476590669, 5468.453154684539, 5567.415421380758, 5590.440955904418, 5622.943770562324, 5625.6905870177125, 4972.0, 5048.899022019576, 5050.141475949097, 5053.1157047516535, 5055.797768089272, 22675.659865102036, 22790.772092279032, 22929.6242225467, 23037.424064398358, 23169.53660926789, 1636.8608668263212, 1666.2501874156678, 1676.6730487554933, 1677.4464426739146, 1681.6888875557938, 14761.630959226106, 14973.625659358495, 15021.474248401253, 15028.624284392869, 15151.242437878172, 2052.79472052795, 2114.270576651053, 2115.8307335413283, 2130.691049797786, 2140.5183833637307, 85151.0, 86961.5651921749, 87145.0, 88163.55918220432, 89549.10450895473, 10769.730756731144, 10800.94599527013, 10940.726481837859, 10952.397618131079, 11111.833062601525, 14279.78580321296, 15262.923685381724, 15277.541673749805, 15295.388184472497, 15300.0, 7105.502614816914, 7735.7679269622, 7739.110002349802, 7969.561674107979, 8034.718784842503, 7247.782566523013, 7293.452991025694, 7402.29678180572, 7479.289467500579, 7488.625568721543, 6976.127984002, 7008.614526201108, 7047.577145371294, 7122.394596459359, 7130.500864939509, 1938.9127489263017, 1956.2957335359258, 2026.1996511377922, 2035.8880261585755, 2126.5109024924354, 817.4972391979009, 854.8204876975781, 865.6234537976001, 866.0733015673295, 899.5097671768901, 16941.32234710598, 17032.041315248658, 17667.469975900745, 17883.463496095137, 18003.0, 874.2175752701423, 890.1587999340561, 890.7951171230524, 894.8926128864578, 908.8000639859221, 9045.864312035324, 9421.293402994803, 9679.806403872024, 9747.756306092404, 9789.9021009789, 453540.0, 453760.0, 473388.0, 474175.0, 476325.0, 86371.0, 87106.56446717726, 87275.56362218148, 88077.55961220153, 88261.0, 1055.9419231942318, 1070.1706177712335, 1098.758273179899, 1104.111190491662, 1104.6244276945877, 14810.62973425673, 14824.110553366832, 15090.24548772535, 15193.924030379778, 15299.578604868751, 38051.61948380481, 38539.229215414976, 38631.80684096562, 39016.60983390243, 39874.401883971186, 44966.29637350975, 45959.54040459553, 53408.46591534035, 54098.0, 54542.454575455326, 6476.838079048061, 8097.1093179749005, 8182.22268884455, 8453.154684531497, 8637.481751094954, 13255.469781209029, 13482.595522134352, 13494.32528373597, 13678.384472698554, 13723.45106195741, 10695.197860160364, 11121.332720036824, 11268.0, 11329.433528323387, 11835.881641183478, 10480.528376222936, 11005.61480348184, 11039.889601104207, 11187.720306992065, 11366.374849383363, 10375.758058177042, 11418.82871756941, 11636.592719255124, 12199.69500762488, 12209.328486933304, 7918.485298455582, 7980.441369104107, 7984.481008734414, 8087.231712987257, 8438.409311348147, 10755.623553175601, 10792.460376981277, 10803.783924321628, 11038.503267352828, 11589.768204636028], "value": 8982.35257441736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.5340504121036, 1353.4247944623532, 1375.5804479633707, 1380.7928810678397, 1392.9094608850417, 9795.559199836007, 10247.743806404844, 10295.279330446872, 10314.329568578038, 10337.534810933506, 9964.0, 10319.690409287714, 10363.326383785048, 10367.274290799647, 10381.273310868242, 2220.3338998300487, 2282.052948026567, 2282.3038973113194, 2282.8173746100356, 2282.82878784091, 1892.7350170976074, 1966.6853303471448, 2183.683365911942, 2282.805961493275, 2284.6573014047945, 2001.9699704504444, 2016.8386529077638, 2029.2491778042072, 2145.7639659637425, 2233.9553208935813, 2117.4177101297114, 2119.756228033765, 2122.4163355077476, 2122.968155477669, 2124.16095642222, 2095.402810199086, 2108.114591871418, 2122.734658167729, 2123.702681624574, 2125.3730149605904, 9643.758906027335, 9928.602855885829, 9943.0, 9943.105120539187, 9962.551685174185, 5601.80393686219, 5762.394948530427, 5787.826365209051, 5806.44838740319, 5806.5354771618595, 3188.1551388881967, 3337.0656216259486, 3398.677125673057, 3404.778689385182, 3444.0356700123757, 1058.9205809564237, 1064.2124827627576, 1070.68414817629, 1107.6234080412698, 1116.5143162724241, 14251.928740356232, 14653.487127950471, 14658.41366345345, 14662.413503459955, 14683.853161468462, 4713.528647135259, 5003.874903127451, 5056.418511871108, 5059.569936555434, 5091.338126043591, 12434.0, 12434.129610927148, 12455.065870059781, 12473.126881118234, 12496.937515312366, 5676.602637815313, 5678.858028549319, 5680.204771332017, 5690.260266165372, 5700.515456186271, 4996.0, 5009.89980200394, 5011.774470148852, 5046.7476626168545, 5056.570191533688, 4006.2187873364996, 4070.9389359159636, 4121.2993791055, 4187.099773548702, 4194.0563373240775, 1228.8893999540085, 1254.0155977557574, 1259.9811002834965, 1276.7765641012786, 1281.4681907008487, 610.9725062372204, 699.646678427391, 707.9646017699198, 732.1616748822569, 741.8664640364786, 5051.0, 5174.767135478913, 5399.406065332811, 5451.563874890078, 5478.616496845262, 843.9831203376021, 845.7124577643631, 856.2978357746588, 856.8457677618088, 861.7630151708205, 3318.7345012399433, 3321.485169798685, 3348.6986171244703, 3370.321009099675, 3486.0587641336697, 12608.49566017349, 12784.744305113845, 13022.934885325702, 13026.153300035467, 13035.0, 12758.80861787074, 12883.613491595268, 12911.677208069874, 12998.285094319903, 13001.659701253677, 8889.777755556162, 9033.412828166149, 9040.0, 9097.454152750724, 9107.635694572144, 5831.067029275296, 5878.147668587945, 5931.051031834886, 5962.16529685853, 6077.969610151921, 11040.061594764215, 11056.281341712764, 11088.390138542458, 11099.889001109885, 11207.215494915277, 11333.150013748836, 11451.141164412536, 11940.76118477643, 11976.341301228516, 12026.218295810744, 8209.589520524069, 8321.459105158145, 8328.250457458858, 8334.458260213067, 8344.499330040217, 8688.26149777276, 8722.302215822592, 8733.0, 8778.51718155482, 8811.206991370807, 7532.623368831646, 7539.886901696588, 7612.505187162817, 7616.162222155448, 7886.842263154819, 6285.779997700059, 7597.240275972358, 7755.573443460664, 8007.319377852715, 8021.2379823916635, 6754.223264324665, 6821.863562728817, 6821.931780682328, 6827.668604622051, 6829.385355318045, 4869.0, 5070.188769796962, 5165.276861239505, 5205.596263869202, 5212.635115541876, 5250.159974404077, 5329.813456529003, 5401.945980540144, 5501.862453438696, 5525.751341189576], "value": 4714.0484625769695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.75092687899104, 385.1776457263741, 391.7434080677157, 397.4058782120729, 404.07870056271713, 5265.499777521139, 5299.735013249337, 5318.627696061272, 5324.227986941891, 5344.305240318763, 5212.1660534314515, 5226.484319547327, 5227.869303267411, 5237.685738855662, 5241.39723931748, 4032.3749818778138, 4112.0, 4115.403266526352, 4137.110521237933, 4145.481814773153, 4103.281925663012, 4110.705127884722, 4112.074783173792, 4126.938095928564, 4137.027798467358, 4103.015276333674, 4115.259253334399, 4115.444415003981, 4115.682981445939, 4128.8348466061325, 4016.6544207690167, 4091.9181616367505, 4109.794510274489, 4119.340905455143, 4129.132882094764, 3675.246574452231, 3704.5369328833895, 3708.684761795251, 3711.3669985206425, 3748.8687895923786, 5032.622553308516, 5041.495850414965, 5050.671706339076, 5052.924206136874, 5056.924146137811, 4754.809807607691, 4833.516648335173, 4862.270659401082, 4872.975635121802, 4879.194932836078, 5511.173324001392, 5528.944710552883, 5540.390557038762, 5546.362168350611, 5558.388577256498, 4169.874903752892, 4173.351526147185, 4177.4778152730905, 4178.310578754502, 4178.997040710238, 5535.640183388107, 5666.546676265889, 5729.799457019026, 5749.683767392792, 5769.740361683735, 4276.743395396286, 4281.336392859112, 4284.4430224070675, 4290.613844753987, 4302.65578753699, 4341.283688191413, 4348.303941649572, 4359.978200108979, 4363.3018717005125, 4372.278574035248, 4473.731576105444, 4525.841595544206, 4819.2530157825595, 4831.057943700945, 4835.347228124228, 5428.267183930119, 5496.972515137399, 5507.531859791962, 5509.889802204014, 5510.752016159283, 1498.0, 1523.5353217268619, 1523.6647937453743, 1524.885633577464, 1526.008094738429, 1028.5063169678597, 1079.7192729890128, 1080.9675709728722, 1087.6791346552786, 1102.211918478276, 4843.564079232886, 4846.733429661332, 4859.659823812299, 4871.805127794849, 4889.535494128123, 5644.57665675076, 5661.518770904437, 5683.772649094072, 5685.488306052475, 5696.0, 4699.8271099541025, 4851.902961940741, 4866.0, 4876.609871210295, 4889.168841296988, 2974.6430428348303, 3005.4890668586395, 3008.909732708022, 3016.2610160510817, 3026.803257788237, 5281.151596941117, 5354.651947623392, 5384.623076384615, 5388.67667939917, 5399.271098401744, 5711.543076553866, 5792.304923409218, 5843.970780146072, 5847.386024467455, 5862.443067908542, 5348.786048558014, 5354.973225133927, 5357.357117145967, 5360.865978350573, 5364.9731751341, 5533.667979921218, 5631.887362252814, 5687.374388817309, 5689.6586204827845, 5715.942840571541, 5566.443355664401, 5588.329400471969, 5590.357108932525, 5605.551555875439, 5610.635308704921, 5095.286659867696, 5260.447652996533, 5262.605304602247, 5270.420253772006, 5345.625806193529, 4036.5761595033273, 4174.0, 4187.790610469525, 4278.743275403485, 4292.313229883203, 5673.347565030074, 5693.174489698888, 5728.54171666274, 5734.483896449339, 5734.627249228787, 5307.150855863043, 5546.278983732089, 5549.7780088796, 5564.081926482085, 5583.274174357308, 5534.225208470898, 5535.944640553543, 5543.77824887, 5561.328484073398, 5568.832935011957, 5269.208469120517, 5413.485718856702, 5443.482869127427, 5448.318960129984, 5460.180972854104, 5545.0, 5555.111182210827, 5563.13771365439, 5575.0, 5576.553875689854, 5397.649152805055, 5401.918971215357, 5425.864353391197, 5436.700981445901, 5437.891242175056], "value": 4240.180576470911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.6286856571711, 746.8468963862407, 765.9961700191499, 767.110152223421, 774.8489044636294, 11861.822072668907, 11917.404129793498, 12210.32843193624, 12309.692257693561, 12324.691882702926, 13263.137896036751, 13590.932045339785, 13603.251821149834, 13610.523631672893, 13625.0, 663.5156335874814, 815.8776183572452, 907.0521305236027, 918.7519369770191, 929.9023602521739, 939.9812003759921, 940.6284517615537, 941.5904081724437, 942.797298580805, 943.9339246252765, 986.6250824686609, 987.2151639446657, 987.5852142100299, 987.7234374375187, 987.8419452887539, 977.081543349253, 977.130353984954, 977.2719324103552, 977.8533220016983, 980.1472718734675, 723.424877222604, 724.1238101896658, 724.5869854183118, 725.4160400877291, 726.0561270348526, 11865.466054027504, 11917.404129793476, 11974.161808673396, 12069.879301207051, 12729.0, 13134.868651313556, 13137.802932955918, 13859.0, 13872.028957972945, 14007.369668364949, 13427.12723672958, 13621.455141794317, 13732.107413018122, 13741.793873091812, 13852.376643051088, 2743.0947787230166, 2750.4911591355462, 2751.339678477171, 2752.0367871245103, 2865.4555634429394, 61699.38300617026, 63427.68286158586, 64030.0, 64545.3545464544, 65180.674096629686, 10279.588816447407, 10366.222533310032, 10423.843642345371, 10491.632792852213, 10577.100946419641, 21630.783692163193, 21643.35069947904, 21653.891730541247, 21663.0, 21676.24133155332, 6287.779927702509, 6291.55959082869, 6410.487161027107, 6461.967690161613, 6572.4084832365315, 3422.6748458896363, 3460.8788692395647, 3472.340255351475, 3490.1798077451776, 3521.454174602941, 3585.4980302757635, 3637.2907283079544, 3641.10792855752, 3664.3770559005034, 3698.038509987369, 648.7015972652538, 661.0579923608934, 661.3650895140719, 661.9834504137339, 664.0636702249805, 513.4070148977936, 524.590819161055, 524.6301357542923, 532.1034057612935, 537.9381371142368, 8248.340132789363, 8584.0, 8673.262772664395, 8789.208971192624, 9175.862362064574, 558.6536347464598, 559.7089513453063, 560.1457776890275, 561.3123923194137, 572.699332850257, 3755.248950209969, 3774.471573979645, 3812.5615554211067, 3916.2754890345377, 3935.5670876203594, 64731.67634161799, 64752.676236618514, 65105.0, 65744.67127664427, 67429.66285168641, 57557.0, 57697.0, 57737.422625774045, 58000.70999644975, 58291.417085829446, 50597.74701126544, 50835.237471437955, 51230.0, 51769.0, 52243.477565224624, 7617.162112167768, 8006.119326873923, 8031.196880311922, 8109.59452027408, 8138.1861813820515, 26482.0, 26527.734722652527, 27388.726112739416, 27541.173764787087, 28130.859345703142, 33237.833810830794, 33361.66638333683, 33443.33113337671, 33585.32829343448, 33960.0, 11387.202895797214, 11587.8261826071, 11618.883811162119, 11654.475548600503, 11698.76602467963, 12357.629271121881, 12410.627681169579, 12678.936605316914, 12929.03895274597, 13061.0, 11089.722756931142, 11638.185327027366, 11645.534178632759, 11766.352850593299, 12019.158658893793, 11038.944805275922, 11406.657800266004, 11578.189526733047, 11688.123390745897, 11930.245112848943, 10429.322094063862, 10924.726881828017, 11011.504482298476, 11394.658160255205, 11406.201565890307, 8622.223999840044, 9037.1773148608, 9134.634614615607, 9141.314401419788, 9205.309601780027, 9025.025704503125, 9741.0, 9801.430101900818, 9812.313138080266, 9867.11195992364], "value": 6371.572606734637, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 112.0, 113.0, 112.0, 112.0, 113.0, 111.0, 112.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 124.0, 172.0, 125.0, 130.0, 125.0, 123.0, 151.0, 124.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 164.0, 164.0, 167.0, 165.0, 167.0, 164.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 80.0, 107.0, 76.0, 76.0, 78.0, 75.0, 92.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 92.0, 88.0, 94.0, 105.0, 89.0, 88.0, 109.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 113.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 151.0, 152.0, 151.0, 151.0, 152.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 85.0, 86.0, 83.0, 84.0, 83.0, 87.0, 90.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 135.0, 141.0, 134.0, 133.0, 131.0, 135.0, 133.0, 184.0, 146.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 197.0, 196.0, 193.0, 200.0, 213.0, 196.0, 194.0, 189.0, 198.0], "value": 197.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 76.0, 71.0, 73.0, 71.0, 72.0, 71.0, 71.0, 71.0], "value": 72.1, "unit": "score"}]}]} 14:28:29 INFO - Return code: 0 14:28:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:28:29 ERROR - # TBPL SUCCESS # 14:28:29 INFO - Running post-action listener: _resource_record_post_action 14:28:29 INFO - [mozharness: 2017-04-05 21:28:29.716200Z] Finished run-tests step (success) 14:28:29 INFO - Running post-run listener: _resource_record_post_run 14:28:29 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361111552; Read time: 8; Write time: 311456 14:28:29 INFO - TinderboxPrint: CPU usage
13.0% 14:28:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:28:29 INFO - TinderboxPrint: I/O write bytes / time
361,111,552 / 311,456 14:28:29 INFO - TinderboxPrint: CPU idle
8,373.0 (87.0%) 14:28:29 INFO - TinderboxPrint: CPU user
1,205.7 (12.5%) 14:28:29 INFO - TinderboxPrint: Swap in / out
0 / 0 14:28:29 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 102514688; Read time: 0; Write time: 139772 14:28:29 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258596864; Read time: 8; Write time: 171684 14:28:30 INFO - Running post-run listener: _upload_blobber_files 14:28:30 INFO - Blob upload gear active. 14:28:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:28:30 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 14:28:30 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'] 14:28:30 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 14:28:30 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:28:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:28:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:31 INFO - (blobuploader) - INFO - Done attempting. 14:28:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:28:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:34 INFO - (blobuploader) - INFO - Done attempting. 14:28:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:28:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:35 INFO - (blobuploader) - INFO - Done attempting. 14:28:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:28:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:35 INFO - (blobuploader) - INFO - Done attempting. 14:28:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:28:35 INFO - Return code: 0 14:28:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:28:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:28:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/372f430ef2c6ef8c95a49905988c840764f81944c72530165400961a383d098a5720d590605362d038b78b82b8828ec29041223bc497e6c0a1dc9cca3c3e1026", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c236cd299bb15adda0a19aa3a024469075a6615d7a5348c0987f7a0adb1b0e2bd281c8fe65d1f7b83b8c06ad9915ba67279b6042b1474a6ede25ea12a5ced95", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c0db9c989062fee934682ff73a73a0ae51cd23a34aebeac71b8ce60daec73c78d040f5a12ea641718a9f813edc8ac4c3afa9ecfeadcb810f10c60235790d9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acca12903346bda47d6d0f33f029611900f836fbf374e3c4f9cbd1fa8ae4e80ffe2c17d2d4849ae9b9b40be7c3dca63a4480477311a70daf9b2d880a0c4af3fd"} 14:28:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:28:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:28:35 INFO - Contents: 14:28:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/372f430ef2c6ef8c95a49905988c840764f81944c72530165400961a383d098a5720d590605362d038b78b82b8828ec29041223bc497e6c0a1dc9cca3c3e1026", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c236cd299bb15adda0a19aa3a024469075a6615d7a5348c0987f7a0adb1b0e2bd281c8fe65d1f7b83b8c06ad9915ba67279b6042b1474a6ede25ea12a5ced95", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c0db9c989062fee934682ff73a73a0ae51cd23a34aebeac71b8ce60daec73c78d040f5a12ea641718a9f813edc8ac4c3afa9ecfeadcb810f10c60235790d9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acca12903346bda47d6d0f33f029611900f836fbf374e3c4f9cbd1fa8ae4e80ffe2c17d2d4849ae9b9b40be7c3dca63a4480477311a70daf9b2d880a0c4af3fd"} 14:28:35 INFO - Running post-run listener: copy_logs_to_upload_dir 14:28:35 INFO - Copying logs to upload dir... 14:28:35 INFO - mkdir: /builds/slave/test/build/upload/logs 14:28:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.612753 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-04-05 14:28:35.935666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 14:28:35.939117) ========= 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=745a4373a2a16df560f216e000000264-1491426450.696988-566554197 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/372f430ef2c6ef8c95a49905988c840764f81944c72530165400961a383d098a5720d590605362d038b78b82b8828ec29041223bc497e6c0a1dc9cca3c3e1026", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c236cd299bb15adda0a19aa3a024469075a6615d7a5348c0987f7a0adb1b0e2bd281c8fe65d1f7b83b8c06ad9915ba67279b6042b1474a6ede25ea12a5ced95", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c0db9c989062fee934682ff73a73a0ae51cd23a34aebeac71b8ce60daec73c78d040f5a12ea641718a9f813edc8ac4c3afa9ecfeadcb810f10c60235790d9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acca12903346bda47d6d0f33f029611900f836fbf374e3c4f9cbd1fa8ae4e80ffe2c17d2d4849ae9b9b40be7c3dca63a4480477311a70daf9b2d880a0c4af3fd"} build_url:https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011540 build_url: 'https://queue.taskcluster.net/v1/task/DJW-VgxJRgO3FiZj1UKV6w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/372f430ef2c6ef8c95a49905988c840764f81944c72530165400961a383d098a5720d590605362d038b78b82b8828ec29041223bc497e6c0a1dc9cca3c3e1026", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c236cd299bb15adda0a19aa3a024469075a6615d7a5348c0987f7a0adb1b0e2bd281c8fe65d1f7b83b8c06ad9915ba67279b6042b1474a6ede25ea12a5ced95", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c0db9c989062fee934682ff73a73a0ae51cd23a34aebeac71b8ce60daec73c78d040f5a12ea641718a9f813edc8ac4c3afa9ecfeadcb810f10c60235790d9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acca12903346bda47d6d0f33f029611900f836fbf374e3c4f9cbd1fa8ae4e80ffe2c17d2d4849ae9b9b40be7c3dca63a4480477311a70daf9b2d880a0c4af3fd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 14:28:35.964579) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:28:35.964911) ========= 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=745a4373a2a16df560f216e000000264-1491426450.696988-566554197 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:28:36.048766) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 14:28:36.049079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 14:28:36.049385) ========= ========= Total master_lag: 0.17 =========