builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1489331826.68 results: success (0) revision: f9362554866b327700c7f9b18050d7b7eb3d2b23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:06.675853) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:06.676267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:06.676556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:06.726259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:06.726645) ========= 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=eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-12 08:17:06-- 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% 46.5M=0s 2017-03-12 08:17:07 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.249932 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:07.031517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:07.031981) ========= 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=eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.069308 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:07.115006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:07.115436) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9362554866b327700c7f9b18050d7b7eb3d2b23 --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 f9362554866b327700c7f9b18050d7b7eb3d2b23 --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=eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-12 08:17:07,210 truncating revision to first 12 chars 2017-03-12 08:17:07,210 Setting DEBUG logging. 2017-03-12 08:17:07,210 attempt 1/10 2017-03-12 08:17:07,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9362554866b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-12 08:17:07,680 unpacking tar archive at: mozilla-central-f9362554866b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.900320 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:08.030137) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:08.030435) ========= script_repo_revision: f9362554866b327700c7f9b18050d7b7eb3d2b23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:08.030821) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:08.031094) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-12 08:17:08.039482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-03-12 08:17:08.039770) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:17:08 INFO - MultiFileLogger online at 20170312 08:17:08 in /builds/slave/test 08:17:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:17:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:17:08 INFO - {'append_to_log': False, 08:17:08 INFO - 'base_work_dir': '/builds/slave/test', 08:17:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:17:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:17:08 INFO - 'branch': 'Firefox-Non-PGO', 08:17:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:17:08 INFO - 'config_files': ('talos/linux_config.py',), 08:17:08 INFO - 'default_actions': ('clobber', 08:17:08 INFO - 'read-buildbot-config', 08:17:08 INFO - 'download-and-extract', 08:17:08 INFO - 'populate-webroot', 08:17:08 INFO - 'create-virtualenv', 08:17:08 INFO - 'install', 08:17:08 INFO - 'run-tests'), 08:17:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:17:08 INFO - 'download_minidump_stackwalk': True, 08:17:08 INFO - 'download_symbols': 'ondemand', 08:17:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:17:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:17:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:17:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:17:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:17:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:17:08 INFO - 'gecko_profile': False, 08:17:08 INFO - 'gecko_profile_interval': 0, 08:17:08 INFO - 'installer_path': 'installer.exe', 08:17:08 INFO - 'log_level': 'info', 08:17:08 INFO - 'log_name': 'talos', 08:17:08 INFO - 'log_to_console': True, 08:17:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:17:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:17:08 INFO - 'opt_config_files': (), 08:17:08 INFO - 'pip_index': False, 08:17:08 INFO - 'suite': 'dromaeojs', 08:17:08 INFO - 'system_bits': '32', 08:17:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:17:08 INFO - 'title': 'talos-linux64-ix-010', 08:17:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:17:08 INFO - 'use_talos_json': True, 08:17:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:17:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:17:08 INFO - 'work_dir': 'build'} 08:17:08 INFO - [mozharness: 2017-03-12 15:17:08.369030Z] Running clobber step. 08:17:08 INFO - Running pre-action listener: _resource_record_pre_action 08:17:08 INFO - Running main action method: clobber 08:17:08 INFO - rmtree: /builds/slave/test/build 08:17:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:17:10 INFO - Running post-action listener: _resource_record_post_action 08:17:10 INFO - [mozharness: 2017-03-12 15:17:10.330576Z] Finished clobber step (success) 08:17:10 INFO - [mozharness: 2017-03-12 15:17:10.330704Z] Running read-buildbot-config step. 08:17:10 INFO - Running pre-action listener: _resource_record_pre_action 08:17:10 INFO - Running main action method: read_buildbot_config 08:17:10 INFO - Using buildbot properties: 08:17:10 INFO - { 08:17:10 INFO - "project": "", 08:17:10 INFO - "product": "firefox", 08:17:10 INFO - "who": "ffxbld@noreply.mozilla.org", 08:17:10 INFO - "installer_path": "public/build/target.tar.bz2", 08:17:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:17:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:17:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:17:10 INFO - "stage_platform": "linux64", 08:17:10 INFO - "basedir": "/builds/slave/test", 08:17:10 INFO - "buildnumber": 871, 08:17:10 INFO - "platform": "ubuntu64_hw", 08:17:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:17:10 INFO - "slavebuilddir": "test", 08:17:10 INFO - "taskId": "Ha6Khe6VTjODUbNXmYrdfg", 08:17:10 INFO - "branch": "mozilla-central", 08:17:10 INFO - "script_repo_revision": "production", 08:17:10 INFO - "revision": "f9362554866b327700c7f9b18050d7b7eb3d2b23", 08:17:10 INFO - "slavename": "talos-linux64-ix-010", 08:17:10 INFO - "repo_path": "mozilla-central" 08:17:10 INFO - } 08:17:10 INFO - Finding installer, test and symbols from parent task. 08:17:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ha6Khe6VTjODUbNXmYrdfg'}, attempt #1 08:17:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ha6Khe6VTjODUbNXmYrdfg'}, attempt #1 08:17:11 INFO - Task dependencies: J3WmIIjuRLKrO_muyoqQ-Q 08:17:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q'}, attempt #1 08:17:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.tar.bz2 08:17:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/test_packages.json 08:17:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.crashreporter-symbols.zip 08:17:11 INFO - Running post-action listener: _resource_record_post_action 08:17:11 INFO - [mozharness: 2017-03-12 15:17:11.710015Z] Finished read-buildbot-config step (success) 08:17:11 INFO - [mozharness: 2017-03-12 15:17:11.710324Z] Running download-and-extract step. 08:17:11 INFO - Running pre-action listener: _resource_record_pre_action 08:17:11 INFO - Running main action method: download_and_extract 08:17:11 INFO - mkdir: /builds/slave/test/build/tests 08:17: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')]} 08:17:11 INFO - trying https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.test_packages.json 08:17:11 INFO - Downloading https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:17:12 INFO - Downloaded 896 bytes. 08:17:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:17:12 INFO - Using the following test package requirements: 08:17:12 INFO - {u'common': [u'target.common.tests.zip'], 08:17:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:17:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:17:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:17:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:17:12 INFO - u'mozbase': [u'target.common.tests.zip'], 08:17:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:17:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:17:12 INFO - u'web-platform': [u'target.common.tests.zip', 08:17:12 INFO - u'target.web-platform.tests.zip'], 08:17:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:17:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:17:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.common.tests.zip 08:17:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:17:12 INFO - Fetch https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.common.tests.zip into memory 08:17:13 INFO - Expected file size: 57499432 08:17:13 INFO - Obtained file size: 57499432 08:17:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:17:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.common.tests.zip 08:17:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:17:23 INFO - Fetch https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.common.tests.zip into memory 08:17:24 INFO - Expected file size: 57499432 08:17:24 INFO - Obtained file size: 57499432 08:17:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.talos.tests.zip 08:17:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:17:35 INFO - Fetch https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.talos.tests.zip into memory 08:17:36 INFO - Expected file size: 14404438 08:17:36 INFO - Obtained file size: 14404438 08:17:36 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')]} 08:17:36 INFO - trying https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.tar.bz2 08:17:36 INFO - Downloading https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:17:38 INFO - Downloaded 61598879 bytes. 08:17:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.tar.bz2 08:17:38 INFO - mkdir: /builds/slave/test/properties 08:17:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:17:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:17:38 INFO - Contents: 08:17:38 INFO - build_url:https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.tar.bz2 08:17:38 INFO - Running post-action listener: _resource_record_post_action 08:17:38 INFO - Running post-action listener: set_extra_try_arguments 08:17:38 INFO - [mozharness: 2017-03-12 15:17:38.090715Z] Finished download-and-extract step (success) 08:17:38 INFO - [mozharness: 2017-03-12 15:17:38.090812Z] Running populate-webroot step. 08:17:38 INFO - Running pre-action listener: _resource_record_pre_action 08:17:38 INFO - Running main action method: populate_webroot 08:17:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:17:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:17:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:17:38 INFO - '--tppagecycles', 08:17:38 INFO - '7'], 08:17:38 INFO - 'tests': ['tsvgm']}}, 08:17:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:17:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:17:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:17:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:17:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:17:38 INFO - 'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:17:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:17:38 INFO - 'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['damp', 'tps']}, 08:17:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:17:38 INFO - 'tests': ['damp', 'tps']}, 08:17:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['dromaeo_dom']}, 08:17:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:17:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['basic_compositor_video']}, 08:17:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:17:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['a11yr', 08:17:38 INFO - 'ts_paint', 08:17:38 INFO - 'tpaint', 08:17:38 INFO - 'sessionrestore', 08:17:38 INFO - 'sessionrestore_no_auto_restore', 08:17:38 INFO - 'tabpaint']}, 08:17:38 INFO - 'other-e10s': {'tests': ['a11yr', 08:17:38 INFO - 'ts_paint', 08:17:38 INFO - 'tpaint', 08:17:38 INFO - 'sessionrestore', 08:17:38 INFO - 'sessionrestore_no_auto_restore', 08:17:38 INFO - 'tabpaint']}, 08:17:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:17:38 INFO - 'ts_paint', 08:17:38 INFO - 'tpaint', 08:17:38 INFO - 'sessionrestore', 08:17:38 INFO - 'sessionrestore_no_auto_restore', 08:17:38 INFO - 'tabpaint']}, 08:17:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:17:38 INFO - 'ts_paint', 08:17:38 INFO - 'tpaint', 08:17:38 INFO - 'sessionrestore', 08:17:38 INFO - 'sessionrestore_no_auto_restore', 08:17:38 INFO - 'tabpaint']}, 08:17:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['a11yr', 08:17:38 INFO - 'ts_paint', 08:17:38 INFO - 'tpaint', 08:17:38 INFO - 'sessionrestore', 08:17:38 INFO - 'sessionrestore_no_auto_restore', 08:17:38 INFO - 'tabpaint']}, 08:17:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['a11yr', 08:17:38 INFO - 'ts_paint', 08:17:38 INFO - 'tpaint', 08:17:38 INFO - 'sessionrestore', 08:17:38 INFO - 'sessionrestore_no_auto_restore', 08:17:38 INFO - 'tabpaint']}, 08:17:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['tsvgx', 08:17:38 INFO - 'tsvgr_opacity', 08:17:38 INFO - 'tart', 08:17:38 INFO - 'tscrollx', 08:17:38 INFO - 'cart', 08:17:38 INFO - 'tsvg_static']}, 08:17:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:17:38 INFO - 'tsvgr_opacity', 08:17:38 INFO - 'tart', 08:17:38 INFO - 'tscrollx', 08:17:38 INFO - 'cart', 08:17:38 INFO - 'tsvg_static']}, 08:17:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:17:38 INFO - 'talos_options': ['--disable-e10s'], 08:17:38 INFO - 'tests': ['tp5o']}, 08:17:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:17:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:17:38 INFO - 'talos_options': ['--disable-e10s', 08:17:38 INFO - '--xperf_path', 08:17:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:38 INFO - 'tests': ['tp5n']}, 08:17:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:17:38 INFO - 'talos_options': ['--xperf_path', 08:17:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:38 INFO - 'tests': ['tp5n']}}, 08:17:38 INFO - 'talos.zip': {'path': '', 08:17:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:17:38 INFO - Running post-action listener: _resource_record_post_action 08:17:38 INFO - [mozharness: 2017-03-12 15:17:38.103904Z] Finished populate-webroot step (success) 08:17:38 INFO - [mozharness: 2017-03-12 15:17:38.103994Z] Running create-virtualenv step. 08:17:38 INFO - Running pre-action listener: _resource_record_pre_action 08:17:38 INFO - Running main action method: create_virtualenv 08:17:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:17:38 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 08:17:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:17:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:17:38 INFO - Using real prefix '/usr' 08:17:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:17:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:40 INFO - Installing pip.................done. 08:17:40 INFO - Return code: 0 08:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:17:41 INFO - Reading from file tmpfile_stdout 08:17:41 INFO - Output received: 08:17:41 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) 08:17:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:17:41 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 08:17:41 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 08:17:41 INFO - Using env: {'DISPLAY': ':0', 08:17:41 INFO - 'HOME': '/home/cltbld', 08:17:41 INFO - 'LANG': 'en_US.UTF-8', 08:17:41 INFO - 'LANGUAGE': 'en_US:en', 08:17:41 INFO - 'LOGNAME': 'cltbld', 08:17:41 INFO - 'MAIL': '/var/mail/cltbld', 08:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:41 INFO - 'MOZ_NO_REMOTE': '1', 08:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:41 INFO - 'NO_EM_RESTART': '1', 08:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:41 INFO - 'PWD': '/builds/slave/test', 08:17:41 INFO - 'SHELL': '/bin/bash', 08:17:41 INFO - 'SHLVL': '1', 08:17:41 INFO - 'TERM': 'linux', 08:17:41 INFO - 'TMOUT': '86400', 08:17:41 INFO - 'USER': 'cltbld', 08:17:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:41 INFO - '_': '/tools/buildbot/bin/python'} 08:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:41 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 08:17:41 INFO - Cleaning up... 08:17:41 INFO - Return code: 0 08:17:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:17:41 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 08:17:41 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 08:17:41 INFO - Using env: {'DISPLAY': ':0', 08:17:41 INFO - 'HOME': '/home/cltbld', 08:17:41 INFO - 'LANG': 'en_US.UTF-8', 08:17:41 INFO - 'LANGUAGE': 'en_US:en', 08:17:41 INFO - 'LOGNAME': 'cltbld', 08:17:41 INFO - 'MAIL': '/var/mail/cltbld', 08:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:41 INFO - 'MOZ_NO_REMOTE': '1', 08:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:41 INFO - 'NO_EM_RESTART': '1', 08:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:41 INFO - 'PWD': '/builds/slave/test', 08:17:41 INFO - 'SHELL': '/bin/bash', 08:17:41 INFO - 'SHLVL': '1', 08:17:41 INFO - 'TERM': 'linux', 08:17:41 INFO - 'TMOUT': '86400', 08:17:41 INFO - 'USER': 'cltbld', 08:17:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:41 INFO - '_': '/tools/buildbot/bin/python'} 08:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:41 INFO - Downloading/unpacking psutil>=3.1.1 08:17:41 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 08:17:41 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 08:17:41 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 08:17:41 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 08:17:41 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 08:17:41 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 08:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:43 INFO - Installing collected packages: psutil 08:17:43 INFO - Running setup.py install for psutil 08:17:43 INFO - building 'psutil._psutil_linux' extension 08:17:43 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 08:17:44 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 08:17:45 INFO - building 'psutil._psutil_posix' extension 08:17:45 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 08:17:45 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 08:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:45 INFO - Successfully installed psutil 08:17:45 INFO - Cleaning up... 08:17:45 INFO - Return code: 0 08:17:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:17:45 INFO - Using env: {'DISPLAY': ':0', 08:17:45 INFO - 'HOME': '/home/cltbld', 08:17:45 INFO - 'LANG': 'en_US.UTF-8', 08:17:45 INFO - 'LANGUAGE': 'en_US:en', 08:17:45 INFO - 'LOGNAME': 'cltbld', 08:17:45 INFO - 'MAIL': '/var/mail/cltbld', 08:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:45 INFO - 'MOZ_NO_REMOTE': '1', 08:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:45 INFO - 'NO_EM_RESTART': '1', 08:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:45 INFO - 'PWD': '/builds/slave/test', 08:17:45 INFO - 'SHELL': '/bin/bash', 08:17:45 INFO - 'SHLVL': '1', 08:17:45 INFO - 'TERM': 'linux', 08:17:45 INFO - 'TMOUT': '86400', 08:17:45 INFO - 'USER': 'cltbld', 08:17:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:45 INFO - '_': '/tools/buildbot/bin/python'} 08:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:47 INFO - Installing collected packages: mozsystemmonitor 08:17:47 INFO - Running setup.py install for mozsystemmonitor 08:17:47 INFO - Successfully installed mozsystemmonitor 08:17:47 INFO - Cleaning up... 08:17:47 INFO - Return code: 0 08:17:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:17:47 INFO - Using env: {'DISPLAY': ':0', 08:17:47 INFO - 'HOME': '/home/cltbld', 08:17:47 INFO - 'LANG': 'en_US.UTF-8', 08:17:47 INFO - 'LANGUAGE': 'en_US:en', 08:17:47 INFO - 'LOGNAME': 'cltbld', 08:17:47 INFO - 'MAIL': '/var/mail/cltbld', 08:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:47 INFO - 'MOZ_NO_REMOTE': '1', 08:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:47 INFO - 'NO_EM_RESTART': '1', 08:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:47 INFO - 'PWD': '/builds/slave/test', 08:17:47 INFO - 'SHELL': '/bin/bash', 08:17:47 INFO - 'SHLVL': '1', 08:17:47 INFO - 'TERM': 'linux', 08:17:47 INFO - 'TMOUT': '86400', 08:17:47 INFO - 'USER': 'cltbld', 08:17:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:47 INFO - '_': '/tools/buildbot/bin/python'} 08:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:48 INFO - Downloading/unpacking jsonschema==2.5.1 08:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:50 INFO - warning: no files found matching '*.txt' 08:17:50 INFO - no previously-included directories found matching 'build' 08:17:50 INFO - no previously-included directories found matching 'dist' 08:17:50 INFO - no previously-included directories found matching '.git*' 08:17:50 INFO - Installing collected packages: jsonschema, functools32 08:17:50 INFO - Running setup.py install for functools32 08:17:50 INFO - warning: no files found matching '*.txt' 08:17:50 INFO - no previously-included directories found matching 'build' 08:17:50 INFO - no previously-included directories found matching 'dist' 08:17:50 INFO - no previously-included directories found matching '.git*' 08:17:50 INFO - Successfully installed jsonschema functools32 08:17:50 INFO - Cleaning up... 08:17:50 INFO - Return code: 0 08:17:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:17:50 INFO - Using env: {'DISPLAY': ':0', 08:17:50 INFO - 'HOME': '/home/cltbld', 08:17:50 INFO - 'LANG': 'en_US.UTF-8', 08:17:50 INFO - 'LANGUAGE': 'en_US:en', 08:17:50 INFO - 'LOGNAME': 'cltbld', 08:17:50 INFO - 'MAIL': '/var/mail/cltbld', 08:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:50 INFO - 'MOZ_NO_REMOTE': '1', 08:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:50 INFO - 'NO_EM_RESTART': '1', 08:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:50 INFO - 'PWD': '/builds/slave/test', 08:17:50 INFO - 'SHELL': '/bin/bash', 08:17:50 INFO - 'SHLVL': '1', 08:17:50 INFO - 'TERM': 'linux', 08:17:50 INFO - 'TMOUT': '86400', 08:17:50 INFO - 'USER': 'cltbld', 08:17:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:50 INFO - '_': '/tools/buildbot/bin/python'} 08:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:17:50 INFO - Cleaning up... 08:17:50 INFO - Return code: 0 08:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:17:50 INFO - Using env: {'DISPLAY': ':0', 08:17:50 INFO - 'HOME': '/home/cltbld', 08:17:50 INFO - 'LANG': 'en_US.UTF-8', 08:17:50 INFO - 'LANGUAGE': 'en_US:en', 08:17:50 INFO - 'LOGNAME': 'cltbld', 08:17:50 INFO - 'MAIL': '/var/mail/cltbld', 08:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:50 INFO - 'MOZ_NO_REMOTE': '1', 08:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:50 INFO - 'NO_EM_RESTART': '1', 08:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:50 INFO - 'PWD': '/builds/slave/test', 08:17:50 INFO - 'SHELL': '/bin/bash', 08:17:50 INFO - 'SHLVL': '1', 08:17:50 INFO - 'TERM': 'linux', 08:17:50 INFO - 'TMOUT': '86400', 08:17:50 INFO - 'USER': 'cltbld', 08:17:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:50 INFO - '_': '/tools/buildbot/bin/python'} 08:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:53 INFO - Downloading docopt-0.6.1.tar.gz 08:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:53 INFO - Running setup.py install for blobuploader 08:17:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:53 INFO - Running setup.py install for requests 08:17:54 INFO - Running setup.py install for docopt 08:17:54 INFO - Successfully installed blobuploader requests docopt 08:17:54 INFO - Cleaning up... 08:17:54 INFO - Return code: 0 08:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:54 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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:17:54 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 08:17:54 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 08:17:54 INFO - Using env: {'DISPLAY': ':0', 08:17:54 INFO - 'HOME': '/home/cltbld', 08:17:54 INFO - 'LANG': 'en_US.UTF-8', 08:17:54 INFO - 'LANGUAGE': 'en_US:en', 08:17:54 INFO - 'LOGNAME': 'cltbld', 08:17:54 INFO - 'MAIL': '/var/mail/cltbld', 08:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:54 INFO - 'MOZ_NO_REMOTE': '1', 08:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:54 INFO - 'NO_EM_RESTART': '1', 08:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:54 INFO - 'PWD': '/builds/slave/test', 08:17:54 INFO - 'SHELL': '/bin/bash', 08:17:54 INFO - 'SHLVL': '1', 08:17:54 INFO - 'TERM': 'linux', 08:17:54 INFO - 'TMOUT': '86400', 08:17:54 INFO - 'USER': 'cltbld', 08:17:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:54 INFO - '_': '/tools/buildbot/bin/python'} 08:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:54 INFO - Running setup.py (path:/tmp/pip-D5TPtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:54 INFO - Running setup.py (path:/tmp/pip-4uPMKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:54 INFO - Running setup.py (path:/tmp/pip-WhWgxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:54 INFO - Running setup.py (path:/tmp/pip-t2Om5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:54 INFO - Running setup.py (path:/tmp/pip-d2FnC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:54 INFO - Running setup.py (path:/tmp/pip-jaOcVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:55 INFO - Running setup.py (path:/tmp/pip-p87wRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:55 INFO - Running setup.py (path:/tmp/pip-k72aeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:55 INFO - Running setup.py (path:/tmp/pip-SUoeqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:55 INFO - Running setup.py (path:/tmp/pip-_5xAP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:55 INFO - Running setup.py (path:/tmp/pip-gdn2Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:55 INFO - Running setup.py (path:/tmp/pip-M0Issm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:55 INFO - Running setup.py (path:/tmp/pip-XZKd8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:55 INFO - Running setup.py (path:/tmp/pip-_xohgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:55 INFO - Running setup.py (path:/tmp/pip-090JKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:55 INFO - Running setup.py (path:/tmp/pip-sgErdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:55 INFO - Running setup.py (path:/tmp/pip-Tsy33W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:55 INFO - Running setup.py install for manifestparser 08:17:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Running setup.py install for mozcrash 08:17:56 INFO - Running setup.py install for mozdebug 08:17:56 INFO - Running setup.py install for mozdevice 08:17:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Running setup.py install for mozfile 08:17:56 INFO - Running setup.py install for mozhttpd 08:17:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Running setup.py install for mozinfo 08:17:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Running setup.py install for mozInstall 08:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Running setup.py install for mozleak 08:17:56 INFO - Running setup.py install for mozlog 08:17:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Running setup.py install for moznetwork 08:17:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Running setup.py install for mozprocess 08:17:57 INFO - Running setup.py install for mozprofile 08:17:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:57 INFO - Running setup.py install for mozrunner 08:17:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:57 INFO - Running setup.py install for mozscreenshot 08:17:57 INFO - Running setup.py install for moztest 08:17:57 INFO - Running setup.py install for mozversion 08:17:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:57 INFO - Cleaning up... 08:17:57 INFO - Return code: 0 08:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:57 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')]} 08:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:57 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')]} 08:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:57 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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:17:57 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 08:17:57 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 08:17:57 INFO - Using env: {'DISPLAY': ':0', 08:17:57 INFO - 'HOME': '/home/cltbld', 08:17:57 INFO - 'LANG': 'en_US.UTF-8', 08:17:57 INFO - 'LANGUAGE': 'en_US:en', 08:17:57 INFO - 'LOGNAME': 'cltbld', 08:17:57 INFO - 'MAIL': '/var/mail/cltbld', 08:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:57 INFO - 'MOZ_NO_REMOTE': '1', 08:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:57 INFO - 'NO_EM_RESTART': '1', 08:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:57 INFO - 'PWD': '/builds/slave/test', 08:17:57 INFO - 'SHELL': '/bin/bash', 08:17:57 INFO - 'SHLVL': '1', 08:17:57 INFO - 'TERM': 'linux', 08:17:57 INFO - 'TMOUT': '86400', 08:17:57 INFO - 'USER': 'cltbld', 08:17:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:57 INFO - '_': '/tools/buildbot/bin/python'} 08:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:57 INFO - Running setup.py (path:/tmp/pip-k5XFnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:57 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)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:57 INFO - Running setup.py (path:/tmp/pip-HE_vuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:58 INFO - Running setup.py (path:/tmp/pip-yOIKDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:58 INFO - Running setup.py (path:/tmp/pip-0BCJd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:58 INFO - Running setup.py (path:/tmp/pip-6TmJdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:58 INFO - Running setup.py (path:/tmp/pip-RRRuya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:58 INFO - Running setup.py (path:/tmp/pip-G6tIh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:58 INFO - Running setup.py (path:/tmp/pip-Vdkrat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:58 INFO - Running setup.py (path:/tmp/pip-0nRy7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:58 INFO - Running setup.py (path:/tmp/pip-U3ulhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:58 INFO - Running setup.py (path:/tmp/pip-QZvKZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:58 INFO - Running setup.py (path:/tmp/pip-YePuj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:58 INFO - Running setup.py (path:/tmp/pip-mGj9cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:58 INFO - Running setup.py (path:/tmp/pip-5vz40v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:58 INFO - Running setup.py (path:/tmp/pip-LZb5UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:58 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)) 08:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:58 INFO - Running setup.py (path:/tmp/pip-3SFOFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:59 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)) 08:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:59 INFO - Running setup.py (path:/tmp/pip-ZC8mLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:59 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)) 08:17:59 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)) 08:17:59 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)) 08:17:59 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)) 08:17:59 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)) 08:17:59 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)) 08:17:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:01 INFO - Downloading blessings-1.6.tar.gz 08:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:18:01 INFO - Installing collected packages: blessings 08:18:01 INFO - Running setup.py install for blessings 08:18:01 INFO - Successfully installed blessings 08:18:01 INFO - Cleaning up... 08:18:01 INFO - Return code: 0 08:18:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:01 INFO - Reading from file tmpfile_stdout 08:18:01 INFO - Current package versions: 08:18:01 INFO - argparse == 1.2.1 08:18:01 INFO - blessings == 1.6 08:18:01 INFO - blobuploader == 1.2.4 08:18:01 INFO - docopt == 0.6.1 08:18:01 INFO - functools32 == 3.2.3-2 08:18:01 INFO - jsonschema == 2.5.1 08:18:01 INFO - manifestparser == 1.1 08:18:01 INFO - mozInstall == 1.12 08:18:01 INFO - mozcrash == 1.0 08:18:01 INFO - mozdebug == 0.1 08:18:01 INFO - mozdevice == 0.49 08:18:01 INFO - mozfile == 1.2 08:18:01 INFO - mozhttpd == 0.7 08:18:01 INFO - mozinfo == 0.9 08:18:01 INFO - mozleak == 0.1 08:18:01 INFO - mozlog == 3.4 08:18:01 INFO - moznetwork == 0.27 08:18:01 INFO - mozprocess == 0.25 08:18:01 INFO - mozprofile == 0.28 08:18:01 INFO - mozrunner == 6.13 08:18:01 INFO - mozscreenshot == 0.1 08:18:01 INFO - mozsystemmonitor == 0.3 08:18:01 INFO - moztest == 0.8 08:18:01 INFO - mozversion == 1.4 08:18:01 INFO - psutil == 3.1.1 08:18:01 INFO - requests == 1.2.3 08:18:01 INFO - wsgiref == 0.1.2 08:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:01 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')]} 08:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:01 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')]} 08:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:01 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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:18:01 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 08:18:01 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 08:18:01 INFO - Using env: {'DISPLAY': ':0', 08:18:01 INFO - 'HOME': '/home/cltbld', 08:18:01 INFO - 'LANG': 'en_US.UTF-8', 08:18:01 INFO - 'LANGUAGE': 'en_US:en', 08:18:01 INFO - 'LOGNAME': 'cltbld', 08:18:01 INFO - 'MAIL': '/var/mail/cltbld', 08:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:01 INFO - 'MOZ_NO_REMOTE': '1', 08:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:01 INFO - 'NO_EM_RESTART': '1', 08:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:01 INFO - 'PWD': '/builds/slave/test', 08:18:01 INFO - 'SHELL': '/bin/bash', 08:18:01 INFO - 'SHLVL': '1', 08:18:01 INFO - 'TERM': 'linux', 08:18:01 INFO - 'TMOUT': '86400', 08:18:01 INFO - 'USER': 'cltbld', 08:18:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:01 INFO - '_': '/tools/buildbot/bin/python'} 08:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 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)) 08:18:01 INFO - Cleaning up... 08:18:01 INFO - Return code: 0 08:18:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:18:01 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')]} 08:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:01 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')]} 08:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:01 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 0x21ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, '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': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', '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 08:18:01 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 08:18:01 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 08:18:01 INFO - Using env: {'DISPLAY': ':0', 08:18:01 INFO - 'HOME': '/home/cltbld', 08:18:01 INFO - 'LANG': 'en_US.UTF-8', 08:18:01 INFO - 'LANGUAGE': 'en_US:en', 08:18:01 INFO - 'LOGNAME': 'cltbld', 08:18:01 INFO - 'MAIL': '/var/mail/cltbld', 08:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:01 INFO - 'MOZ_NO_REMOTE': '1', 08:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:01 INFO - 'NO_EM_RESTART': '1', 08:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:01 INFO - 'PWD': '/builds/slave/test', 08:18:01 INFO - 'SHELL': '/bin/bash', 08:18:01 INFO - 'SHLVL': '1', 08:18:01 INFO - 'TERM': 'linux', 08:18:01 INFO - 'TMOUT': '86400', 08:18:01 INFO - 'USER': 'cltbld', 08:18:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:01 INFO - '_': '/tools/buildbot/bin/python'} 08:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:18:02 INFO - Cleaning up... 08:18:02 INFO - Return code: 0 08:18:02 INFO - Running post-action listener: _resource_record_post_action 08:18:02 INFO - Running post-action listener: _start_resource_monitoring 08:18:02 INFO - Starting resource monitoring. 08:18:02 INFO - [mozharness: 2017-03-12 15:18:02.062731Z] Finished create-virtualenv step (success) 08:18:02 INFO - [mozharness: 2017-03-12 15:18:02.063184Z] Running install step. 08:18:02 INFO - Running pre-action listener: _resource_record_pre_action 08:18:02 INFO - Running main action method: install 08:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:02 INFO - Reading from file tmpfile_stdout 08:18:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:18:02 INFO - Reading from file tmpfile_stdout 08:18:02 INFO - Output received: 08:18:02 INFO - Usage: mozinstall [options] installer 08:18:02 INFO - Options: 08:18:02 INFO - -h, --help show this help message and exit 08:18:02 INFO - -d DEST, --destination=DEST 08:18:02 INFO - Directory to install application into. [default: 08:18:02 INFO - "/builds/slave/test"] 08:18:02 INFO - --app=APP Application being installed. [default: firefox] 08:18:02 INFO - mkdir: /builds/slave/test/build/application 08:18:02 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'] 08:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:18:17 INFO - Reading from file tmpfile_stdout 08:18:17 INFO - Output received: 08:18:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:18:17 INFO - Running post-action listener: _resource_record_post_action 08:18:17 INFO - [mozharness: 2017-03-12 15:18:17.783440Z] Finished install step (success) 08:18:17 INFO - [mozharness: 2017-03-12 15:18:17.783717Z] Running run-tests step. 08:18:17 INFO - Running pre-action listener: _resource_record_pre_action 08:18:17 INFO - Running main action method: run_tests 08:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:18:17 INFO - Python 2.7.3 08:18:17 INFO - Return code: 0 08:18:17 INFO - grabbing minidump binary from tooltool 08:18:17 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')]} 08:18:17 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 0x2449290>, '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 0x2449b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:18:17 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 08:18:17 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 08:18:17 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 08:18:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:18:17 INFO - Return code: 0 08:18:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:18:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:18:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:18:17 INFO - ENV: RUST_BACKTRACE is now 1 08:18:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:18:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 08:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 08:18:17 INFO - Using env: {'DISPLAY': ':0', 08:18:17 INFO - 'HOME': '/home/cltbld', 08:18:17 INFO - 'LANG': 'en_US.UTF-8', 08:18:17 INFO - 'LANGUAGE': 'en_US:en', 08:18:17 INFO - 'LOGNAME': 'cltbld', 08:18:17 INFO - 'MAIL': '/var/mail/cltbld', 08:18:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:17 INFO - 'MOZ_NO_REMOTE': '1', 08:18:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:17 INFO - 'NO_EM_RESTART': '1', 08:18:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:17 INFO - 'PWD': '/builds/slave/test', 08:18:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:17 INFO - 'RUST_BACKTRACE': '1', 08:18:17 INFO - 'SHELL': '/bin/bash', 08:18:17 INFO - 'SHLVL': '1', 08:18:17 INFO - 'TERM': 'linux', 08:18:17 INFO - 'TMOUT': '86400', 08:18:17 INFO - 'USER': 'cltbld', 08:18:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459', 08:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:17 INFO - '_': '/tools/buildbot/bin/python'} 08:18:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 08:18:18 INFO - mozversion application_buildid: 20170312145206 08:18:18 INFO - mozversion application_changeset: f9362554866b327700c7f9b18050d7b7eb3d2b23 08:18:18 INFO - mozversion application_display_name: Nightly 08:18:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:18:18 INFO - mozversion application_name: Firefox 08:18:18 INFO - mozversion application_remotingname: firefox 08:18:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:18:18 INFO - mozversion application_vendor: Mozilla 08:18:18 INFO - mozversion application_version: 55.0a1 08:18:18 INFO - mozversion platform_buildid: 20170312145206 08:18:18 INFO - mozversion platform_changeset: f9362554866b327700c7f9b18050d7b7eb3d2b23 08:18:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:18:18 INFO - mozversion platform_version: 55.0a1 08:18:18 INFO - using testdate: 1489331898 08:18:18 INFO - actual date: 1489331898 08:18:18 INFO - starting webserver on 'localhost:40651' 08:18:18 INFO - SUITE-START | Running 2 tests 08:18:18 INFO - TEST-START | dromaeo_css 08:18:18 INFO - operating with platform_type : linux_ 08:18:18 INFO - Initialising browser for dromaeo_css test... 08:18:18 INFO - TEST-INFO | started process 3423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpheXONR/profile http://localhost:40651/getInfo.html) 08:18:23 INFO - PROCESS | 3423 | __metrics Screen width/height:1600/1200 08:18:23 INFO - PROCESS | 3423 | colorDepth:24 08:18:23 INFO - PROCESS | 3423 | Browser inner width/height: 1024/697 08:18:23 INFO - PROCESS | 3423 | __metrics 08:18:24 INFO - PROCESS | 3423 | 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" 08:18:24 INFO - PROCESS | 3423 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:18:24 INFO - PROCESS | 3423 | console.error: PushService: 08:18:24 INFO - PROCESS | 3423 | stateChangeProcessEnqueue: Error transitioning state 08:18:24 INFO - PROCESS | 3423 | UnknownError 08:18:25 INFO - TEST-INFO | 3423: exit 0 08:18:25 INFO - Browser initialized. 08:18:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:18:25 INFO - TEST-INFO | started process 3511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpheXONR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:37 INFO - PROCESS | 3511 | RSS: Main: 148262912 08:18:37 INFO - PROCESS | 3511 | 08:21:43 INFO - PROCESS | 3511 | Cycle 1(1): loaded http://localhost:40651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40651/tests/dromaeo/cssquery-ext.html) 08:21:46 INFO - PROCESS | 3511 | RSS: Main: 359342080 08:21:46 INFO - PROCESS | 3511 | 08:23:27 INFO - PROCESS | 3511 | ************************* 08:23:27 INFO - PROCESS | 3511 | A coding exception was thrown and uncaught in a Task. 08:23:27 INFO - PROCESS | 3511 | 08:23:27 ERROR - PROCESS | 3511 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:23:27 INFO - PROCESS | 3511 | Full stack: 08:23:27 INFO - PROCESS | 3511 | ************************* 08:24:49 INFO - PROCESS | 3511 | Cycle 1(1): loaded http://localhost:40651/tests/dromaeo/cssquery-ext.html (next: http://localhost:40651/tests/dromaeo/cssquery-jquery.html) 08:24:49 INFO - PROCESS | 3511 | RSS: Main: 243924992 08:24:49 INFO - PROCESS | 3511 | 08:27:51 INFO - PROCESS | 3511 | Cycle 1(1): loaded http://localhost:40651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40651/tests/dromaeo/cssquery-mootools.html) 08:27:52 INFO - PROCESS | 3511 | RSS: Main: 245030912 08:27:52 INFO - PROCESS | 3511 | 08:30:54 INFO - PROCESS | 3511 | Cycle 1(1): loaded http://localhost:40651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40651/tests/dromaeo/cssquery-prototype.html) 08:30:55 INFO - PROCESS | 3511 | RSS: Main: 216313856 08:30:55 INFO - PROCESS | 3511 | 08:33:58 INFO - PROCESS | 3511 | Cycle 1(1): loaded http://localhost:40651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40651/tests/dromaeo/cssquery-yui.html) 08:33:59 INFO - PROCESS | 3511 | RSS: Main: 191123456 08:33:59 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | Cycle 1(1): loaded http://localhost:40651/tests/dromaeo/cssquery-yui.html (next: http://localhost:40651/tests/dromaeo/cssquery-dojo.html) 08:37:02 INFO - PROCESS | 3511 | RSS: Main: 277348352 08:37:02 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | __start_tp_report 08:37:02 INFO - PROCESS | 3511 | _x_x_mozilla_page_load 08:37:02 INFO - PROCESS | 3511 | _x_x_mozilla_page_load_details 08:37:02 INFO - PROCESS | 3511 | |i|pagename|runs| 08:37:02 INFO - PROCESS | 3511 | |0;dojo.html;2587.7800386967106;2672.679278486582;2687.6371689821876;2707.783377329814;2709.078913169522;4880.585150262232;4923.18767403378;4927.852164435073;5014.373203349577;5081.187010078388;4997.950020499794;5000.899982000358;5045.318881950936;5049.343585333911;5084.0594490019275;4533.795979180936;4573.8170473181035;4609.953900460986;4615.492295847454;4625.375574297477;4647.67466277359;4665.370175026362;4690.718556886581;4692.155412025834;4718.57532822046;4467.977660111711;4493.123840851035;4539.954600453986;4563.70335928167;4612.630989520831;4529.8641040768825;4567.680262381635;4568.109218702354;4574.885627859297;4634.559716826896;4505.414296141481;4570.520095389969;4573.885652858672;4612.769361531943;4635.420572428447;4986.850394488135;5009.4239162496415;5010.574101201402;5011.824586139468;5043.319151914481;5224.059669259532;5259.658122222043;5315.654482458666;5337.973310133463;5406.16204488301;5380.461953804588;5382.569394448435;5387.568994480433;5387.568994480433;5402.729863506809;4969.453360130455;4999.725015124131;5021.271915572258;5021.5229553192385;5039.420466646309;5488.91766623501;5586.16207568868;5586.692731899703;5590.580706447033;5592.217089607459;5166.896662066738;5188.948110518922;5197.090509160882;5250.369955605352;5311.49540793624;5334.759935802898;5448.700321482277;5453.23654688344;5455.072637651609;5455.072637651609;5355.223492593552;5355.98236335095;5368.489993450616;5369.194620806832;5374.408815030343;5175.378954525481;5216.139337009351;5278.049951008778;5279.656822306538;5302.92045619316;4499.505054444008;4505.909881802346;4516.36770852081;4522.909541809211;4525.185466615975;3933.350997085506;3951.7036222283446;3955;3958.129211573449;3961.286968345668;4647.395838541036;4648.2098043332035;4659.394278743742;4660.091282200006;4698.835540756126;5203.2195170723935;5234;5404.189371594292;5449.536789372948;5481.862953426196;4500.617447516932;4604.1252162089095;4608.101420223024;4614.400127983407;4628.4445866496235;4853.611711063107;4911.16510193268;4929.901401971941;4938.111139994836;4939.456659767423;5121.795128194905;5121.871953201051;5133.02472530233;5134.845954621367;5173.094708426086;5267.631265811357;5306.416294207711;5482.972585137209;5485.780568777204;5486.1222204447095;5045.318881951036;5048.1165795984825;5049.974750126225;5058.772355243949;5059.038782631288;5296.861174847426;5299.655522391032;5306.708131052829;5307.283516725192;5308.708021058879;5380.408155103014;5384.542313903362;5387.353517577759;5388.973055134699;5389.676619402849;5168.819091331786;5219.791208351623;5224.320838290998;5227.215917612389;5231.895362092813;5183.222516622386;5191.662541934762;5205.791768329376;5315.176147697113;5315.681059136464;5214.661047032083;5215.16557350822;5217.452167522507;5220.086484865057;5231.712255825966;5302.8144014960835;5309.362876454696;5319.547838433777;5319.6808191508635;5362.651427657346;4991.376077990251;5020.42265139499;5093.439721630692;5106.46382129871;5110.79556817738 08:37:02 INFO - PROCESS | 3511 | |1;ext.html;674.0832467843732;693.5387967001946;752.7064444866503;764.747633281017;765.6516285090285;25193.748062519368;35567.64432355676;36272.27455450893;40174.7991260044;40200.798996005055;35792.82103589485;35816.641833581656;35972.2805543889;35976.42365433362;35981.28037439256;6399.9040014399825;7358.521696089764;7513.887291690602;7516.5114267572435;7519.13529944058;6523.543351965364;9040.909590904106;9191.08089191079;9213.401128926633;9227.215686666641;9245.676401325954;9257.768555786091;9267.119623635777;9268.119528644767;9268.258539316872;9204.493752843591;9226.308026897976;9231.861522077174;9232.6306947722;9235.39969901961;9030.86453703195;9064.592093355815;9073.954630226806;9078.86381704275;9080.545972701404;33232.833835830905;33302.3339533208;33350.16624584381;33477.83261083703;33564.6643533564;3405.5743032120986;3421.538092357525;3443.913902152466;3480.738944579167;3505.4566542186003;23587.7641223589;23942.880285598636;24007;24040.9181586829;24108.638370424458;3305.586801649794;3368.208471009311;3432.982835085809;3446.2245994651253;3555.2889422115422;165270;171899;171926;172339;172970;43964.340534892;44392.55607443949;44452;44461.55538444639;44523.777381112886;46685.533144668116;46811;46828.7658561705;46934.295985560246;46939.5306046942;12608.11743177987;12881.355932203352;12887.355632218352;12892;12898.290594017419;10323.74190645225;10325.277230593936;10327.896721032694;10330.690079297634;10336.638217662347;12445.688857778629;12561.309127998047;12608.432620532098;12658.936705316415;12755;5051.520105589963;5079.771410286472;5168.81909133186;5204.866004937957;5220.973895130576;801.1307731111809;828.5318794880873;842.3345557010016;843.8734189871568;865.4763867859854;21375.67936480954;21944.341669749934;22112.459357588545;22332.77667223307;22585.774142258368;873.8514452543083;874.8337815815102;890.7461373508519;896.7982204004047;899.2356496977517;11493.942530287295;11632.592859250055;11764.70588235301;11857.288562686266;12002.399880005965;203014;204146;204153;204664;207535;40822.1835563293;40887.1822563553;40991.18017639631;40991.180176396905;41015;1174.4127936031985;1205.6804946689135;1212.3271584270815;1214.0712355048395;1214.623466725318;20115.497112572302;20154.798452015293;20919.37241882746;21110;21560.892195538923;29922;30012.849935750182;30027.099187024425;30086.398272034;30118.54822177625;201922;204032;204123;204232;204581;27535.86232068827;27559.17322480329;32228;33115.50326745053;33571.83214083914;35614.82192589124;35724.64275357213;37892.24215515729;39229.215415692095;44176.116477669624;31736.682633173372;31850;33137.66862331346;33500.83249583736;33983.320333593685;31958;32231;32396;32468.67531324751;33293.667063330024;33000.55490843984;33354.332913342085;33466.49800253047;33633.49549756707;33675.326493470486;24989.37526561778;26862.194134175224;27907.860460697568;28818.279543010754;29568.55647165251;22993.284298048926;23444;23463.178788742312;23712.170074047324;23738.406539836644 08:37:02 INFO - PROCESS | 3511 | |2;jquery.html;358.77755791409317;369.05153754850045;399.8060940443885;409.87293938878946;422.9090745489719;12014.2791432514;12584.119111662176;13637.65905852353;19175.32886348978;19391.70912436311;17302.913485432586;17629.294828206857;17922.910385448053;17987.280508779633;18024.09879506023;5625.718714064301;5864.266966629171;5908.320543137551;5956.434138756833;5958.404159584029;5655.4061823508555;5758.992176369119;5787;5792.942070579304;5796.681182534959;5762.366139724627;5793.073108302672;5794.884102317951;5798.7100644967795;5803.477687008169;5602.411746766592;5718.370979192307;5724.627899186539;5768.625039372428;5769.336526299488;5371.946280537184;5584.86037849053;5609.915851262234;5617.325920889479;5620;17428;17522.299108035662;17690;17863.73204401935;17874.731879021823;2385.427497400629;2432.3797431654993;2444.1567659157563;2452.3991622052713;2505.711843138026;11928.522859085626;12251.203671761306;13812.171269723749;13883.583492495241;14325.115416917288;1961.622588983902;1967.45894878908;1976.347805224287;1990.1840245499275;2006.8294194993443;89222.10777892268;90058.5497072517;90207;90528.5473572628;91817;15154.696906062038;15729.842701572838;15730.528084157493;15800.288986995613;16193.838061619468;27460.45079098407;27477.17568472949;27529;27542.934279929086;27750.861245693643;7870.921290787133;7949.960250198712;8206.056303525052;8251.669933202606;8349.582520874053;6383.9361606383345;6451.580647257913;6461.903071453932;6629.834254143685;6638.302978187221;8458.139209373929;8524.74425767228;8561.824347843427;8667.263282621048;8675.6529738811;3372.5278461015478;3509.105178179599;3512.332656795201;3668.926621467556;3705.40713485841;792.7027364738224;802.6508468816083;824.5959479854828;827.6854795177794;844.1136806353427;18439;19469.51326216856;19590.412287631392;19725;19865.205391784166;792.9722459713882;795.0975642645524;801.4910531812225;808.890799742039;813.341193633159;9974.152197063186;10637.202209834293;10639.202059845542;10724.624638137628;10830.350178989285;471066;472111;474817;480278;481902;84373.57813210895;85720.57139714262;87263.56368218118;87556;88839;1057.9471026448646;1065.4406436620682;1100.460774220626;1101.130107215307;1102.73534351755;15740.370385184464;16200.270987805812;16394.754078689068;16494.505164845075;16653.5836604081;38089.23821523499;38843.61156388513;39192.804035979636;41986.58013419949;45477.99742028308;54288;55116.17325740197;55166.17250741323;55758.44241557532;56812;10322.638707645196;10363.63727269542;10804.189685773756;10851.891481085087;11119.944400278271;12558.309292988608;12572.182808117443;12664.556740514037;12781.105322627327;13270.933645331712;11103.833442498531;11226.943865280948;11436.370999595103;11473.942630286796;11716.589919352782;10160;10341.4312212829;10364.948175259075;10367.481625918523;10438.53026613789;11101.888981110085;11433.771324573296;11474.4262786862;11515.136364772508;11929.463174157358;10975.725606859573;10988.615398461016;11018.228723989243;11303.604373847205;11374.317540947239;11020.283681560673;11122.277051991918;11220.438978050901;11252.493637786156;11434 08:37:02 INFO - PROCESS | 3511 | |3;mootools.html;1295.6631275868272;1455.410558723717;1456.0462896802599;1470.867621914028;1472.6907349456615;8060.274575288223;9234.722958311253;9335.206507446876;9706.757331066709;9793.755156121082;9542.188913942324;9585.376950498212;9616.855747163781;9618.47098409589;9626;1623.7889074420368;1914.0812410043222;1939.6508628446945;1942.8445724342018;1944.0474167657887;1643.1291415549717;1662.03601910892;1830.8718389712726;1896.933607323744;1898.4874083997313;1934.2263094762068;1939.6411663842234;1940.3499827557785;1942.3978566644314;1943.1935746665117;1863.4409677096817;1884.1709647755013;1886.3020682347483;1891.905404729765;1892.4795681187645;1766.97349539757;1790.1228398084845;1791.713325867868;1793.9774328632684;1794.667986422503;9323.627054917795;9404.717858464257;9431.811363772686;9444.244460443148;9447.90552094477;4509.3461448090175;4652.441706995149;4655.441347038343;4658.953410465886;4669.0195059037305;2538.3019669590826;2724.087430710714;2726.5364887968894;2769.155407600681;2785.9303517412022;964.5804075227298;981.6809536900536;991.9950400248025;1001.0440029771551;1051.8369652703843;13188.83467967681;13193.076484646079;13207;13212.471501140039;13213;3738.36447803874;3769.509963704701;3869.897079332433;3876.7092468065007;3881.5924327945722;11335.659930202108;11421.600243991421;11426.714332141762;11467.77064458706;11493.195476316745;4623.052274283764;4628.352030715702;4633.4208223972;4637.536246375403;4638;4102.138550904344;4259.467566554181;4269.487661480643;4308.870733877989;4357.346398040256;3155.25851424915;3269.9673003269663;3270.6565810590023;3282.1466418730824;3305.7933854143066;899.6356475627381;911.9133682300171;921.944683319003;937.9494965638529;938.737153596994;770.3067239484396;785.2500861677084;794.0630056533231;799.0531220503722;804.2560631415917;5703.572232082611;5916.053431450947;5947.286325640951;6066.117684681807;6083.939160608337;954.7445109680748;955.7037318431309;962.1399422120238;968.8692026576322;986.0386123529645;3744.569374521965;3856.4408160816524;4083.959160408417;4110.691698122653;4170.4995400552125;11783.469743861375;12231.633051008484;12255.877441225652;12262.877371226352;12285.140040197279;12114.273143611412;12129.090318226168;12129.818052729217;12150.210236334788;12153.392330383445;8287.12985136564;8552.187542183607;8618.224359807647;8626;8628.35287353451;5902.881942361043;5991.131285963424;6083.6045657032155;6100.816975490742;6204.410580994799;10737.141028717528;10892.836607451052;11009.779804404026;11026.44867756625;11026.614068507884;10775.892241077803;10810.729731756453;11011.944940275247;11071.225014248925;11108.888911110786;7402.777916662509;7670.7315243966195;7730.072391312853;8064.677412903418;8208.220219079178;9170.908290917005;9188.21900138469;9263.351565390627;9271.258299336172;9278.350515463853;8060.516369017878;8130.349572034342;8130.552819594979;8244.670213191404;8319.584020798815;7703.614819259126;7761.72833950809;7863.567503787347;7866.646000929857;8040.87938680932;6548.47612191014;6783.966080169567;6949.061876646588;7117.964410177916;7127.75052873147;5004.924926126038;5066.645334826527;5089.236614507706;5126.53861152498;5168.8449346519665;5159.587233021424;5192.221166825007;5384.488473595002;5401.162819762943;5441.700706461183 08:37:02 INFO - PROCESS | 3511 | |4;prototype.html;349.99475007874884;365.97987110708914;368.9612590677977;370.0212936782211;373.79254513744894;4729.999999999995;4759.571638552529;4770.7853146608395;4786.353842231298;4830.830920917769;4458.152950939319;4617.4762328431625;4666.943152235292;4680.549029800764;4704.670673052888;3959.4654721612646;3968.72218944674;3977.9204415911663;3981.5620281768984;3999.1601763629747;3985.561588225293;3988.461557689718;3995.9200815983663;4010.8997275068064;4026.5369482509595;3781.905452363699;3921.686265098785;3984.5019372578427;3994.6205110514456;4004.799760011988;3944.5266568011734;3950.1112249743865;3963.929738970462;3973.403989401584;3984.501937257857;3657.3599620066384;3677.2277821657485;3679.5032670589394;3681.7606855554304;3695.593484716679;4553.704009239389;4575.885602859922;4580.862574122782;4593.83921562747;4596.058522545573;4328.523862375137;4464.665150113722;4499.1451624191295;4525.886852828673;4554.111948170108;4879.268109783526;4908.533689299511;4911.680740751875;4929.334539837112;4947.314250883115;4023.416604592347;4034.5561988181275;4041.6864519031433;4069.2065047315787;4072.552019277877;5014.699118052892;5165.302684137669;5182.974085129588;5192.402873669576;5216.7913283468615;4145.461090058334;4157.958420415757;4162.9791851041155;4165.208610364021;4183.707140500136;4227.429297044921;4238.279492486285;4242.893927651833;4254.085371645049;4271.743695378287;4344.739315641072;4491.418752872052;4523.2988886722615;4542.931856022163;4576.450825900846;4914.533119353656;4914.754262286871;4918.2376731606655;4948.455669876311;4979.875503112451;1455.4760286296926;1456.1044957351153;1463.7365274250737;1465.728840164573;1470.713210923881;1034.8344264917578;1120.7086157599083;1121.1535290855352;1122.3770807201918;1131.2081542919825;4220.831166753295;4296.291111966553;4320.373545835836;4365.650747940157;4381.291296394409;5032.7483625819295;5041.621878359138;5055.595552355802;5079.425378132791;5108.208227724708;4110.787317741214;4319.222539942841;4367.825286988485;4368.344748287719;4429.778511074498;2663.429790252416;2696.662917135358;2704.553748631493;2707.323169207698;2712.91861244163;4769.928451073237;4775.868873424462;4803.375561177025;4828.806847726122;4832.830850920272;4957;5178.81874134411;5244.6328756987405;5245.370555533361;5259.500347467061;4728.281238287929;4746.240601503743;4747.382840230817;4759.714417134983;4773.904521909542;5040.36995375578;5076.593872490266;5088.0469850276;5093.821716239914;5112.36095488064;4755.5719985201495;4976.576990955809;5009.373828271466;5014.52362025607;5024;4762.833300834454;4783;4793.832215872428;4797.208460603962;4801.615870730403;4151;4152.813123409514;4157.563455837094;4159;4179;4814.253790662453;5040.269160971712;5055.317532133115;5067.87330316745;5145.382554093533;4876.63512176597;4906.63200259989;4922.901541969069;4940.209566469348;4947.851564453073;4914.8771280718265;4927.433345165208;4937;4937.827355963364;4975.6517043808035;4612.723236605814;4856.68431551948;4858.137780464469;4871.805127794849;4904.215325547895;4913.9017219656125;4915.26271059344;4941.935999680221;4961.767204757802;4963.156263435297;4848.200046992207;4854.344663470386;4891.437484689164;4900.5099490052135;4916.975415122902 08:37:02 INFO - PROCESS | 3511 | |5;yui.html;648.4293821437135;673.5083389125938;718.5616773768;750.3546949623322;762.211111499598;12359.814602780965;13877.444902203924;13882.236476993787;14031.158130512176;14045.438182472702;11506.654800355982;11508.136889733261;11545.307281563091;11578.768424631502;11581.420928953561;836.234845116719;844.6916875340487;864.170396419435;869.652139144341;877.4209022045451;869.070094998352;869.1135042256926;869.2654706772767;869.8999615044288;873.4671850171422;900.3112618846587;901.6889173235223;902.0528445132585;902.4720538484994;902.702108304258;899.1727610598265;900.2033200617435;901.396064636695;901.5582364641344;902.7878448564582;658.3383699382139;661.3584822721951;661.6096503063216;662.3442791636294;663.4625952978055;13154.736905261841;13305.933470332684;13380.464781408731;13518.662033449144;14276.50096739848;13725.45098196071;14394.352254148589;14399.208043557705;14428.567142985727;14433.494827681086;10623.889104034479;10686.412247326394;10779.407132607703;10894.836577451344;10943.124550035978;3196.378692129395;3218.806871587712;3246.8376581170846;3277.0332751838264;3305.6033276007033;64000;66495.3350466494;67091.66454167747;67738;68138.65930670364;10968.341899486057;11000.944995274973;11053.447327633587;11063.778724425467;11202.943985280184;20054.59890802205;22072.33782986513;22139.33581992543;22166.556668866855;22337.553248935255;6654.234763002317;6675.198976122896;6697.430718388991;6699.229588597276;6957.2694867039245;3256.3487302539115;3259.3807176636365;3311.569495965509;3316.1543806329714;3324.451465508164;2625.7111717711036;2680.249530131566;2693.192042387276;2694.7844172466157;2696.379832638504;472.2066927561729;479.43666192224;481.67005601163316;483.15447966059395;492.75116066386244;521.015281118686;549.7773401772289;553.3636318234063;553.4238121544219;558.3383690326975;8219.465734727342;8692.869606955901;8839.425437346552;8923.509206993678;9022.368434209542;571.2744814086087;587.8941790477755;597.2355385106983;600.3306313460461;612.5650787940613;3991.4888103768953;4243.236217480883;4245.405643209953;4273.444452221192;4342.739435633872;59025;59979;61025.084623730676;61911.380886191466;63564;42751.572484275384;44780.55219447829;47665.28502072472;53021;54068.72965635147;49738.25392619114;50402.49597503978;50560.49439505632;51199;51931.74034129805;7898.723544675909;8349.457285276438;9715.299653096183;9975.700728978143;10059.949700251453;27049.59425608578;31286.530702039032;32011.437655280144;32184.517232241065;32205;40951.38572921349;42345.153096937276;42743.358849616656;43161.56838431575;44379.77810110929;11604;11847.407629618658;12039.277643341427;12392.194507356993;12439;12128.151029427856;12669.292666713027;12723.491060357483;12786.680332991378;13109.60671179866;11247.887521124683;11281.830772538255;11430.14273929442;12282.631521054025;12555.183913045623;11645.88354116482;12022.671838138089;12197.917235151835;12284.692882678004;12709.745805084032;11948.581799636971;12258.14193006481;12396.442160102997;12436.37818109109;12869.163504372185;10088.243381746544;10453.372797632166;10602.25784195099;10647.89352106469;10729.034386905216;9244.352895297534;10274.33216840903;10318.690439286833;10394.48027598602;10425.218108642033 08:37:02 INFO - PROCESS | 3511 | __end_tp_report 08:37:02 INFO - PROCESS | 3511 | __start_cc_report 08:37:02 INFO - PROCESS | 3511 | _x_x_mozilla_cycle_collect,2727 08:37:02 INFO - PROCESS | 3511 | __end_cc_report 08:37:02 INFO - PROCESS | 3511 | __startTimestamp1489333022454__endTimestamp 08:37:02 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | ------- Summary: start ------- 08:37:02 INFO - PROCESS | 3511 | Number of tests: 6 08:37:02 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | [#0] dojo.html Cycles:165 Average:4955.52 Median:5093.44 stddev:543.62 (10.7%) stddev-sans-first:512.57 08:37:02 INFO - PROCESS | 3511 | Values: 2587.8 2672.7 2687.6 2707.8 2709.1 4880.6 4923.2 4927.9 5014.4 5081.2 4998.0 5000.9 5045.3 5049.3 5084.1 4533.8 4573.8 4610.0 4615.5 4625.4 4647.7 4665.4 4690.7 4692.2 4718.6 4468.0 4493.1 4540.0 4563.7 4612.6 4529.9 4567.7 4568.1 4574.9 4634.6 4505.4 4570.5 4573.9 4612.8 4635.4 4986.9 5009.4 5010.6 5011.8 5043.3 5224.1 5259.7 5315.7 5338.0 5406.2 5380.5 5382.6 5387.6 5387.6 5402.7 4969.5 4999.7 5021.3 5021.5 5039.4 5488.9 5586.2 5586.7 5590.6 5592.2 5166.9 5188.9 5197.1 5250.4 5311.5 5334.8 5448.7 5453.2 5455.1 5455.1 5355.2 5356.0 5368.5 5369.2 5374.4 5175.4 5216.1 5278.0 5279.7 5302.9 4499.5 4505.9 4516.4 4522.9 4525.2 3933.4 3951.7 3955.0 3958.1 3961.3 4647.4 4648.2 4659.4 4660.1 4698.8 5203.2 5234.0 5404.2 5449.5 5481.9 4500.6 4604.1 4608.1 4614.4 4628.4 4853.6 4911.2 4929.9 4938.1 4939.5 5121.8 5121.9 5133.0 5134.8 5173.1 5267.6 5306.4 5483.0 5485.8 5486.1 5045.3 5048.1 5050.0 5058.8 5059.0 5296.9 5299.7 5306.7 5307.3 5308.7 5380.4 5384.5 5387.4 5389.0 5389.7 5168.8 5219.8 5224.3 5227.2 5231.9 5183.2 5191.7 5205.8 5315.2 5315.7 5214.7 5215.2 5217.5 5220.1 5231.7 5302.8 5309.4 5319.5 5319.7 5362.7 4991.4 5020.4 5093.4 5106.5 5110.8 08:37:02 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | [#1] ext.html Cycles:180 Average:34414.01 Median:33489.33 stddev:50125.96 (149.7%) stddev-sans-first:50202.56 08:37:02 INFO - PROCESS | 3511 | Values: 674.1 693.5 752.7 764.7 765.7 25193.7 35567.6 36272.3 40174.8 40200.8 35792.8 35816.6 35972.3 35976.4 35981.3 6399.9 7358.5 7513.9 7516.5 7519.1 6523.5 9040.9 9191.1 9213.4 9227.2 9245.7 9257.8 9267.1 9268.1 9268.3 9204.5 9226.3 9231.9 9232.6 9235.4 9030.9 9064.6 9074.0 9078.9 9080.5 33232.8 33302.3 33350.2 33477.8 33564.7 3405.6 3421.5 3443.9 3480.7 3505.5 23587.8 23942.9 24007.0 24040.9 24108.6 3305.6 3368.2 3433.0 3446.2 3555.3 165270.0 171899.0 171926.0 172339.0 172970.0 43964.3 44392.6 44452.0 44461.6 44523.8 46685.5 46811.0 46828.8 46934.3 46939.5 12608.1 12881.4 12887.4 12892.0 12898.3 10323.7 10325.3 10327.9 10330.7 10336.6 12445.7 12561.3 12608.4 12658.9 12755.0 5051.5 5079.8 5168.8 5204.9 5221.0 801.1 828.5 842.3 843.9 865.5 21375.7 21944.3 22112.5 22332.8 22585.8 873.9 874.8 890.7 896.8 899.2 11493.9 11632.6 11764.7 11857.3 12002.4 203014.0 204146.0 204153.0 204664.0 207535.0 40822.2 40887.2 40991.2 40991.2 41015.0 1174.4 1205.7 1212.3 1214.1 1214.6 20115.5 20154.8 20919.4 21110.0 21560.9 29922.0 30012.8 30027.1 30086.4 30118.5 201922.0 204032.0 204123.0 204232.0 204581.0 27535.9 27559.2 32228.0 33115.5 33571.8 35614.8 35724.6 37892.2 39229.2 44176.1 31736.7 31850.0 33137.7 33500.8 33983.3 31958.0 32231.0 32396.0 32468.7 33293.7 33000.6 33354.3 33466.5 33633.5 33675.3 24989.4 26862.2 27907.9 28818.3 29568.6 22993.3 23444.0 23463.2 23712.2 23738.4 08:37:02 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | [#2] jquery.html Cycles:180 Average:29025.00 Median:27503.09 stddev:78536.36 (285.6%) stddev-sans-first:78727.18 08:37:02 INFO - PROCESS | 3511 | Values: 358.8 369.1 399.8 409.9 422.9 12014.3 12584.1 13637.7 19175.3 19391.7 17302.9 17629.3 17922.9 17987.3 18024.1 5625.7 5864.3 5908.3 5956.4 5958.4 5655.4 5759.0 5787.0 5792.9 5796.7 5762.4 5793.1 5794.9 5798.7 5803.5 5602.4 5718.4 5724.6 5768.6 5769.3 5371.9 5584.9 5609.9 5617.3 5620.0 17428.0 17522.3 17690.0 17863.7 17874.7 2385.4 2432.4 2444.2 2452.4 2505.7 11928.5 12251.2 13812.2 13883.6 14325.1 1961.6 1967.5 1976.3 1990.2 2006.8 89222.1 90058.5 90207.0 90528.5 91817.0 15154.7 15729.8 15730.5 15800.3 16193.8 27460.5 27477.2 27529.0 27542.9 27750.9 7870.9 7950.0 8206.1 8251.7 8349.6 6383.9 6451.6 6461.9 6629.8 6638.3 8458.1 8524.7 8561.8 8667.3 8675.7 3372.5 3509.1 3512.3 3668.9 3705.4 792.7 802.7 824.6 827.7 844.1 18439.0 19469.5 19590.4 19725.0 19865.2 793.0 795.1 801.5 808.9 813.3 9974.2 10637.2 10639.2 10724.6 10830.4 471066.0 472111.0 474817.0 480278.0 481902.0 84373.6 85720.6 87263.6 87556.0 88839.0 1057.9 1065.4 1100.5 1101.1 1102.7 15740.4 16200.3 16394.8 16494.5 16653.6 38089.2 38843.6 39192.8 41986.6 45478.0 54288.0 55116.2 55166.2 55758.4 56812.0 10322.6 10363.6 10804.2 10851.9 11119.9 12558.3 12572.2 12664.6 12781.1 13270.9 11103.8 11226.9 11436.4 11473.9 11716.6 10160.0 10341.4 10364.9 10367.5 10438.5 11101.9 11433.8 11474.4 11515.1 11929.5 10975.7 10988.6 11018.2 11303.6 11374.3 11020.3 11122.3 11220.4 11252.5 11434.0 08:37:02 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | [#3] mootools.html Cycles:180 Average:5879.78 Median:4635.48 stddev:3795.31 (81.9%) stddev-sans-first:3790.33 08:37:02 INFO - PROCESS | 3511 | Values: 1295.7 1455.4 1456.0 1470.9 1472.7 8060.3 9234.7 9335.2 9706.8 9793.8 9542.2 9585.4 9616.9 9618.5 9626.0 1623.8 1914.1 1939.7 1942.8 1944.0 1643.1 1662.0 1830.9 1896.9 1898.5 1934.2 1939.6 1940.3 1942.4 1943.2 1863.4 1884.2 1886.3 1891.9 1892.5 1767.0 1790.1 1791.7 1794.0 1794.7 9323.6 9404.7 9431.8 9444.2 9447.9 4509.3 4652.4 4655.4 4659.0 4669.0 2538.3 2724.1 2726.5 2769.2 2785.9 964.6 981.7 992.0 1001.0 1051.8 13188.8 13193.1 13207.0 13212.5 13213.0 3738.4 3769.5 3869.9 3876.7 3881.6 11335.7 11421.6 11426.7 11467.8 11493.2 4623.1 4628.4 4633.4 4637.5 4638.0 4102.1 4259.5 4269.5 4308.9 4357.3 3155.3 3270.0 3270.7 3282.1 3305.8 899.6 911.9 921.9 937.9 938.7 770.3 785.3 794.1 799.1 804.3 5703.6 5916.1 5947.3 6066.1 6083.9 954.7 955.7 962.1 968.9 986.0 3744.6 3856.4 4084.0 4110.7 4170.5 11783.5 12231.6 12255.9 12262.9 12285.1 12114.3 12129.1 12129.8 12150.2 12153.4 8287.1 8552.2 8618.2 8626.0 8628.4 5902.9 5991.1 6083.6 6100.8 6204.4 10737.1 10892.8 11009.8 11026.4 11026.6 10775.9 10810.7 11011.9 11071.2 11108.9 7402.8 7670.7 7730.1 8064.7 8208.2 9170.9 9188.2 9263.4 9271.3 9278.4 8060.5 8130.3 8130.6 8244.7 8319.6 7703.6 7761.7 7863.6 7866.6 8040.9 6548.5 6784.0 6949.1 7118.0 7127.8 5004.9 5066.6 5089.2 5126.5 5168.8 5159.6 5192.2 5384.5 5401.2 5441.7 08:37:02 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | [#4] prototype.html Cycles:180 Average:4237.32 Median:4604.39 stddev:1116.27 (24.2%) stddev-sans-first:1080.59 08:37:02 INFO - PROCESS | 3511 | Values: 350.0 366.0 369.0 370.0 373.8 4730.0 4759.6 4770.8 4786.4 4830.8 4458.2 4617.5 4666.9 4680.5 4704.7 3959.5 3968.7 3977.9 3981.6 3999.2 3985.6 3988.5 3995.9 4010.9 4026.5 3781.9 3921.7 3984.5 3994.6 4004.8 3944.5 3950.1 3963.9 3973.4 3984.5 3657.4 3677.2 3679.5 3681.8 3695.6 4553.7 4575.9 4580.9 4593.8 4596.1 4328.5 4464.7 4499.1 4525.9 4554.1 4879.3 4908.5 4911.7 4929.3 4947.3 4023.4 4034.6 4041.7 4069.2 4072.6 5014.7 5165.3 5183.0 5192.4 5216.8 4145.5 4158.0 4163.0 4165.2 4183.7 4227.4 4238.3 4242.9 4254.1 4271.7 4344.7 4491.4 4523.3 4542.9 4576.5 4914.5 4914.8 4918.2 4948.5 4979.9 1455.5 1456.1 1463.7 1465.7 1470.7 1034.8 1120.7 1121.2 1122.4 1131.2 4220.8 4296.3 4320.4 4365.7 4381.3 5032.7 5041.6 5055.6 5079.4 5108.2 4110.8 4319.2 4367.8 4368.3 4429.8 2663.4 2696.7 2704.6 2707.3 2712.9 4769.9 4775.9 4803.4 4828.8 4832.8 4957.0 5178.8 5244.6 5245.4 5259.5 4728.3 4746.2 4747.4 4759.7 4773.9 5040.4 5076.6 5088.0 5093.8 5112.4 4755.6 4976.6 5009.4 5014.5 5024.0 4762.8 4783.0 4793.8 4797.2 4801.6 4151.0 4152.8 4157.6 4159.0 4179.0 4814.3 5040.3 5055.3 5067.9 5145.4 4876.6 4906.6 4922.9 4940.2 4947.9 4914.9 4927.4 4937.0 4937.8 4975.7 4612.7 4856.7 4858.1 4871.8 4904.2 4913.9 4915.3 4941.9 4961.8 4963.2 4848.2 4854.3 4891.4 4900.5 4917.0 08:37:02 INFO - PROCESS | 3511 | 08:37:02 INFO - PROCESS | 3511 | [#5] yui.html Cycles:180 Average:14544.57 Median:22471.44 stddev:17482.31 (77.8%) stddev-sans-first:17500.21 08:37:02 INFO - PROCESS | 3511 | Values: 648.4 673.5 718.6 750.4 762.2 12359.8 13877.4 13882.2 14031.2 14045.4 11506.7 11508.1 11545.3 11578.8 11581.4 836.2 844.7 864.2 869.7 877.4 869.1 869.1 869.3 869.9 873.5 900.3 901.7 902.1 902.5 902.7 899.2 900.2 901.4 901.6 902.8 658.3 661.4 661.6 662.3 663.5 13154.7 13305.9 13380.5 13518.7 14276.5 13725.5 14394.4 14399.2 14428.6 14433.5 10623.9 10686.4 10779.4 10894.8 10943.1 3196.4 3218.8 3246.8 3277.0 3305.6 64000.0 66495.3 67091.7 67738.0 68138.7 10968.3 11000.9 11053.4 11063.8 11202.9 20054.6 22072.3 22139.3 22166.6 22337.6 6654.2 6675.2 6697.4 6699.2 6957.3 3256.3 3259.4 3311.6 3316.2 3324.5 2625.7 2680.2 2693.2 2694.8 2696.4 472.2 479.4 481.7 483.2 492.8 521.0 549.8 553.4 553.4 558.3 8219.5 8692.9 8839.4 8923.5 9022.4 571.3 587.9 597.2 600.3 612.6 3991.5 4243.2 4245.4 4273.4 4342.7 59025.0 59979.0 61025.1 61911.4 63564.0 42751.6 44780.6 47665.3 53021.0 54068.7 49738.3 50402.5 50560.5 51199.0 51931.7 7898.7 8349.5 9715.3 9975.7 10059.9 27049.6 31286.5 32011.4 32184.5 32205.0 40951.4 42345.2 42743.4 43161.6 44379.8 11604.0 11847.4 12039.3 12392.2 12439.0 12128.2 12669.3 12723.5 12786.7 13109.6 11247.9 11281.8 11430.1 12282.6 12555.2 11645.9 12022.7 12197.9 12284.7 12709.7 11948.6 12258.1 12396.4 12436.4 12869.2 10088.2 10453.4 10602.3 10647.9 10729.0 9244.4 10274.3 10318.7 10394.5 10425.2 08:37:02 INFO - PROCESS | 3511 | -------- Summary: end -------- 08:37:02 INFO - PROCESS | 3511 | 08:37:03 INFO - TEST-INFO | 3511: exit 0 08:37:03 INFO - TEST-OK | dromaeo_css | took 1125126ms 08:37:03 INFO - TEST-START | kraken 08:37:03 INFO - operating with platform_type : linux_ 08:37:03 INFO - Initialising browser for kraken test... 08:37:03 INFO - TEST-INFO | started process 3834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOKc1BZ/profile http://localhost:40651/getInfo.html) 08:37:07 INFO - PROCESS | 3834 | __metrics Screen width/height:1600/1200 08:37:07 INFO - PROCESS | 3834 | colorDepth:24 08:37:07 INFO - PROCESS | 3834 | Browser inner width/height: 1024/697 08:37:07 INFO - PROCESS | 3834 | __metrics 08:37:08 INFO - PROCESS | 3834 | 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" 08:37:08 INFO - PROCESS | 3834 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:37:10 INFO - TEST-INFO | 3834: exit 0 08:37:10 INFO - Browser initialized. 08:37:10 INFO - Running cycle 1/1 for kraken test... 08:37:10 INFO - TEST-INFO | started process 3928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOKc1BZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:22 INFO - PROCESS | 3928 | RSS: Main: 148873216 08:37:22 INFO - PROCESS | 3928 | 08:37:25 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40651/tests/kraken/driver.html?testName=audio-beat-detection) 08:37:26 INFO - PROCESS | 3928 | RSS: Main: 202956800 08:37:26 INFO - PROCESS | 3928 | 08:37:28 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40651/tests/kraken/driver.html?testName=audio-dft) 08:37:29 INFO - PROCESS | 3928 | RSS: Main: 183148544 08:37:29 INFO - PROCESS | 3928 | 08:37:32 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40651/tests/kraken/driver.html?testName=audio-fft) 08:37:33 INFO - PROCESS | 3928 | RSS: Main: 266113024 08:37:33 INFO - PROCESS | 3928 | 08:37:35 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40651/tests/kraken/driver.html?testName=audio-oscillator) 08:37:35 INFO - PROCESS | 3928 | RSS: Main: 176795648 08:37:35 INFO - PROCESS | 3928 | 08:37:38 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:37:38 INFO - PROCESS | 3928 | RSS: Main: 180244480 08:37:38 INFO - PROCESS | 3928 | 08:37:41 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40651/tests/kraken/driver.html?testName=imaging-darkroom) 08:37:42 INFO - PROCESS | 3928 | RSS: Main: 219127808 08:37:42 INFO - PROCESS | 3928 | 08:37:45 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40651/tests/kraken/driver.html?testName=imaging-desaturate) 08:37:46 INFO - PROCESS | 3928 | RSS: Main: 215150592 08:37:46 INFO - PROCESS | 3928 | 08:37:49 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40651/tests/kraken/driver.html?testName=json-parse-financial) 08:37:50 INFO - PROCESS | 3928 | RSS: Main: 216383488 08:37:50 INFO - PROCESS | 3928 | 08:37:51 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:52 INFO - PROCESS | 3928 | RSS: Main: 180363264 08:37:52 INFO - PROCESS | 3928 | 08:37:54 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40651/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:54 INFO - PROCESS | 3928 | RSS: Main: 186667008 08:37:54 INFO - PROCESS | 3928 | 08:37:57 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:57 INFO - PROCESS | 3928 | RSS: Main: 196640768 08:37:57 INFO - PROCESS | 3928 | 08:38:00 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:38:01 INFO - PROCESS | 3928 | RSS: Main: 206557184 08:38:01 INFO - PROCESS | 3928 | 08:38:04 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:38:05 INFO - PROCESS | 3928 | RSS: Main: 201519104 08:38:05 INFO - PROCESS | 3928 | 08:38:06 INFO - PROCESS | 3928 | Cycle 1(1): loaded http://localhost:40651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40651/tests/kraken/driver.html?testName=ai-astar) 08:38:07 INFO - PROCESS | 3928 | RSS: Main: 254455808 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | __start_tp_report 08:38:07 INFO - PROCESS | 3928 | _x_x_mozilla_page_load 08:38:07 INFO - PROCESS | 3928 | _x_x_mozilla_page_load_details 08:38:07 INFO - PROCESS | 3928 | |i|pagename|runs| 08:38:07 INFO - PROCESS | 3928 | |0;ai-astar;111;118;120;118;120;119;117;119;118;118 08:38:07 INFO - PROCESS | 3928 | |1;audio-beat-detection;161;126;124;173;123;128;125;124;147;122 08:38:07 INFO - PROCESS | 3928 | |2;audio-dft;162;162;162;162;162;161;161;161;161;160 08:38:07 INFO - PROCESS | 3928 | |3;audio-fft;74;76;75;103;77;76;78;77;92;77 08:38:07 INFO - PROCESS | 3928 | |4;audio-oscillator;85;85;120;86;84;84;104;85;84;111 08:38:07 INFO - PROCESS | 3928 | |5;imaging-gaussian-blur;114;113;114;113;113;113;114;114;113;114 08:38:07 INFO - PROCESS | 3928 | |6;imaging-darkroom;148;150;149;150;148;149;149;149;148;148 08:38:07 INFO - PROCESS | 3928 | |7;imaging-desaturate;94;94;94;94;93;94;94;94;94;93 08:38:07 INFO - PROCESS | 3928 | |8;json-parse-financial;65;64;64;70;66;65;66;67;64;65 08:38:07 INFO - PROCESS | 3928 | |9;json-stringify-tinderbox;55;56;58;55;55;55;56;56;55;55 08:38:07 INFO - PROCESS | 3928 | |10;stanford-crypto-aes;86;85;85;92;86;91;84;84;88;84 08:38:07 INFO - PROCESS | 3928 | |11;stanford-crypto-ccm;134;136;134;133;136;133;144;147;181;139 08:38:07 INFO - PROCESS | 3928 | |12;stanford-crypto-pbkdf2;185;180;182;183;185;185;179;187;179;184 08:38:07 INFO - PROCESS | 3928 | |13;stanford-crypto-sha256-iterative;67;67;67;68;67;70;68;67;67;67 08:38:07 INFO - PROCESS | 3928 | __end_tp_report 08:38:07 INFO - PROCESS | 3928 | __start_cc_report 08:38:07 INFO - PROCESS | 3928 | _x_x_mozilla_cycle_collect,1975 08:38:07 INFO - PROCESS | 3928 | __end_cc_report 08:38:07 INFO - PROCESS | 3928 | __startTimestamp1489333087030__endTimestamp 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | ------- Summary: start ------- 08:38:07 INFO - PROCESS | 3928 | Number of tests: 14 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#0] ai-astar Cycles:10 Average:117.80 Median:118.50 stddev:2.57 (2.2%) stddev-sans-first:1.01 08:38:07 INFO - PROCESS | 3928 | Values: 111.0 118.0 120.0 118.0 120.0 119.0 117.0 119.0 118.0 118.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:127.00 stddev:18.40 (14.5%) stddev-sans-first:17.01 08:38:07 INFO - PROCESS | 3928 | Values: 161.0 126.0 124.0 173.0 123.0 128.0 125.0 124.0 147.0 122.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 08:38:07 INFO - PROCESS | 3928 | Values: 162.0 162.0 162.0 162.0 162.0 161.0 161.0 161.0 161.0 160.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#3] audio-fft Cycles:10 Average:80.50 Median:77.00 stddev:9.40 (12.2%) stddev-sans-first:9.67 08:38:07 INFO - PROCESS | 3928 | Values: 74.0 76.0 75.0 103.0 77.0 76.0 78.0 77.0 92.0 77.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:84.50 stddev:13.57 (16.1%) stddev-sans-first:14.10 08:38:07 INFO - PROCESS | 3928 | Values: 85.0 85.0 120.0 86.0 84.0 84.0 104.0 85.0 84.0 111.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:38:07 INFO - PROCESS | 3928 | Values: 114.0 113.0 114.0 113.0 113.0 113.0 114.0 114.0 113.0 114.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 08:38:07 INFO - PROCESS | 3928 | Values: 148.0 150.0 149.0 150.0 148.0 149.0 149.0 149.0 148.0 148.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:38:07 INFO - PROCESS | 3928 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.50 stddev:1.84 (2.8%) stddev-sans-first:1.94 08:38:07 INFO - PROCESS | 3928 | Values: 65.0 64.0 64.0 70.0 66.0 65.0 66.0 67.0 64.0 65.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:55.50 stddev:0.97 (1.7%) stddev-sans-first:1.00 08:38:07 INFO - PROCESS | 3928 | Values: 55.0 56.0 58.0 55.0 55.0 55.0 56.0 56.0 55.0 55.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.92 (3.4%) stddev-sans-first:3.09 08:38:07 INFO - PROCESS | 3928 | Values: 86.0 85.0 85.0 92.0 86.0 91.0 84.0 84.0 88.0 84.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:137.50 stddev:14.61 (10.6%) stddev-sans-first:15.22 08:38:07 INFO - PROCESS | 3928 | Values: 134.0 136.0 134.0 133.0 136.0 133.0 144.0 147.0 181.0 139.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:184.50 stddev:2.81 (1.5%) stddev-sans-first:2.87 08:38:07 INFO - PROCESS | 3928 | Values: 185.0 180.0 182.0 183.0 185.0 185.0 179.0 187.0 179.0 184.0 08:38:07 INFO - PROCESS | 3928 | 08:38:07 INFO - PROCESS | 3928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 08:38:07 INFO - PROCESS | 3928 | Values: 67.0 67.0 67.0 68.0 67.0 70.0 68.0 67.0 67.0 67.0 08:38:07 INFO - PROCESS | 3928 | -------- Summary: end -------- 08:38:07 INFO - PROCESS | 3928 | 08:38:08 INFO - TEST-INFO | 3928: exit 0 08:38:08 INFO - TEST-OK | kraken | took 65063ms 08:38:08 INFO - SUITE-END | took 1190s 08:38:08 INFO - Completed test suite (00:19:50) 08:38:08 INFO - javascript benchmark 08:38:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6579.121569402793, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.7800386967106, 2672.679278486582, 2687.6371689821876, 2707.783377329814, 2709.078913169522, 4880.585150262232, 4923.18767403378, 4927.852164435073, 5014.373203349577, 5081.187010078388, 4997.950020499794, 5000.899982000358, 5045.318881950936, 5049.343585333911, 5084.0594490019275, 4533.795979180936, 4573.8170473181035, 4609.953900460986, 4615.492295847454, 4625.375574297477, 4647.67466277359, 4665.370175026362, 4690.718556886581, 4692.155412025834, 4718.57532822046, 4467.977660111711, 4493.123840851035, 4539.954600453986, 4563.70335928167, 4612.630989520831, 4529.8641040768825, 4567.680262381635, 4568.109218702354, 4574.885627859297, 4634.559716826896, 4505.414296141481, 4570.520095389969, 4573.885652858672, 4612.769361531943, 4635.420572428447, 4986.850394488135, 5009.4239162496415, 5010.574101201402, 5011.824586139468, 5043.319151914481, 5224.059669259532, 5259.658122222043, 5315.654482458666, 5337.973310133463, 5406.16204488301, 5380.461953804588, 5382.569394448435, 5387.568994480433, 5387.568994480433, 5402.729863506809, 4969.453360130455, 4999.725015124131, 5021.271915572258, 5021.5229553192385, 5039.420466646309, 5488.91766623501, 5586.16207568868, 5586.692731899703, 5590.580706447033, 5592.217089607459, 5166.896662066738, 5188.948110518922, 5197.090509160882, 5250.369955605352, 5311.49540793624, 5334.759935802898, 5448.700321482277, 5453.23654688344, 5455.072637651609, 5455.072637651609, 5355.223492593552, 5355.98236335095, 5368.489993450616, 5369.194620806832, 5374.408815030343, 5175.378954525481, 5216.139337009351, 5278.049951008778, 5279.656822306538, 5302.92045619316, 4499.505054444008, 4505.909881802346, 4516.36770852081, 4522.909541809211, 4525.185466615975, 3933.350997085506, 3951.7036222283446, 3955.0, 3958.129211573449, 3961.286968345668, 4647.395838541036, 4648.2098043332035, 4659.394278743742, 4660.091282200006, 4698.835540756126, 5203.2195170723935, 5234.0, 5404.189371594292, 5449.536789372948, 5481.862953426196, 4500.617447516932, 4604.1252162089095, 4608.101420223024, 4614.400127983407, 4628.4445866496235, 4853.611711063107, 4911.16510193268, 4929.901401971941, 4938.111139994836, 4939.456659767423, 5121.795128194905, 5121.871953201051, 5133.02472530233, 5134.845954621367, 5173.094708426086, 5267.631265811357, 5306.416294207711, 5482.972585137209, 5485.780568777204, 5486.1222204447095, 5045.318881951036, 5048.1165795984825, 5049.974750126225, 5058.772355243949, 5059.038782631288, 5296.861174847426, 5299.655522391032, 5306.708131052829, 5307.283516725192, 5308.708021058879, 5380.408155103014, 5384.542313903362, 5387.353517577759, 5388.973055134699, 5389.676619402849, 5168.819091331786, 5219.791208351623, 5224.320838290998, 5227.215917612389, 5231.895362092813, 5183.222516622386, 5191.662541934762, 5205.791768329376, 5315.176147697113, 5315.681059136464, 5214.661047032083, 5215.16557350822, 5217.452167522507, 5220.086484865057, 5231.712255825966, 5302.8144014960835, 5309.362876454696, 5319.547838433777, 5319.6808191508635, 5362.651427657346, 4991.376077990251, 5020.42265139499, 5093.439721630692, 5106.46382129871, 5110.79556817738], "value": 4918.328390420424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.0832467843732, 693.5387967001946, 752.7064444866503, 764.747633281017, 765.6516285090285, 25193.748062519368, 35567.64432355676, 36272.27455450893, 40174.7991260044, 40200.798996005055, 35792.82103589485, 35816.641833581656, 35972.2805543889, 35976.42365433362, 35981.28037439256, 6399.9040014399825, 7358.521696089764, 7513.887291690602, 7516.5114267572435, 7519.13529944058, 6523.543351965364, 9040.909590904106, 9191.08089191079, 9213.401128926633, 9227.215686666641, 9245.676401325954, 9257.768555786091, 9267.119623635777, 9268.119528644767, 9268.258539316872, 9204.493752843591, 9226.308026897976, 9231.861522077174, 9232.6306947722, 9235.39969901961, 9030.86453703195, 9064.592093355815, 9073.954630226806, 9078.86381704275, 9080.545972701404, 33232.833835830905, 33302.3339533208, 33350.16624584381, 33477.83261083703, 33564.6643533564, 3405.5743032120986, 3421.538092357525, 3443.913902152466, 3480.738944579167, 3505.4566542186003, 23587.7641223589, 23942.880285598636, 24007.0, 24040.9181586829, 24108.638370424458, 3305.586801649794, 3368.208471009311, 3432.982835085809, 3446.2245994651253, 3555.2889422115422, 165270.0, 171899.0, 171926.0, 172339.0, 172970.0, 43964.340534892, 44392.55607443949, 44452.0, 44461.55538444639, 44523.777381112886, 46685.533144668116, 46811.0, 46828.7658561705, 46934.295985560246, 46939.5306046942, 12608.11743177987, 12881.355932203352, 12887.355632218352, 12892.0, 12898.290594017419, 10323.74190645225, 10325.277230593936, 10327.896721032694, 10330.690079297634, 10336.638217662347, 12445.688857778629, 12561.309127998047, 12608.432620532098, 12658.936705316415, 12755.0, 5051.520105589963, 5079.771410286472, 5168.81909133186, 5204.866004937957, 5220.973895130576, 801.1307731111809, 828.5318794880873, 842.3345557010016, 843.8734189871568, 865.4763867859854, 21375.67936480954, 21944.341669749934, 22112.459357588545, 22332.77667223307, 22585.774142258368, 873.8514452543083, 874.8337815815102, 890.7461373508519, 896.7982204004047, 899.2356496977517, 11493.942530287295, 11632.592859250055, 11764.70588235301, 11857.288562686266, 12002.399880005965, 203014.0, 204146.0, 204153.0, 204664.0, 207535.0, 40822.1835563293, 40887.1822563553, 40991.18017639631, 40991.180176396905, 41015.0, 1174.4127936031985, 1205.6804946689135, 1212.3271584270815, 1214.0712355048395, 1214.623466725318, 20115.497112572302, 20154.798452015293, 20919.37241882746, 21110.0, 21560.892195538923, 29922.0, 30012.849935750182, 30027.099187024425, 30086.398272034, 30118.54822177625, 201922.0, 204032.0, 204123.0, 204232.0, 204581.0, 27535.86232068827, 27559.17322480329, 32228.0, 33115.50326745053, 33571.83214083914, 35614.82192589124, 35724.64275357213, 37892.24215515729, 39229.215415692095, 44176.116477669624, 31736.682633173372, 31850.0, 33137.66862331346, 33500.83249583736, 33983.320333593685, 31958.0, 32231.0, 32396.0, 32468.67531324751, 33293.667063330024, 33000.55490843984, 33354.332913342085, 33466.49800253047, 33633.49549756707, 33675.326493470486, 24989.37526561778, 26862.194134175224, 27907.860460697568, 28818.279543010754, 29568.55647165251, 22993.284298048926, 23444.0, 23463.178788742312, 23712.170074047324, 23738.406539836644], "value": 15594.836788093575, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.77755791409317, 369.05153754850045, 399.8060940443885, 409.87293938878946, 422.9090745489719, 12014.2791432514, 12584.119111662176, 13637.65905852353, 19175.32886348978, 19391.70912436311, 17302.913485432586, 17629.294828206857, 17922.910385448053, 17987.280508779633, 18024.09879506023, 5625.718714064301, 5864.266966629171, 5908.320543137551, 5956.434138756833, 5958.404159584029, 5655.4061823508555, 5758.992176369119, 5787.0, 5792.942070579304, 5796.681182534959, 5762.366139724627, 5793.073108302672, 5794.884102317951, 5798.7100644967795, 5803.477687008169, 5602.411746766592, 5718.370979192307, 5724.627899186539, 5768.625039372428, 5769.336526299488, 5371.946280537184, 5584.86037849053, 5609.915851262234, 5617.325920889479, 5620.0, 17428.0, 17522.299108035662, 17690.0, 17863.73204401935, 17874.731879021823, 2385.427497400629, 2432.3797431654993, 2444.1567659157563, 2452.3991622052713, 2505.711843138026, 11928.522859085626, 12251.203671761306, 13812.171269723749, 13883.583492495241, 14325.115416917288, 1961.622588983902, 1967.45894878908, 1976.347805224287, 1990.1840245499275, 2006.8294194993443, 89222.10777892268, 90058.5497072517, 90207.0, 90528.5473572628, 91817.0, 15154.696906062038, 15729.842701572838, 15730.528084157493, 15800.288986995613, 16193.838061619468, 27460.45079098407, 27477.17568472949, 27529.0, 27542.934279929086, 27750.861245693643, 7870.921290787133, 7949.960250198712, 8206.056303525052, 8251.669933202606, 8349.582520874053, 6383.9361606383345, 6451.580647257913, 6461.903071453932, 6629.834254143685, 6638.302978187221, 8458.139209373929, 8524.74425767228, 8561.824347843427, 8667.263282621048, 8675.6529738811, 3372.5278461015478, 3509.105178179599, 3512.332656795201, 3668.926621467556, 3705.40713485841, 792.7027364738224, 802.6508468816083, 824.5959479854828, 827.6854795177794, 844.1136806353427, 18439.0, 19469.51326216856, 19590.412287631392, 19725.0, 19865.205391784166, 792.9722459713882, 795.0975642645524, 801.4910531812225, 808.890799742039, 813.341193633159, 9974.152197063186, 10637.202209834293, 10639.202059845542, 10724.624638137628, 10830.350178989285, 471066.0, 472111.0, 474817.0, 480278.0, 481902.0, 84373.57813210895, 85720.57139714262, 87263.56368218118, 87556.0, 88839.0, 1057.9471026448646, 1065.4406436620682, 1100.460774220626, 1101.130107215307, 1102.73534351755, 15740.370385184464, 16200.270987805812, 16394.754078689068, 16494.505164845075, 16653.5836604081, 38089.23821523499, 38843.61156388513, 39192.804035979636, 41986.58013419949, 45477.99742028308, 54288.0, 55116.17325740197, 55166.17250741323, 55758.44241557532, 56812.0, 10322.638707645196, 10363.63727269542, 10804.189685773756, 10851.891481085087, 11119.944400278271, 12558.309292988608, 12572.182808117443, 12664.556740514037, 12781.105322627327, 13270.933645331712, 11103.833442498531, 11226.943865280948, 11436.370999595103, 11473.942630286796, 11716.589919352782, 10160.0, 10341.4312212829, 10364.948175259075, 10367.481625918523, 10438.53026613789, 11101.888981110085, 11433.771324573296, 11474.4262786862, 11515.136364772508, 11929.463174157358, 10975.725606859573, 10988.615398461016, 11018.228723989243, 11303.604373847205, 11374.317540947239, 11020.283681560673, 11122.277051991918, 11220.438978050901, 11252.493637786156, 11434.0], "value": 9616.760966572252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.6631275868272, 1455.410558723717, 1456.0462896802599, 1470.867621914028, 1472.6907349456615, 8060.274575288223, 9234.722958311253, 9335.206507446876, 9706.757331066709, 9793.755156121082, 9542.188913942324, 9585.376950498212, 9616.855747163781, 9618.47098409589, 9626.0, 1623.7889074420368, 1914.0812410043222, 1939.6508628446945, 1942.8445724342018, 1944.0474167657887, 1643.1291415549717, 1662.03601910892, 1830.8718389712726, 1896.933607323744, 1898.4874083997313, 1934.2263094762068, 1939.6411663842234, 1940.3499827557785, 1942.3978566644314, 1943.1935746665117, 1863.4409677096817, 1884.1709647755013, 1886.3020682347483, 1891.905404729765, 1892.4795681187645, 1766.97349539757, 1790.1228398084845, 1791.713325867868, 1793.9774328632684, 1794.667986422503, 9323.627054917795, 9404.717858464257, 9431.811363772686, 9444.244460443148, 9447.90552094477, 4509.3461448090175, 4652.441706995149, 4655.441347038343, 4658.953410465886, 4669.0195059037305, 2538.3019669590826, 2724.087430710714, 2726.5364887968894, 2769.155407600681, 2785.9303517412022, 964.5804075227298, 981.6809536900536, 991.9950400248025, 1001.0440029771551, 1051.8369652703843, 13188.83467967681, 13193.076484646079, 13207.0, 13212.471501140039, 13213.0, 3738.36447803874, 3769.509963704701, 3869.897079332433, 3876.7092468065007, 3881.5924327945722, 11335.659930202108, 11421.600243991421, 11426.714332141762, 11467.77064458706, 11493.195476316745, 4623.052274283764, 4628.352030715702, 4633.4208223972, 4637.536246375403, 4638.0, 4102.138550904344, 4259.467566554181, 4269.487661480643, 4308.870733877989, 4357.346398040256, 3155.25851424915, 3269.9673003269663, 3270.6565810590023, 3282.1466418730824, 3305.7933854143066, 899.6356475627381, 911.9133682300171, 921.944683319003, 937.9494965638529, 938.737153596994, 770.3067239484396, 785.2500861677084, 794.0630056533231, 799.0531220503722, 804.2560631415917, 5703.572232082611, 5916.053431450947, 5947.286325640951, 6066.117684681807, 6083.939160608337, 954.7445109680748, 955.7037318431309, 962.1399422120238, 968.8692026576322, 986.0386123529645, 3744.569374521965, 3856.4408160816524, 4083.959160408417, 4110.691698122653, 4170.4995400552125, 11783.469743861375, 12231.633051008484, 12255.877441225652, 12262.877371226352, 12285.140040197279, 12114.273143611412, 12129.090318226168, 12129.818052729217, 12150.210236334788, 12153.392330383445, 8287.12985136564, 8552.187542183607, 8618.224359807647, 8626.0, 8628.35287353451, 5902.881942361043, 5991.131285963424, 6083.6045657032155, 6100.816975490742, 6204.410580994799, 10737.141028717528, 10892.836607451052, 11009.779804404026, 11026.44867756625, 11026.614068507884, 10775.892241077803, 10810.729731756453, 11011.944940275247, 11071.225014248925, 11108.888911110786, 7402.777916662509, 7670.7315243966195, 7730.072391312853, 8064.677412903418, 8208.220219079178, 9170.908290917005, 9188.21900138469, 9263.351565390627, 9271.258299336172, 9278.350515463853, 8060.516369017878, 8130.349572034342, 8130.552819594979, 8244.670213191404, 8319.584020798815, 7703.614819259126, 7761.72833950809, 7863.567503787347, 7866.646000929857, 8040.87938680932, 6548.47612191014, 6783.966080169567, 6949.061876646588, 7117.964410177916, 7127.75052873147, 5004.924926126038, 5066.645334826527, 5089.236614507706, 5126.53861152498, 5168.8449346519665, 5159.587233021424, 5192.221166825007, 5384.488473595002, 5401.162819762943, 5441.700706461183], "value": 4411.721801782175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.99475007874884, 365.97987110708914, 368.9612590677977, 370.0212936782211, 373.79254513744894, 4729.999999999995, 4759.571638552529, 4770.7853146608395, 4786.353842231298, 4830.830920917769, 4458.152950939319, 4617.4762328431625, 4666.943152235292, 4680.549029800764, 4704.670673052888, 3959.4654721612646, 3968.72218944674, 3977.9204415911663, 3981.5620281768984, 3999.1601763629747, 3985.561588225293, 3988.461557689718, 3995.9200815983663, 4010.8997275068064, 4026.5369482509595, 3781.905452363699, 3921.686265098785, 3984.5019372578427, 3994.6205110514456, 4004.799760011988, 3944.5266568011734, 3950.1112249743865, 3963.929738970462, 3973.403989401584, 3984.501937257857, 3657.3599620066384, 3677.2277821657485, 3679.5032670589394, 3681.7606855554304, 3695.593484716679, 4553.704009239389, 4575.885602859922, 4580.862574122782, 4593.83921562747, 4596.058522545573, 4328.523862375137, 4464.665150113722, 4499.1451624191295, 4525.886852828673, 4554.111948170108, 4879.268109783526, 4908.533689299511, 4911.680740751875, 4929.334539837112, 4947.314250883115, 4023.416604592347, 4034.5561988181275, 4041.6864519031433, 4069.2065047315787, 4072.552019277877, 5014.699118052892, 5165.302684137669, 5182.974085129588, 5192.402873669576, 5216.7913283468615, 4145.461090058334, 4157.958420415757, 4162.9791851041155, 4165.208610364021, 4183.707140500136, 4227.429297044921, 4238.279492486285, 4242.893927651833, 4254.085371645049, 4271.743695378287, 4344.739315641072, 4491.418752872052, 4523.2988886722615, 4542.931856022163, 4576.450825900846, 4914.533119353656, 4914.754262286871, 4918.2376731606655, 4948.455669876311, 4979.875503112451, 1455.4760286296926, 1456.1044957351153, 1463.7365274250737, 1465.728840164573, 1470.713210923881, 1034.8344264917578, 1120.7086157599083, 1121.1535290855352, 1122.3770807201918, 1131.2081542919825, 4220.831166753295, 4296.291111966553, 4320.373545835836, 4365.650747940157, 4381.291296394409, 5032.7483625819295, 5041.621878359138, 5055.595552355802, 5079.425378132791, 5108.208227724708, 4110.787317741214, 4319.222539942841, 4367.825286988485, 4368.344748287719, 4429.778511074498, 2663.429790252416, 2696.662917135358, 2704.553748631493, 2707.323169207698, 2712.91861244163, 4769.928451073237, 4775.868873424462, 4803.375561177025, 4828.806847726122, 4832.830850920272, 4957.0, 5178.81874134411, 5244.6328756987405, 5245.370555533361, 5259.500347467061, 4728.281238287929, 4746.240601503743, 4747.382840230817, 4759.714417134983, 4773.904521909542, 5040.36995375578, 5076.593872490266, 5088.0469850276, 5093.821716239914, 5112.36095488064, 4755.5719985201495, 4976.576990955809, 5009.373828271466, 5014.52362025607, 5024.0, 4762.833300834454, 4783.0, 4793.832215872428, 4797.208460603962, 4801.615870730403, 4151.0, 4152.813123409514, 4157.563455837094, 4159.0, 4179.0, 4814.253790662453, 5040.269160971712, 5055.317532133115, 5067.87330316745, 5145.382554093533, 4876.63512176597, 4906.63200259989, 4922.901541969069, 4940.209566469348, 4947.851564453073, 4914.8771280718265, 4927.433345165208, 4937.0, 4937.827355963364, 4975.6517043808035, 4612.723236605814, 4856.68431551948, 4858.137780464469, 4871.805127794849, 4904.215325547895, 4913.9017219656125, 4915.26271059344, 4941.935999680221, 4961.767204757802, 4963.156263435297, 4848.200046992207, 4854.344663470386, 4891.437484689164, 4900.5099490052135, 4916.975415122902], "value": 3911.609799537605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.4293821437135, 673.5083389125938, 718.5616773768, 750.3546949623322, 762.211111499598, 12359.814602780965, 13877.444902203924, 13882.236476993787, 14031.158130512176, 14045.438182472702, 11506.654800355982, 11508.136889733261, 11545.307281563091, 11578.768424631502, 11581.420928953561, 836.234845116719, 844.6916875340487, 864.170396419435, 869.652139144341, 877.4209022045451, 869.070094998352, 869.1135042256926, 869.2654706772767, 869.8999615044288, 873.4671850171422, 900.3112618846587, 901.6889173235223, 902.0528445132585, 902.4720538484994, 902.702108304258, 899.1727610598265, 900.2033200617435, 901.396064636695, 901.5582364641344, 902.7878448564582, 658.3383699382139, 661.3584822721951, 661.6096503063216, 662.3442791636294, 663.4625952978055, 13154.736905261841, 13305.933470332684, 13380.464781408731, 13518.662033449144, 14276.50096739848, 13725.45098196071, 14394.352254148589, 14399.208043557705, 14428.567142985727, 14433.494827681086, 10623.889104034479, 10686.412247326394, 10779.407132607703, 10894.836577451344, 10943.124550035978, 3196.378692129395, 3218.806871587712, 3246.8376581170846, 3277.0332751838264, 3305.6033276007033, 64000.0, 66495.3350466494, 67091.66454167747, 67738.0, 68138.65930670364, 10968.341899486057, 11000.944995274973, 11053.447327633587, 11063.778724425467, 11202.943985280184, 20054.59890802205, 22072.33782986513, 22139.33581992543, 22166.556668866855, 22337.553248935255, 6654.234763002317, 6675.198976122896, 6697.430718388991, 6699.229588597276, 6957.2694867039245, 3256.3487302539115, 3259.3807176636365, 3311.569495965509, 3316.1543806329714, 3324.451465508164, 2625.7111717711036, 2680.249530131566, 2693.192042387276, 2694.7844172466157, 2696.379832638504, 472.2066927561729, 479.43666192224, 481.67005601163316, 483.15447966059395, 492.75116066386244, 521.015281118686, 549.7773401772289, 553.3636318234063, 553.4238121544219, 558.3383690326975, 8219.465734727342, 8692.869606955901, 8839.425437346552, 8923.509206993678, 9022.368434209542, 571.2744814086087, 587.8941790477755, 597.2355385106983, 600.3306313460461, 612.5650787940613, 3991.4888103768953, 4243.236217480883, 4245.405643209953, 4273.444452221192, 4342.739435633872, 59025.0, 59979.0, 61025.084623730676, 61911.380886191466, 63564.0, 42751.572484275384, 44780.55219447829, 47665.28502072472, 53021.0, 54068.72965635147, 49738.25392619114, 50402.49597503978, 50560.49439505632, 51199.0, 51931.74034129805, 7898.723544675909, 8349.457285276438, 9715.299653096183, 9975.700728978143, 10059.949700251453, 27049.59425608578, 31286.530702039032, 32011.437655280144, 32184.517232241065, 32205.0, 40951.38572921349, 42345.153096937276, 42743.358849616656, 43161.56838431575, 44379.77810110929, 11604.0, 11847.407629618658, 12039.277643341427, 12392.194507356993, 12439.0, 12128.151029427856, 12669.292666713027, 12723.491060357483, 12786.680332991378, 13109.60671179866, 11247.887521124683, 11281.830772538255, 11430.14273929442, 12282.631521054025, 12555.183913045623, 11645.88354116482, 12022.671838138089, 12197.917235151835, 12284.692882678004, 12709.745805084032, 11948.581799636971, 12258.14193006481, 12396.442160102997, 12436.37818109109, 12869.163504372185, 10088.243381746544, 10453.372797632166, 10602.25784195099, 10647.89352106469, 10729.034386905216, 9244.352895297534, 10274.33216840903, 10318.690439286833, 10394.48027598602, 10425.218108642033], "value": 6370.503732820419, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 118.0, 120.0, 118.0, 120.0, 119.0, 117.0, 119.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 126.0, 124.0, 173.0, 123.0, 128.0, 125.0, 124.0, 147.0, 122.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 103.0, 77.0, 76.0, 78.0, 77.0, 92.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 120.0, 86.0, 84.0, 84.0, 104.0, 85.0, 84.0, 111.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 150.0, 148.0, 149.0, 149.0, 149.0, 148.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 70.0, 66.0, 65.0, 66.0, 67.0, 64.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 58.0, 55.0, 55.0, 55.0, 56.0, 56.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 92.0, 86.0, 91.0, 84.0, 84.0, 88.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 134.0, 133.0, 136.0, 133.0, 144.0, 147.0, 181.0, 139.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 180.0, 182.0, 183.0, 185.0, 185.0, 179.0, 187.0, 179.0, 184.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 70.0, 68.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}]}]} 08:38:08 INFO - Return code: 0 08:38:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:38:08 ERROR - # TBPL SUCCESS # 08:38:08 INFO - Running post-action listener: _resource_record_post_action 08:38:08 INFO - [mozharness: 2017-03-12 15:38:08.834057Z] Finished run-tests step (success) 08:38:08 INFO - Running post-run listener: _resource_record_post_run 08:38:08 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 7454720; Write bytes: 363823104; Read time: 1668; Write time: 360928 08:38:08 INFO - TinderboxPrint: CPU usage
13.3% 08:38:08 INFO - TinderboxPrint: I/O read bytes / time
7,454,720 / 1,668 08:38:08 INFO - TinderboxPrint: I/O write bytes / time
363,823,104 / 360,928 08:38:08 INFO - TinderboxPrint: CPU idle
8,348.1 (86.7%) 08:38:08 INFO - TinderboxPrint: CPU user
1,224.8 (12.7%) 08:38:08 INFO - TinderboxPrint: Swap in / out
0 / 0 08:38:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 110604288; Read time: 304; Write time: 156824 08:38:08 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 5419008; Write bytes: 252952576; Read time: 1240; Write time: 204080 08:38:09 INFO - Running post-run listener: _upload_blobber_files 08:38:09 INFO - Blob upload gear active. 08:38:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:38:09 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 08:38:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:38:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:10 INFO - (blobuploader) - INFO - Done attempting. 08:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:38:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:14 INFO - (blobuploader) - INFO - Done attempting. 08:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:15 INFO - (blobuploader) - INFO - Done attempting. 08:38:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:38:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:17 INFO - (blobuploader) - INFO - Done attempting. 08:38:17 INFO - (blobuploader) - INFO - Iteration through files over. 08:38:17 INFO - Return code: 0 08:38:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:38:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:38:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef613cd5c80061f159a4c44896b94a8882522469dba2b3d1d81b4fff06b058c2d412ede8744ad583f75c2a22d05f1d0aa115691307faaa550ac51c7ae0835eff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44c5bf288d6515eac6fb4bff4b67f7cdcf13a113f932ab8c9643d00458a407265c0358a1983c00e05c7813ae63fe697e1a4e3733c07ff14d7f4310999e8f0727", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a20be1eb9cf401c2ab919e064e549b73d6923e78287c232879b88628e54e37ff483a9de8c73cf6bd96a8a42607e27707778740563ce684f9419b28b3e6bc29c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83ee06497d2a1ccd0d6939c0fe3b1ce34bea2e0d74e3ea12b87c443ea81f680b6c594b422b3000d816b1d90b7d69c7e40225cf3fd0062c65debfb3c76789c668"} 08:38:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:38:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:38:17 INFO - Contents: 08:38:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef613cd5c80061f159a4c44896b94a8882522469dba2b3d1d81b4fff06b058c2d412ede8744ad583f75c2a22d05f1d0aa115691307faaa550ac51c7ae0835eff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44c5bf288d6515eac6fb4bff4b67f7cdcf13a113f932ab8c9643d00458a407265c0358a1983c00e05c7813ae63fe697e1a4e3733c07ff14d7f4310999e8f0727", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a20be1eb9cf401c2ab919e064e549b73d6923e78287c232879b88628e54e37ff483a9de8c73cf6bd96a8a42607e27707778740563ce684f9419b28b3e6bc29c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83ee06497d2a1ccd0d6939c0fe3b1ce34bea2e0d74e3ea12b87c443ea81f680b6c594b422b3000d816b1d90b7d69c7e40225cf3fd0062c65debfb3c76789c668"} 08:38:17 INFO - Running post-run listener: copy_logs_to_upload_dir 08:38:17 INFO - Copying logs to upload dir... 08:38:17 INFO - mkdir: /builds/slave/test/build/upload/logs 08:38:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.590963 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-03-12 08:38:17.639830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-12 08:38:17.643394) ========= 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=eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef613cd5c80061f159a4c44896b94a8882522469dba2b3d1d81b4fff06b058c2d412ede8744ad583f75c2a22d05f1d0aa115691307faaa550ac51c7ae0835eff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44c5bf288d6515eac6fb4bff4b67f7cdcf13a113f932ab8c9643d00458a407265c0358a1983c00e05c7813ae63fe697e1a4e3733c07ff14d7f4310999e8f0727", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a20be1eb9cf401c2ab919e064e549b73d6923e78287c232879b88628e54e37ff483a9de8c73cf6bd96a8a42607e27707778740563ce684f9419b28b3e6bc29c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83ee06497d2a1ccd0d6939c0fe3b1ce34bea2e0d74e3ea12b87c443ea81f680b6c594b422b3000d816b1d90b7d69c7e40225cf3fd0062c65debfb3c76789c668"} build_url:https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/J3WmIIjuRLKrO_muyoqQ-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef613cd5c80061f159a4c44896b94a8882522469dba2b3d1d81b4fff06b058c2d412ede8744ad583f75c2a22d05f1d0aa115691307faaa550ac51c7ae0835eff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44c5bf288d6515eac6fb4bff4b67f7cdcf13a113f932ab8c9643d00458a407265c0358a1983c00e05c7813ae63fe697e1a4e3733c07ff14d7f4310999e8f0727", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a20be1eb9cf401c2ab919e064e549b73d6923e78287c232879b88628e54e37ff483a9de8c73cf6bd96a8a42607e27707778740563ce684f9419b28b3e6bc29c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83ee06497d2a1ccd0d6939c0fe3b1ce34bea2e0d74e3ea12b87c443ea81f680b6c594b422b3000d816b1d90b7d69c7e40225cf3fd0062c65debfb3c76789c668"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-12 08:38:17.669403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:38:17.669981) ========= 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=eca2ab57546de7b41f256b19000001ef-1489329306.660623-2023823459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:38:17.753130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-12 08:38:17.753468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-12 08:38:17.753770) ========= ========= Total master_lag: 0.19 =========