builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1494232325.07 results: success (0) revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:05.066769) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:05.067598) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:05.067939) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:05.091704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:05.092150) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 01:32: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-05-08 01:32:06 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116421 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:05.226637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:05.227011) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015085 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:05.287645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 01:32:05.288008) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --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=97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 01:32:06,593 truncating revision to first 12 chars 2017-05-08 01:32:06,593 Setting DEBUG logging. 2017-05-08 01:32:06,593 attempt 1/10 2017-05-08 01:32:06,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 01:32:07,802 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.555757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 01:32:06.861520) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:06.861983) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:06.862549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:06.862940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 01:32:06.872907) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-05-08 01:32:06.873271) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:32:08 INFO - MultiFileLogger online at 20170508 01:32:08 in /builds/slave/test 01:32:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 01:32:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:08 INFO - {'append_to_log': False, 01:32:08 INFO - 'base_work_dir': '/builds/slave/test', 01:32:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:32:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:08 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:32:08 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:08 INFO - 'config_files': ('talos/linux_config.py',), 01:32:08 INFO - 'default_actions': ('clobber', 01:32:08 INFO - 'read-buildbot-config', 01:32:08 INFO - 'download-and-extract', 01:32:08 INFO - 'populate-webroot', 01:32:08 INFO - 'create-virtualenv', 01:32:08 INFO - 'install', 01:32:08 INFO - 'run-tests'), 01:32:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:08 INFO - 'download_minidump_stackwalk': True, 01:32:08 INFO - 'download_symbols': 'ondemand', 01:32:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:08 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:08 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:08 INFO - 'gecko_profile': False, 01:32:08 INFO - 'gecko_profile_interval': 0, 01:32:08 INFO - 'installer_path': 'installer.exe', 01:32:08 INFO - 'log_level': 'info', 01:32:08 INFO - 'log_name': 'talos', 01:32:08 INFO - 'log_to_console': True, 01:32:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:32:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:32:08 INFO - 'opt_config_files': (), 01:32:08 INFO - 'pip_index': False, 01:32:08 INFO - 'suite': 'dromaeojs', 01:32:08 INFO - 'system_bits': '32', 01:32:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:08 INFO - 'title': 'talos-linux64-ix-068', 01:32:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:08 INFO - 'use_talos_json': True, 01:32:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:08 INFO - 'work_dir': 'build'} 01:32:08 INFO - [mozharness: 2017-05-08 08:32:08.277832Z] Running clobber step. 01:32:08 INFO - Running pre-action listener: _resource_record_pre_action 01:32:08 INFO - Running main action method: clobber 01:32:08 INFO - rmtree: /builds/slave/test/build 01:32:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:09 INFO - Running post-action listener: _resource_record_post_action 01:32:09 INFO - [mozharness: 2017-05-08 08:32:09.725908Z] Finished clobber step (success) 01:32:09 INFO - [mozharness: 2017-05-08 08:32:09.726006Z] Running read-buildbot-config step. 01:32:09 INFO - Running pre-action listener: _resource_record_pre_action 01:32:09 INFO - Running main action method: read_buildbot_config 01:32:09 INFO - Using buildbot properties: 01:32:09 INFO - { 01:32:09 INFO - "project": "", 01:32:09 INFO - "product": "firefox", 01:32:09 INFO - "who": "nobody@mozilla.org", 01:32:09 INFO - "installer_path": "public/build/target.tar.bz2", 01:32:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:32:09 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:32:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:32:09 INFO - "stage_platform": "linux64", 01:32:09 INFO - "basedir": "/builds/slave/test", 01:32:09 INFO - "buildnumber": 3, 01:32:09 INFO - "platform": "ubuntu64_hw", 01:32:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:32:09 INFO - "slavebuilddir": "test", 01:32:09 INFO - "taskId": "XEQfzGJGSz2p4CweggKfsg", 01:32:09 INFO - "branch": "mozilla-aurora", 01:32:09 INFO - "script_repo_revision": "production", 01:32:09 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 01:32:09 INFO - "slavename": "talos-linux64-ix-068", 01:32:09 INFO - "repo_path": "releases/mozilla-aurora" 01:32:09 INFO - } 01:32:09 INFO - Finding installer, test and symbols from parent task. 01:32:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XEQfzGJGSz2p4CweggKfsg'}, attempt #1 01:32:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XEQfzGJGSz2p4CweggKfsg'}, attempt #1 01:32:10 INFO - Task dependencies: LX26AeTfTpiDB4KsEKvVAA 01:32:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA'}, attempt #1 01:32:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.tar.bz2 01:32:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/test_packages.json 01:32:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.crashreporter-symbols.zip 01:32:11 INFO - Running post-action listener: _resource_record_post_action 01:32:11 INFO - [mozharness: 2017-05-08 08:32:11.101783Z] Finished read-buildbot-config step (success) 01:32:11 INFO - [mozharness: 2017-05-08 08:32:11.102001Z] Running download-and-extract step. 01:32:11 INFO - Running pre-action listener: _resource_record_pre_action 01:32:11 INFO - Running main action method: download_and_extract 01:32:11 INFO - mkdir: /builds/slave/test/build/tests 01:32: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')]} 01:32:11 INFO - trying https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.test_packages.json 01:32:11 INFO - Downloading https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:32:11 INFO - Downloaded 896 bytes. 01:32:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:32:11 INFO - Using the following test package requirements: 01:32:11 INFO - {u'common': [u'target.common.tests.zip'], 01:32:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:32:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:32:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:32:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:32:11 INFO - u'mozbase': [u'target.common.tests.zip'], 01:32:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:32:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:32:11 INFO - u'web-platform': [u'target.common.tests.zip', 01:32:11 INFO - u'target.web-platform.tests.zip'], 01:32:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:32:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:32:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.common.tests.zip 01:32:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:32:11 INFO - Fetch https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.common.tests.zip into memory 01:32:13 INFO - Expected file size: 59542588 01:32:13 INFO - Obtained file size: 59542588 01:32:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:32:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.common.tests.zip 01:32:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:32:22 INFO - Fetch https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.common.tests.zip into memory 01:32:24 INFO - Expected file size: 59542588 01:32:24 INFO - Obtained file size: 59542588 01:32:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.talos.tests.zip 01:32:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:32:34 INFO - Fetch https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.talos.tests.zip into memory 01:32:35 INFO - Expected file size: 14404424 01:32:35 INFO - Obtained file size: 14404424 01:32: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')]} 01:32:36 INFO - trying https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.tar.bz2 01:32:36 INFO - Downloading https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:32:38 INFO - Downloaded 66686881 bytes. 01:32:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.tar.bz2 01:32:38 INFO - mkdir: /builds/slave/test/properties 01:32:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:32:38 INFO - Writing to file /builds/slave/test/properties/build_url 01:32:38 INFO - Contents: 01:32:38 INFO - build_url:https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.tar.bz2 01:32:38 INFO - Running post-action listener: _resource_record_post_action 01:32:38 INFO - Running post-action listener: set_extra_try_arguments 01:32:38 INFO - [mozharness: 2017-05-08 08:32:38.400968Z] Finished download-and-extract step (success) 01:32:38 INFO - [mozharness: 2017-05-08 08:32:38.401108Z] Running populate-webroot step. 01:32:38 INFO - Running pre-action listener: _resource_record_pre_action 01:32:38 INFO - Running main action method: populate_webroot 01:32:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:32:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:32:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:32:38 INFO - '--tppagecycles', 01:32:38 INFO - '7'], 01:32:38 INFO - 'tests': ['tsvgm']}}, 01:32:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:32:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:32:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:32:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:32:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:32:38 INFO - 'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:32:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:32:38 INFO - 'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['damp', 'tps']}, 01:32:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:32:38 INFO - 'tests': ['damp', 'tps']}, 01:32:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['dromaeo_dom']}, 01:32:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:32:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['basic_compositor_video']}, 01:32:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:32:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['a11yr', 01:32:38 INFO - 'ts_paint', 01:32:38 INFO - 'tpaint', 01:32:38 INFO - 'sessionrestore', 01:32:38 INFO - 'sessionrestore_no_auto_restore', 01:32:38 INFO - 'tabpaint']}, 01:32:38 INFO - 'other-e10s': {'tests': ['a11yr', 01:32:38 INFO - 'ts_paint', 01:32:38 INFO - 'tpaint', 01:32:38 INFO - 'sessionrestore', 01:32:38 INFO - 'sessionrestore_no_auto_restore', 01:32:38 INFO - 'tabpaint']}, 01:32:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:32:38 INFO - 'ts_paint', 01:32:38 INFO - 'tpaint', 01:32:38 INFO - 'sessionrestore', 01:32:38 INFO - 'sessionrestore_no_auto_restore', 01:32:38 INFO - 'tabpaint']}, 01:32:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:32:38 INFO - 'ts_paint', 01:32:38 INFO - 'tpaint', 01:32:38 INFO - 'sessionrestore', 01:32:38 INFO - 'sessionrestore_no_auto_restore', 01:32:38 INFO - 'tabpaint']}, 01:32:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['a11yr', 01:32:38 INFO - 'ts_paint', 01:32:38 INFO - 'tpaint', 01:32:38 INFO - 'sessionrestore', 01:32:38 INFO - 'sessionrestore_no_auto_restore', 01:32:38 INFO - 'tabpaint']}, 01:32:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['a11yr', 01:32:38 INFO - 'ts_paint', 01:32:38 INFO - 'tpaint', 01:32:38 INFO - 'sessionrestore', 01:32:38 INFO - 'sessionrestore_no_auto_restore', 01:32:38 INFO - 'tabpaint']}, 01:32:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['tsvgx', 01:32:38 INFO - 'tsvgr_opacity', 01:32:38 INFO - 'tart', 01:32:38 INFO - 'tscrollx', 01:32:38 INFO - 'cart', 01:32:38 INFO - 'tsvg_static']}, 01:32:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:32:38 INFO - 'tsvgr_opacity', 01:32:38 INFO - 'tart', 01:32:38 INFO - 'tscrollx', 01:32:38 INFO - 'cart', 01:32:38 INFO - 'tsvg_static']}, 01:32:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:32:38 INFO - 'talos_options': ['--disable-e10s'], 01:32:38 INFO - 'tests': ['tp5o']}, 01:32:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:32:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:32:38 INFO - 'talos_options': ['--disable-e10s', 01:32:38 INFO - '--xperf_path', 01:32:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:38 INFO - 'tests': ['tp5n']}, 01:32:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:32:38 INFO - 'talos_options': ['--xperf_path', 01:32:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:38 INFO - 'tests': ['tp5n']}}, 01:32:38 INFO - 'talos.zip': {'path': '', 01:32:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:32:38 INFO - Running post-action listener: _resource_record_post_action 01:32:38 INFO - [mozharness: 2017-05-08 08:32:38.418426Z] Finished populate-webroot step (success) 01:32:38 INFO - [mozharness: 2017-05-08 08:32:38.418535Z] Running create-virtualenv step. 01:32:38 INFO - Running pre-action listener: _resource_record_pre_action 01:32:38 INFO - Running main action method: create_virtualenv 01:32:38 INFO - Creating virtualenv /builds/slave/test/build/venv 01:32: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 01:32:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:32:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:32:38 INFO - Using real prefix '/usr' 01:32:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:32:39 INFO - Installing distribute.............................................................................................................................................................................................done. 01:32:41 INFO - Installing pip.................done. 01:32:41 INFO - Return code: 0 01:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:32:41 INFO - Reading from file tmpfile_stdout 01:32:41 INFO - Output received: 01:32: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) 01:32:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32: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 01:32: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 01:32:41 INFO - Using env: {'DISPLAY': ':0', 01:32:41 INFO - 'HOME': '/home/cltbld', 01:32:41 INFO - 'LANG': 'en_US.UTF-8', 01:32:41 INFO - 'LANGUAGE': 'en_US:en', 01:32:41 INFO - 'LOGNAME': 'cltbld', 01:32:41 INFO - 'MAIL': '/var/mail/cltbld', 01:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:41 INFO - 'MOZ_NO_REMOTE': '1', 01:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:41 INFO - 'NO_EM_RESTART': '1', 01:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:41 INFO - 'PWD': '/builds/slave/test', 01:32:41 INFO - 'SHELL': '/bin/bash', 01:32:41 INFO - 'SHLVL': '1', 01:32:41 INFO - 'TERM': 'linux', 01:32:41 INFO - 'TMOUT': '86400', 01:32:41 INFO - 'USER': 'cltbld', 01:32:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:41 INFO - '_': '/tools/buildbot/bin/python'} 01:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32: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 01:32:41 INFO - Cleaning up... 01:32:41 INFO - Return code: 0 01:32:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32: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 01:32: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 01:32:41 INFO - Using env: {'DISPLAY': ':0', 01:32:41 INFO - 'HOME': '/home/cltbld', 01:32:41 INFO - 'LANG': 'en_US.UTF-8', 01:32:41 INFO - 'LANGUAGE': 'en_US:en', 01:32:41 INFO - 'LOGNAME': 'cltbld', 01:32:41 INFO - 'MAIL': '/var/mail/cltbld', 01:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:41 INFO - 'MOZ_NO_REMOTE': '1', 01:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:41 INFO - 'NO_EM_RESTART': '1', 01:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:41 INFO - 'PWD': '/builds/slave/test', 01:32:41 INFO - 'SHELL': '/bin/bash', 01:32:41 INFO - 'SHLVL': '1', 01:32:41 INFO - 'TERM': 'linux', 01:32:41 INFO - 'TMOUT': '86400', 01:32:41 INFO - 'USER': 'cltbld', 01:32:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:41 INFO - '_': '/tools/buildbot/bin/python'} 01:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:41 INFO - Downloading/unpacking psutil>=3.1.1 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:42 INFO - Installing collected packages: psutil 01:32:42 INFO - Running setup.py install for psutil 01:32:42 INFO - building 'psutil._psutil_linux' extension 01:32:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:32:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:32:43 INFO - building 'psutil._psutil_posix' extension 01:32:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:32:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:32:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:43 INFO - Successfully installed psutil 01:32:43 INFO - Cleaning up... 01:32:43 INFO - Return code: 0 01:32:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:43 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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:32:43 INFO - Using env: {'DISPLAY': ':0', 01:32:43 INFO - 'HOME': '/home/cltbld', 01:32:43 INFO - 'LANG': 'en_US.UTF-8', 01:32:43 INFO - 'LANGUAGE': 'en_US:en', 01:32:43 INFO - 'LOGNAME': 'cltbld', 01:32:43 INFO - 'MAIL': '/var/mail/cltbld', 01:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:43 INFO - 'MOZ_NO_REMOTE': '1', 01:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:43 INFO - 'NO_EM_RESTART': '1', 01:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:43 INFO - 'PWD': '/builds/slave/test', 01:32:43 INFO - 'SHELL': '/bin/bash', 01:32:43 INFO - 'SHLVL': '1', 01:32:43 INFO - 'TERM': 'linux', 01:32:43 INFO - 'TMOUT': '86400', 01:32:43 INFO - 'USER': 'cltbld', 01:32:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:43 INFO - '_': '/tools/buildbot/bin/python'} 01:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:32:44 INFO - Installing collected packages: mozsystemmonitor 01:32:44 INFO - Running setup.py install for mozsystemmonitor 01:32:44 INFO - Successfully installed mozsystemmonitor 01:32:44 INFO - Cleaning up... 01:32:44 INFO - Return code: 0 01:32:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:32:44 INFO - Using env: {'DISPLAY': ':0', 01:32:44 INFO - 'HOME': '/home/cltbld', 01:32:44 INFO - 'LANG': 'en_US.UTF-8', 01:32:44 INFO - 'LANGUAGE': 'en_US:en', 01:32:44 INFO - 'LOGNAME': 'cltbld', 01:32:44 INFO - 'MAIL': '/var/mail/cltbld', 01:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:44 INFO - 'MOZ_NO_REMOTE': '1', 01:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:44 INFO - 'NO_EM_RESTART': '1', 01:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:44 INFO - 'PWD': '/builds/slave/test', 01:32:44 INFO - 'SHELL': '/bin/bash', 01:32:44 INFO - 'SHLVL': '1', 01:32:44 INFO - 'TERM': 'linux', 01:32:44 INFO - 'TMOUT': '86400', 01:32:44 INFO - 'USER': 'cltbld', 01:32:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:44 INFO - '_': '/tools/buildbot/bin/python'} 01:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:45 INFO - Downloading/unpacking jsonschema==2.5.1 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:32:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:46 INFO - Downloading functools32-3.2.3-2.tar.gz 01:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:32:46 INFO - warning: no files found matching '*.txt' 01:32:46 INFO - no previously-included directories found matching 'build' 01:32:46 INFO - no previously-included directories found matching 'dist' 01:32:46 INFO - no previously-included directories found matching '.git*' 01:32:46 INFO - Installing collected packages: jsonschema, functools32 01:32:46 INFO - Running setup.py install for functools32 01:32:46 INFO - warning: no files found matching '*.txt' 01:32:46 INFO - no previously-included directories found matching 'build' 01:32:46 INFO - no previously-included directories found matching 'dist' 01:32:46 INFO - no previously-included directories found matching '.git*' 01:32:46 INFO - Successfully installed jsonschema functools32 01:32:46 INFO - Cleaning up... 01:32:46 INFO - Return code: 0 01:32:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:46 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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:32:46 INFO - Using env: {'DISPLAY': ':0', 01:32:46 INFO - 'HOME': '/home/cltbld', 01:32:46 INFO - 'LANG': 'en_US.UTF-8', 01:32:46 INFO - 'LANGUAGE': 'en_US:en', 01:32:46 INFO - 'LOGNAME': 'cltbld', 01:32:46 INFO - 'MAIL': '/var/mail/cltbld', 01:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:46 INFO - 'MOZ_NO_REMOTE': '1', 01:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:46 INFO - 'NO_EM_RESTART': '1', 01:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:46 INFO - 'PWD': '/builds/slave/test', 01:32:46 INFO - 'SHELL': '/bin/bash', 01:32:46 INFO - 'SHLVL': '1', 01:32:46 INFO - 'TERM': 'linux', 01:32:46 INFO - 'TMOUT': '86400', 01:32:46 INFO - 'USER': 'cltbld', 01:32:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:46 INFO - '_': '/tools/buildbot/bin/python'} 01:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:32:46 INFO - Cleaning up... 01:32:46 INFO - Return code: 0 01:32:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:46 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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:32:46 INFO - Using env: {'DISPLAY': ':0', 01:32:46 INFO - 'HOME': '/home/cltbld', 01:32:46 INFO - 'LANG': 'en_US.UTF-8', 01:32:46 INFO - 'LANGUAGE': 'en_US:en', 01:32:46 INFO - 'LOGNAME': 'cltbld', 01:32:46 INFO - 'MAIL': '/var/mail/cltbld', 01:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:46 INFO - 'MOZ_NO_REMOTE': '1', 01:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:46 INFO - 'NO_EM_RESTART': '1', 01:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:46 INFO - 'PWD': '/builds/slave/test', 01:32:46 INFO - 'SHELL': '/bin/bash', 01:32:46 INFO - 'SHLVL': '1', 01:32:46 INFO - 'TERM': 'linux', 01:32:46 INFO - 'TMOUT': '86400', 01:32:46 INFO - 'USER': 'cltbld', 01:32:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:46 INFO - '_': '/tools/buildbot/bin/python'} 01:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:46 INFO - Downloading/unpacking blobuploader==1.2.4 01:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:47 INFO - Downloading blobuploader-1.2.4.tar.gz 01:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:32:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:32:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:49 INFO - Downloading docopt-0.6.1.tar.gz 01:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:32:49 INFO - Installing collected packages: blobuploader, requests, docopt 01:32:49 INFO - Running setup.py install for blobuploader 01:32:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:32:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:32:49 INFO - Running setup.py install for requests 01:32:50 INFO - Running setup.py install for docopt 01:32:50 INFO - Successfully installed blobuploader requests docopt 01:32:50 INFO - Cleaning up... 01:32:50 INFO - Return code: 0 01:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32: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')]} 01:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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')]} 01:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:50 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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:32:50 INFO - Using env: {'DISPLAY': ':0', 01:32:50 INFO - 'HOME': '/home/cltbld', 01:32:50 INFO - 'LANG': 'en_US.UTF-8', 01:32:50 INFO - 'LANGUAGE': 'en_US:en', 01:32:50 INFO - 'LOGNAME': 'cltbld', 01:32:50 INFO - 'MAIL': '/var/mail/cltbld', 01:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:50 INFO - 'MOZ_NO_REMOTE': '1', 01:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:50 INFO - 'NO_EM_RESTART': '1', 01:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:50 INFO - 'PWD': '/builds/slave/test', 01:32:50 INFO - 'SHELL': '/bin/bash', 01:32:50 INFO - 'SHLVL': '1', 01:32:50 INFO - 'TERM': 'linux', 01:32:50 INFO - 'TMOUT': '86400', 01:32:50 INFO - 'USER': 'cltbld', 01:32:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:50 INFO - '_': '/tools/buildbot/bin/python'} 01:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:50 INFO - Running setup.py (path:/tmp/pip-ibjQxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:50 INFO - Running setup.py (path:/tmp/pip-CDUevH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:50 INFO - Running setup.py (path:/tmp/pip-MVxTr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:50 INFO - Running setup.py (path:/tmp/pip-hbd4nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:50 INFO - Running setup.py (path:/tmp/pip-KD8c9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:50 INFO - Running setup.py (path:/tmp/pip-xkKYov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:50 INFO - Running setup.py (path:/tmp/pip-FceUBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:50 INFO - Running setup.py (path:/tmp/pip-632dXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:51 INFO - Running setup.py (path:/tmp/pip-fn90jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:51 INFO - Running setup.py (path:/tmp/pip-KjaGhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:51 INFO - Running setup.py (path:/tmp/pip-qTMACn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:51 INFO - Running setup.py (path:/tmp/pip-LqfJSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:51 INFO - Running setup.py (path:/tmp/pip-1dyARy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:51 INFO - Running setup.py (path:/tmp/pip-ZUu3aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:51 INFO - Running setup.py (path:/tmp/pip-GtDs4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:51 INFO - Running setup.py (path:/tmp/pip-O_k7Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:51 INFO - Running setup.py (path:/tmp/pip-UsNDmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:32:51 INFO - Running setup.py install for manifestparser 01:32:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:32:51 INFO - Running setup.py install for mozcrash 01:32:51 INFO - Running setup.py install for mozdebug 01:32:51 INFO - Running setup.py install for mozdevice 01:32:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Running setup.py install for mozfile 01:32:52 INFO - Running setup.py install for mozhttpd 01:32:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Running setup.py install for mozinfo 01:32:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Running setup.py install for mozInstall 01:32:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Running setup.py install for mozleak 01:32:52 INFO - Running setup.py install for mozlog 01:32:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Running setup.py install for moznetwork 01:32:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Running setup.py install for mozprocess 01:32:52 INFO - Running setup.py install for mozprofile 01:32:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Running setup.py install for mozrunner 01:32:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Running setup.py install for mozscreenshot 01:32:53 INFO - Running setup.py install for moztest 01:32:53 INFO - Running setup.py install for mozversion 01:32:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:32:53 INFO - Cleaning up... 01:32:53 INFO - Return code: 0 01:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:53 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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:32:53 INFO - Using env: {'DISPLAY': ':0', 01:32:53 INFO - 'HOME': '/home/cltbld', 01:32:53 INFO - 'LANG': 'en_US.UTF-8', 01:32:53 INFO - 'LANGUAGE': 'en_US:en', 01:32:53 INFO - 'LOGNAME': 'cltbld', 01:32:53 INFO - 'MAIL': '/var/mail/cltbld', 01:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:53 INFO - 'MOZ_NO_REMOTE': '1', 01:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:53 INFO - 'NO_EM_RESTART': '1', 01:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:53 INFO - 'PWD': '/builds/slave/test', 01:32:53 INFO - 'SHELL': '/bin/bash', 01:32:53 INFO - 'SHLVL': '1', 01:32:53 INFO - 'TERM': 'linux', 01:32:53 INFO - 'TMOUT': '86400', 01:32:53 INFO - 'USER': 'cltbld', 01:32:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:53 INFO - '_': '/tools/buildbot/bin/python'} 01:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:53 INFO - Running setup.py (path:/tmp/pip-wrRc2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:53 INFO - Running setup.py (path:/tmp/pip-1ac2NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:53 INFO - Running setup.py (path:/tmp/pip-kpaVov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:53 INFO - Running setup.py (path:/tmp/pip-OjF4lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:54 INFO - Running setup.py (path:/tmp/pip-WIc0Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:54 INFO - Running setup.py (path:/tmp/pip-E30D_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:54 INFO - Running setup.py (path:/tmp/pip-b3pJAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:54 INFO - Running setup.py (path:/tmp/pip-oVM2J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:54 INFO - Running setup.py (path:/tmp/pip-uEFR_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:54 INFO - Running setup.py (path:/tmp/pip-lJIhO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:54 INFO - Running setup.py (path:/tmp/pip-In5icd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:54 INFO - Running setup.py (path:/tmp/pip-Xd1X8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:54 INFO - Running setup.py (path:/tmp/pip-8BNKlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:54 INFO - Running setup.py (path:/tmp/pip-186oOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:54 INFO - Running setup.py (path:/tmp/pip-UsE6aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:54 INFO - Running setup.py (path:/tmp/pip-hZROFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:54 INFO - Running setup.py (path:/tmp/pip-bUX3BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:56 INFO - Downloading blessings-1.6.tar.gz 01:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:32:56 INFO - Installing collected packages: blessings 01:32:56 INFO - Running setup.py install for blessings 01:32:56 INFO - Successfully installed blessings 01:32:56 INFO - Cleaning up... 01:32:56 INFO - Return code: 0 01:32:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:56 INFO - Reading from file tmpfile_stdout 01:32:56 INFO - Current package versions: 01:32:56 INFO - argparse == 1.2.1 01:32:56 INFO - blessings == 1.6 01:32:56 INFO - blobuploader == 1.2.4 01:32:56 INFO - docopt == 0.6.1 01:32:56 INFO - functools32 == 3.2.3-2 01:32:56 INFO - jsonschema == 2.5.1 01:32:56 INFO - manifestparser == 1.1 01:32:56 INFO - mozInstall == 1.12 01:32:56 INFO - mozcrash == 1.0 01:32:56 INFO - mozdebug == 0.1 01:32:56 INFO - mozdevice == 0.49 01:32:56 INFO - mozfile == 1.2 01:32:56 INFO - mozhttpd == 0.7 01:32:56 INFO - mozinfo == 0.9 01:32:56 INFO - mozleak == 0.1 01:32:56 INFO - mozlog == 3.4 01:32:56 INFO - moznetwork == 0.27 01:32:56 INFO - mozprocess == 0.25 01:32:56 INFO - mozprofile == 0.28 01:32:56 INFO - mozrunner == 6.13 01:32:56 INFO - mozscreenshot == 0.1 01:32:56 INFO - mozsystemmonitor == 0.3 01:32:56 INFO - moztest == 0.8 01:32:56 INFO - mozversion == 1.4 01:32:56 INFO - psutil == 3.1.1 01:32:56 INFO - requests == 1.2.3 01:32:56 INFO - wsgiref == 0.1.2 01:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:56 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 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:32:56 INFO - Using env: {'DISPLAY': ':0', 01:32:56 INFO - 'HOME': '/home/cltbld', 01:32:56 INFO - 'LANG': 'en_US.UTF-8', 01:32:56 INFO - 'LANGUAGE': 'en_US:en', 01:32:56 INFO - 'LOGNAME': 'cltbld', 01:32:56 INFO - 'MAIL': '/var/mail/cltbld', 01:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:56 INFO - 'MOZ_NO_REMOTE': '1', 01:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:56 INFO - 'NO_EM_RESTART': '1', 01:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:56 INFO - 'PWD': '/builds/slave/test', 01:32:56 INFO - 'SHELL': '/bin/bash', 01:32:56 INFO - 'SHLVL': '1', 01:32:56 INFO - 'TERM': 'linux', 01:32:56 INFO - 'TMOUT': '86400', 01:32:56 INFO - 'USER': 'cltbld', 01:32:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:56 INFO - '_': '/tools/buildbot/bin/python'} 01:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:32:56 INFO - Cleaning up... 01:32:56 INFO - Return code: 0 01:32:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf77310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:32:56 INFO - Using env: {'DISPLAY': ':0', 01:32:56 INFO - 'HOME': '/home/cltbld', 01:32:56 INFO - 'LANG': 'en_US.UTF-8', 01:32:56 INFO - 'LANGUAGE': 'en_US:en', 01:32:56 INFO - 'LOGNAME': 'cltbld', 01:32:56 INFO - 'MAIL': '/var/mail/cltbld', 01:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:56 INFO - 'MOZ_NO_REMOTE': '1', 01:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:56 INFO - 'NO_EM_RESTART': '1', 01:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:56 INFO - 'PWD': '/builds/slave/test', 01:32:56 INFO - 'SHELL': '/bin/bash', 01:32:56 INFO - 'SHLVL': '1', 01:32:56 INFO - 'TERM': 'linux', 01:32:56 INFO - 'TMOUT': '86400', 01:32:56 INFO - 'USER': 'cltbld', 01:32:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:56 INFO - '_': '/tools/buildbot/bin/python'} 01:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:32:56 INFO - Cleaning up... 01:32:56 INFO - Return code: 0 01:32:56 INFO - Running post-action listener: _resource_record_post_action 01:32:56 INFO - Running post-action listener: _start_resource_monitoring 01:32:56 INFO - Starting resource monitoring. 01:32:56 INFO - [mozharness: 2017-05-08 08:32:56.984236Z] Finished create-virtualenv step (success) 01:32:56 INFO - [mozharness: 2017-05-08 08:32:56.984705Z] Running install step. 01:32:56 INFO - Running pre-action listener: _resource_record_pre_action 01:32:56 INFO - Running main action method: install 01:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:57 INFO - Reading from file tmpfile_stdout 01:32:57 INFO - Detecting whether we're running mozinstall >=1.0... 01:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:32:57 INFO - Reading from file tmpfile_stdout 01:32:57 INFO - Output received: 01:32:57 INFO - Usage: mozinstall [options] installer 01:32:57 INFO - Options: 01:32:57 INFO - -h, --help show this help message and exit 01:32:57 INFO - -d DEST, --destination=DEST 01:32:57 INFO - Directory to install application into. [default: 01:32:57 INFO - "/builds/slave/test"] 01:32:57 INFO - --app=APP Application being installed. [default: firefox] 01:32:57 INFO - mkdir: /builds/slave/test/build/application 01:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:33:13 INFO - Reading from file tmpfile_stdout 01:33:13 INFO - Output received: 01:33:13 INFO - /builds/slave/test/build/application/firefox/firefox 01:33:13 INFO - Running post-action listener: _resource_record_post_action 01:33:13 INFO - [mozharness: 2017-05-08 08:33:13.868375Z] Finished install step (success) 01:33:13 INFO - [mozharness: 2017-05-08 08:33:13.868650Z] Running run-tests step. 01:33:13 INFO - Running pre-action listener: _resource_record_pre_action 01:33:13 INFO - Running main action method: run_tests 01:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:33:13 INFO - Python 2.7.3 01:33:13 INFO - Return code: 0 01:33:13 INFO - grabbing minidump binary from tooltool 01:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:13 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 0xf74400>, '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 0xf753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:33:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:33:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:33:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:33:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:33:13 INFO - Return code: 0 01:33:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:33:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:33:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:33:13 INFO - ENV: RUST_BACKTRACE is now 1 01:33:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:33:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:33:13 INFO - Using env: {'DISPLAY': ':0', 01:33:13 INFO - 'HOME': '/home/cltbld', 01:33:13 INFO - 'LANG': 'en_US.UTF-8', 01:33:13 INFO - 'LANGUAGE': 'en_US:en', 01:33:13 INFO - 'LOGNAME': 'cltbld', 01:33:13 INFO - 'MAIL': '/var/mail/cltbld', 01:33:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:33:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:13 INFO - 'MOZ_NO_REMOTE': '1', 01:33:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:13 INFO - 'NO_EM_RESTART': '1', 01:33:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:13 INFO - 'PWD': '/builds/slave/test', 01:33:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:33:13 INFO - 'RUST_BACKTRACE': '1', 01:33:13 INFO - 'SHELL': '/bin/bash', 01:33:13 INFO - 'SHLVL': '1', 01:33:13 INFO - 'TERM': 'linux', 01:33:13 INFO - 'TMOUT': '86400', 01:33:13 INFO - 'USER': 'cltbld', 01:33:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848', 01:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:13 INFO - '_': '/tools/buildbot/bin/python'} 01:33:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:33:14 INFO - mozversion application_buildid: 20170508074704 01:33:14 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:33:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:33:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:33:14 INFO - mozversion application_name: Firefox 01:33:14 INFO - mozversion application_remotingname: firefox-dev 01:33:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:33:14 INFO - mozversion application_vendor: Mozilla 01:33:14 INFO - mozversion application_version: 54.0a2 01:33:14 INFO - mozversion platform_buildid: 20170508074704 01:33:14 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:33:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:33:14 INFO - mozversion platform_version: 54.0a2 01:33:14 INFO - using testdate: 1494232394 01:33:14 INFO - actual date: 1494232394 01:33:14 INFO - starting webserver on 'localhost:35127' 01:33:14 INFO - SUITE-START | Running 2 tests 01:33:14 INFO - TEST-START | dromaeo_css 01:33:14 INFO - operating with platform_type : linux_ 01:33:14 INFO - Initialising browser for dromaeo_css test... 01:33:14 INFO - TEST-INFO | started process 4661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu7AzM9/profile http://localhost:35127/getInfo.html) 01:33:18 INFO - PROCESS | 4661 | __metrics Screen width/height:1600/1200 01:33:18 INFO - PROCESS | 4661 | colorDepth:24 01:33:18 INFO - PROCESS | 4661 | Browser inner width/height: 1024/697 01:33:18 INFO - PROCESS | 4661 | __metrics 01:33:19 INFO - PROCESS | 4661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:33:19 INFO - PROCESS | 4661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:33:20 INFO - TEST-INFO | 4661: exit 0 01:33:20 INFO - Browser initialized. 01:33:20 INFO - Running cycle 1/1 for dromaeo_css test... 01:33:20 INFO - TEST-INFO | started process 4754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu7AzM9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:32 INFO - PROCESS | 4754 | RSS: Main: 140124160 01:33:32 INFO - PROCESS | 4754 | 01:36:33 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35127/tests/dromaeo/cssquery-ext.html) 01:36:35 INFO - PROCESS | 4754 | RSS: Main: 270721024 01:36:35 INFO - PROCESS | 4754 | 01:38:22 INFO - PROCESS | 4754 | ************************* 01:38:22 INFO - PROCESS | 4754 | A coding exception was thrown and uncaught in a Task. 01:38:22 INFO - PROCESS | 4754 | 01:38:22 ERROR - PROCESS | 4754 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:38:22 INFO - PROCESS | 4754 | Full stack: 01:38:22 INFO - PROCESS | 4754 | ************************* 01:38:22 INFO - PROCESS | 4754 | ************************* 01:38:22 INFO - PROCESS | 4754 | A coding exception was thrown and uncaught in a Task. 01:38:22 INFO - PROCESS | 4754 | 01:38:22 ERROR - PROCESS | 4754 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:38:22 INFO - PROCESS | 4754 | Full stack: 01:38:22 INFO - PROCESS | 4754 | ************************* 01:38:22 INFO - PROCESS | 4754 | ************************* 01:38:22 INFO - PROCESS | 4754 | A coding exception was thrown and uncaught in a Task. 01:38:22 INFO - PROCESS | 4754 | 01:38:22 ERROR - PROCESS | 4754 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:38:22 INFO - PROCESS | 4754 | Full stack: 01:38:22 INFO - PROCESS | 4754 | ************************* 01:38:22 INFO - PROCESS | 4754 | ************************* 01:38:22 INFO - PROCESS | 4754 | A coding exception was thrown and uncaught in a Task. 01:38:22 INFO - PROCESS | 4754 | 01:38:22 ERROR - PROCESS | 4754 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:38:22 INFO - PROCESS | 4754 | Full stack: 01:38:22 INFO - PROCESS | 4754 | ************************* 01:39:37 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-ext.html (next: http://localhost:35127/tests/dromaeo/cssquery-jquery.html) 01:39:37 INFO - PROCESS | 4754 | RSS: Main: 232300544 01:39:37 INFO - PROCESS | 4754 | 01:42:39 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35127/tests/dromaeo/cssquery-mootools.html) 01:42:40 INFO - PROCESS | 4754 | RSS: Main: 203710464 01:42:40 INFO - PROCESS | 4754 | 01:45:42 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35127/tests/dromaeo/cssquery-prototype.html) 01:45:42 INFO - PROCESS | 4754 | RSS: Main: 206688256 01:45:42 INFO - PROCESS | 4754 | 01:48:45 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35127/tests/dromaeo/cssquery-yui.html) 01:48:46 INFO - PROCESS | 4754 | RSS: Main: 174489600 01:48:46 INFO - PROCESS | 4754 | 01:51:48 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-yui.html (next: http://localhost:35127/tests/dromaeo/cssquery-dojo.html) 01:51:49 INFO - PROCESS | 4754 | RSS: Main: 263024640 01:51:49 INFO - PROCESS | 4754 | 01:51:49 INFO - PROCESS | 4754 | __start_tp_report 01:51:49 INFO - PROCESS | 4754 | _x_x_mozilla_page_load 01:51:49 INFO - PROCESS | 4754 | _x_x_mozilla_page_load_details 01:51:49 INFO - PROCESS | 4754 | |i|pagename|runs| 01:51:49 INFO - PROCESS | 4754 | |0;dojo.html;3402.064432281122;3445.104272889048;3461.3077384523103;3461.8442170102353;3512.086857417071;5628.183913332565;5734.168545560891;5748.9999999999945;5749.655020698761;5782.971085144568;5697.6866272355;5756.510696590794;5758.136279558068;5760.855978600537;5767.884642307151;5073.3404657394485;5124.0776660201145;5125.231215317714;5136.743162841862;5172.612054095939;4986.4265609455015;5005.849824505252;5235.895282094356;5239.423663397023;5277.762500687459;5088.847334579968;5121.155009423441;5204.791808327663;5211.609129315298;5225.555827754645;5249.973750131244;5266.552343050846;5267.130923397634;5268.999999999981;5300.284461597674;4941.505849415065;5102.668326558799;5170;5217.817376391846;5233.738313084331;5627.971860140714;5635.323761148688;5670.943290567124;5697.715114244271;5714.371419143891;6183.350748171422;6212.316645169028;6212.347703491158;6228.532860035515;6235.781747638856;6262.2172228471445;6292.087647291117;6305.558610897239;6312;6319.052142178664;5633.492985631272;5680.517156041741;5767.1637612546365;5798.594098413155;5803.5357171426185;6315.55791094619;6323.30443651198;6327.335629758809;6327.588706734047;6332.746690132435;6095.725692343766;6127.877442451126;6155.138280640714;6155.415235552616;6158.107074474176;5967;5996.5202783777195;6112.5946701277735;6125;6128.1364821545585;6165.352637973038;6205.286392064971;6208.255009398811;6209.565330426917;6218.129461875341;5863.677497737665;5977.731002104916;5983;6111.266648002268;6203.503719702413;4722.079194557028;4749.857504274877;4767.189577771718;4772.188727916263;4781.856544303677;4102.384642303618;4233.364995250676;4256.531781504032;4261.957380426218;4294.677899157513;5856.707164641751;5890.410958904075;5929.881402371929;6004.819855404345;6027.487663548647;6199.845003874939;6222.906656400158;6223.688815559204;6231.563790534709;6236.407541283571;5991.880162396727;5992.790252341147;6016.127661489147;6021.337652858182;6033.245844269466;5074.873128171826;5107.182850743938;5167.896642067138;5257.605679574047;5272.2355258487305;6485.221773387224;6487.156669633012;6490.026496025728;6491.448226900767;6492.935070649233;6096.725647345968;6188.412100850412;6200.906986395298;6207.720652570555;6236.781712640036;6195.19462469876;6237.220347456568;6486.091947127312;6487.935120648922;6501.609903405811;6059.818205453844;6068.362821903813;6130.612163469812;6151.046587778901;6159.969200153971;6165.753369865334;6166.722497487534;6168.876622467616;6174.8147555573405;6190.226221722285;5847.44449277318;6069.33237343883;6076.817695469143;6082.300535438481;6099.992026154221;5958.433948774859;5995.5803093783015;6018.428249316483;6065.909011364744;6135.969320153371;6064.666443345658;6075.939240607538;6077.726502307319;6079.574429789872;6082.2093127893095;5844.415558444121;5894.587378883437;5965.343812180743;6090.269167699905;6111.663858487826;5921.230240068763;5952.077427998667;6005.129256257906;6036.245469316335;6053.243344581927 01:51:49 INFO - PROCESS | 4754 | |1;ext.html;723.7792473295646;798.8921495598095;817.8486979908718;886.1670030171642;903.7198468474777;31381.529277060832;43403.78298108509;44195.3370699439;44262.336064959054;44374.778126109406;44467;44689.776551117284;44728.77635611826;44811.77594112025;44824.77587612066;7613.543187408745;7779.805504862367;9135.68025119121;9275.489848058354;9281;10477.161827053817;10705.036546710795;11004.504797284142;11024.669259922215;11051.668449946474;10803.621873234439;10818.783624327509;10822;10845.295055821385;10848.403337816417;10759.085477734401;10792.676219713381;10796.622118225825;10808.351498910091;10817.405042722647;10587.15302775776;10632.734181645443;10649.361038337647;10654;10657.680269591847;42233.57766422358;42325.57674423278;42436;42464.57535424637;42537.57462425367;4123.505179378464;4172.749635021908;4205.5794420558;4294.4202532658;4298.882290604434;29943.700562994527;30078.398432031456;30431.23921901948;30461.695383046106;31627.683723162932;4293.162833247518;4305.22505948929;4390.165868484977;4391.912161756779;4492.865214043584;230739;230794;231208;232251;232482;54265.45734542604;54341;54371.72814135904;54392.18411723827;54424.45575544273;56480.43519564834;56542.7172864133;56573;56633.150502742494;56745;14655.267236638125;14909.925450372679;14922.179280139697;14980.475683351031;15001.699966000837;12735.554255601195;12761.361931903368;12767.808482872764;13363;13666.52167174144;12531.310777907303;12991.155574887602;13261.73476530464;13312.667183320495;13367.197968121944;5425.755840987086;5529.142982837667;5556.472135147154;5629.887402251932;5660.820584075161;994.3983889746744;1001.114014097529;1003.7942221844504;1018.7249442650443;1024.9846252306222;26840.32899177536;26901.865490672422;26949.73050269472;27170.5924411134;27283.86358068197;1072.4423299884018;1072.9678109656722;1077.498962982217;1078;1094.7974624694457;13871.653208669864;14783.704325913637;14809;14904.18027008525;14964.551063468114;307933;308100;308580;308690;309016;55154;55206;55217;55282.447175527726;55410.16884746732;1481.6369989352677;1518.2105305241212;1535.9462418815287;1540.7919930809421;1550.99224503879;24890.631015294333;26086.34784130412;26357.20928372152;26580.734192657826;26601.33496662599;39864.60135398609;39894.40158397685;39904.2019159621;39958.400623990085;39997.40003900002;276827;277309;277339;278545;278570;29602.407951841273;30278.54582181225;33856.322873541896;34894.30211395809;34909.301813964084;43447.565524344354;44206;45732.54267457416;46596.30105548352;48039;33807.32385352328;34278;34313.48529772006;34737.26313684356;34944.30111397809;33543.16142096467;33991.66008339885;34066.14834629154;34367.82816085903;34420.82789586036;38873.2225355497;39181.2163756729;39348.213035739696;39731.60268397395;39868.40197397099;32317.35365292728;32367;32499.187520311236;32714;33156.83421582876;24687.753122469265;25253.621195682448;25292.74707252904;25537.61693574635;25834.741652583234 01:51:49 INFO - PROCESS | 4754 | |2;jquery.html;458.62851090616584;466.9719816810992;468.9437267527896;481.52088671771594;487.1085912779613;19862.702059469102;21171.364859054214;21548.89225553874;21919;22145.55708885821;22160;22169.667454988186;22528.436789080282;22616.77383226167;22985.850707464644;5015.774290156934;6593.670316484168;6749.088873002131;6779.661016949158;6801.047853300542;6639.701213445406;6730.259671436138;6741.966290168542;6747.257801641816;6748.460123190133;7158.35574798268;7391.371733402667;7597.8480430391355;7603.885941710879;7609.619519024054;7526.548407095537;7534.0582427196605;7539.208383119776;7557;7631.54210747357;7213;7424.183339832614;7465.626718664045;7467.663955122032;7482.363999060087;25592;25729.584872831987;26037.349066273306;26085.230149197447;26146.607800883;3126.3278395145153;3162.3675264946874;3178.110129163838;3247.3180632067056;3267.1668724475107;15393.230338483143;16265.674686506203;16490.34038638453;16769;16777.580560485963;2242.260054182132;2339.0760649543336;2355.5759963206615;2398.9520209595885;2404.0767386091234;114103;116153;116267;116383.83616163814;120042.39978800138;17925.462236132676;17961.640767184843;18095.638087238443;18105.818941810412;18155.273789048555;32144;32611.347773044406;32623.51064734031;32677.50983735246;32951;10662.306950048222;10728.94635526833;10751.51618177184;10852.294600850919;10963.725906852393;9015.323850711091;9130.95434522823;9171.90828091724;9362.204212642002;9389.953050234704;8883.955580222058;9218.86171707425;9392.342536022414;9397.718068457958;9470.573824177929;3624.3294990426857;3696.3900956341904;3827.4067519534515;3844.3474002937883;4000.5599384067727;957.5260246178186;973.2749101919115;980.7891303369667;984.3060642247199;987.8616993620899;21029.579408412053;21291.36125916225;21364.893175534024;21392.144314227568;21410.143594256057;964.4165280005636;966.6423423333412;993.1955116355775;993.3344659078434;993.8857031441477;10784.56861725538;11825.408729563487;11890.464929078213;11916.940415297868;11919.642410727693;631712;632101;651429;659226;679759;109975;111739;114446;116751;118354;1299.226959958823;1303.4655791125592;1313.4549162097815;1319.7096638739463;1333.6132521568636;18024;18256.452306430827;18560.443186704422;18733.718994214825;18752.812471875106;46536.301955470015;48782.5121748778;49181;49414;50474.49525504698;63358.68320658551;63484.68257658867;64409;75970.62014690113;78388;12322.876771232173;12932.93533532364;12946.158499697489;12998.935005324913;13051.477940882258;14426.927865360605;14451;14501.419943202576;14560.126392416489;14646.707065858836;12230.877691222973;12271.325077120844;12318.322492263012;12358.567450139202;12414.131010829517;10714.517846697074;10785.784284314113;10864.782704345711;11023.393713345842;11231.4384280784;12845.935770321088;12896.677583060498;12920.806187907001;13048.673783155496;13050.477980880658;12263.87736122663;12356.320402377956;12395.814062788884;12554.811677825022;12765.93617031909;11834.349110798988;12072.698182545506;12239.449224784728;12979.805302920275;12994.480220791062 01:51:49 INFO - PROCESS | 4754 | |3;mootools.html;1466.7506523890938;1582.16936108543;1603.0702192728215;1603.1102737980423;1610.7664388663643;9231.169194772468;10814.351138931659;11137.05335046521;11151.609693660723;11161.162912781534;11185.66443006709;11248.55005799767;11281.661550153489;11297;11300;2026.0275067967384;2101.8843963582;2290.5876942150367;2321.5589038082794;2323.663068855015;2389.9522009559887;2407.831451798375;2457.4716435966266;2463.950720985579;2476.6904136982876;2333.9883300583474;2339.9766002340016;2349.166046053652;2364.5743766122177;2366.2428023032635;2410.3974006498374;2438.439158993424;2441.7680320369536;2442.6091825307954;2448.5470188015183;2292.0258889971697;2298.7471378148557;2303.8041766449874;2305.884705764705;2309.7228332600193;11286;11369.488373023234;11369.943150284196;11376;11383.089352851752;5665.716714164275;5718.828435146952;5782.392848750863;5783.797567085174;5784.8843023139725;3227.7095061444347;3318.6515415881227;3454.5336379588684;3469.705075068622;3493.6855682988653;1351.108268542757;1374.4364810427776;1397.343248673122;1404.0522647213193;1433.2403825972146;16991;17072;17098.14509274544;17101;17124.05817680027;4726.976365118152;4872.342233798392;4877.365942427533;4925.556699896955;4973.577245934064;13993.790093148611;14047.85952140486;14064.578062658136;14098.577042688736;14136.222507761966;5893.2044174035955;5899.380565040695;5899.46904778572;5900.616459930091;5901.114832775118;5134.229865520202;5387.3804512481565;5427.810026649048;5433.945660543423;5462.235287059815;4201.495820501498;4239.618434340924;4264.530901600821;4316.374125751749;4323.762193079411;1120.8374785656197;1128.3850301585655;1132.2810015639964;1142.628645690154;1148.012709070199;959.2709540748941;975.9853602195973;976.3019441099648;981.9705408837747;995.1789773436943;6764.830879228059;6900.447964162855;6904.13698287714;7030.472714546429;7070.858582828418;1002.4636819301638;1034.374203606822;1037.8754549454113;1061.2253055269541;1070.29895418501;4543.409356783597;4582.495925448198;4597.379353787196;4686.742229177428;4703.74129422885;13410.597682069554;14049.648758780908;14054.086484378482;14060;14074.225917574631;13474.730505389838;13898.86101138996;13909.0959087661;13961.860381396056;14249;10458.790824183627;10758.40828754426;10765.946170269099;10900.96440838135;10940.507677154546;6988.161420629557;7268.27317268269;7292.635368231673;7314.08573928259;7377.262273772794;12326;12496.500139994298;12594.559190428658;12917.612471625866;12923.289219092663;12642.810357844455;12750;12841.614751557468;12923.870761292266;12988.090833641554;9772.462514561767;9829.754256143367;9858.55636496345;9915.25635577349;9930.25523085786;10523.78952420932;10568;10660.147188225079;10677.359358438518;10769.892301077203;8507.234348908629;8553.657853685783;8595.742127736177;8695.043545209895;8699.347548933729;8446.957765211135;8624.525651089;8651.740447786577;8776.297896168164;8850.911490885008;8002.399820013638;8039.919600803917;8147.3482121431325;8203.0566484855;8209.83580328402;6028.75884964614;6066.545009124245;6161.199044124235;6175.475084617858;6224.221972253468;6121.47967422774;6157.353477884937;6281.214848143982;6293.056041593798;6365.108884756045 01:51:49 INFO - PROCESS | 4754 | |4;prototype.html;394.46155997064017;425.7785951305321;426.5201648145836;436.30627302588886;439.9142167277382;5054.646174767768;5185.4296027437;5247.239150323206;5320.308359913206;5328.866778330534;5091.567216786578;5134.485326828585;5144.279800827887;5206.750379908823;5236.266922630825;4442.800443880151;4452.949729435331;4457.977710111453;4467.374567560544;4476.462824461053;4268.743875367472;4324.318922268199;4326.264535029037;4357.3899654048455;4456.376107344974;4299.31211006239;4358.891027724317;4389.517153113155;4414.161309351213;4432.601065904068;4422.7346359218545;4428.180786554498;4446.799894004777;4447.842796243819;4450.287953927356;4228.441528659906;4248.915021699549;4250.702450828443;4293.441852559178;4294.892627684301;5093.617978651616;5107.182850743863;5113.2330150477355;5125.666831655931;5164.096283150471;5184.11869982104;5221.947780522184;5233.581313494911;5266.2890509781455;5299.708516031616;5382.865428364283;5584.86037849053;5604.243427137325;5636.126400407902;5636.267285252891;4779.522047795227;4797.304390863305;4811.831585894512;4838.782254798542;4838.879028024292;5721.799737009184;5742.109972954198;5782.537397008271;5811.535077193815;5855.707214639294;4809.278608208727;5044.848654540369;5050.4697006814495;5070.138076527;5071.442141364447;4873.244647079709;5094.2358646203365;5147.330846989942;5148.382194136728;5161.767720452589;5127.102757017582;5151.562117220078;5221.686698798084;5222.242774797709;5249.291345668362;5594.24477695514;5598.480683692354;5600.283862326768;5607.831765047055;5628.690422026828;1740.1560243282;1769.177332540375;1773;1785.749995000701;1803.5761596024925;1403.3123769352944;1438.7123524445772;1444;1458.176130486293;1473.5338338353406;5482.533984611273;5482.533984611353;5488.423715509894;5494.478024587658;5577.8047768327915;5668.971655141698;5706.885862282731;5753.482186603226;5788.710564471759;5795.565332600072;5168.250603662448;5359.222912677717;5390.407055223922;5474.671519708751;5510.8071217507995;3009.435093751237;3009.6689364169924;3017.89437369691;3021.2778716132034;3032.7565698063686;5779.508741756998;5928.229330187048;5949.672767997715;5971.373005834412;5983.940160598426;5835.2414186156375;5835.599456130498;5842.575331237574;5844.152597873284;5850.069477072556;5847.44449277318;5944.405559444021;5975.37258587842;5994.400559943971;6007.249093863267;5594.664320140804;5637.43625637433;5651.524312547671;5669.858253543694;5676.148577713376;5555.8888822222525;5600.887982240414;5607.299087614048;5623.297087864017;5644.915326270027;5516.14499752539;5707.2332260707735;5783.768649253982;5804.245448091721;5935.5548333875995;4958.537231516639;4977.950220497749;4987.725675087905;4993.325901003318;5014.61805642317;5434.83695489136;5498.80754173602;5512.641678290898;5652.604317697722;5654.123610840326;5510.834674959758;5527.640703354269;5534.667919924656;5575.832725018256;5579.665220086646;5352.705601191972;5524.66851988882;5539.335279766454;5550.001999280336;5617.6910269933915;5465.945340546544;5534.280543529316;5551.389347171727;5563.221149039056;5590.881823635208;5562.944370556243;5620.494155526022;5643.294588176478;5696.658200507983;5707.714614269353;5292.994331077237;5348.860455817704;5391.892162156656;5437.945620543744;5564.081926482085 01:51:49 INFO - PROCESS | 4754 | |5;yui.html;737.4579683932305;864.2912811494573;898.8407335572168;903.408267584732;903.9965638141666;17161;17215.22531486083;17294.82705172948;17519.562010949732;18353.541161470952;16426.589335266624;16567.751483727752;16758.16209189539;17019.91490042548;17145.74281385777;851.7572491839827;868.513632365874;877.4121338703085;882.5234373438368;894.3784070071302;896.3546246702364;898.8202359528087;899.6626265150569;901.4456109492647;901.5131828812433;947.7393716727886;948.0803620488116;948.4830767231875;949.781550243441;950.1021534649759;941.4962994797785;941.8398872191743;941.905809419056;941.9340646154806;944.0182210501071;694.9652517374161;695.5200911371188;696.1750325863817;696.5681277607915;697.1111832413662;17326;17338.2197801098;17609;17832.3758668446;17875.821241787675;14667.77998330026;15617.921910390376;15864.60338491547;16098.678026439406;16380.508584742476;15069.698606027818;15137.318820653098;15175.620609484851;15192.848071519255;15835.524934251876;4822.614190864722;4833.10587541306;4932.5807306379;4960.528749768766;4974.527419895104;86581;89254.661180083;90185;91127.08872911253;91348.08651913462;12685;12721.491140354283;12834.614961551168;12918.935405322913;12945.611631651065;22633.88683056574;22935.770642293697;22942.541149176923;23003.769962300164;23004.53990920172;8492.108328625529;8510.446820956618;8664.09027052163;8834;9406.858897116548;4791.257355109963;4841.205658889256;4904.779284932187;4933.383327084114;5038.899222015539;3867.149227170018;4043.555208927016;4112.259793237246;4117.423560701504;4124.711270211056;650.3561474140662;652.7454292825802;661.3419647450721;661.5567569728294;671.9496037797185;853.2832420766586;874.5277550122862;878.152582757642;880.6169316347409;889.0798024045082;11530.250533715282;11666.183367164387;11807.350595717146;11841.058285259667;12136.45385957634;850.2050582705191;856.9535302001444;865.260202526843;882.302980645283;884.6903583745637;5322.2548843161985;5487.341519017744;5508.008558459435;5557.277553918046;5603.663780173202;69634.30365696279;71907.28092719006;75876.62061689656;78209.60895195487;80579;69034.65482672554;70306;70950.64524677343;71446.64276678584;73430;50973.745131274845;62672;62877.371226288065;62966;63173.368266317666;11531.481083351437;12331.321777302335;12592.893521729638;12611;12721.745565088831;40747.796261018506;41283;41306.793466032475;41470.792646037786;42077.78961105298;49534.50465495443;49629.25556116589;50193.24710129278;50250;50267.74330641763;13882;13930.79103813464;14088.290600841765;14095.577132686036;14255.786163207767;16082.758758618864;16270.918645406697;16322.183890805649;16340.428085016967;16487.505374838773;15997.360105596112;16067.357305708108;16080.115593642462;16083.276252568428;16332.67334653324;15472.303746331667;15536;15716.449924252596;15725.21373931276;15841.207939603204;14897.255137243312;15020.324085415963;15164.31760570799;15224;15453.922730386275;12008.159428840247;12087.305494636677;12223.75552488963;12391.566295179626;12696.873031269939;12579.87420125787;12920.741585168433;12999.480020799441;13158;13205.130750749817 01:51:49 INFO - PROCESS | 4754 | __end_tp_report 01:51:49 INFO - PROCESS | 4754 | __start_cc_report 01:51:49 INFO - PROCESS | 4754 | _x_x_mozilla_cycle_collect,1255 01:51:49 INFO - PROCESS | 4754 | __end_cc_report 01:51:49 INFO - PROCESS | 4754 | __startTimestamp1494233509217__endTimestamp 01:51:49 INFO - PROCESS | 4754 | 01:51:49 INFO - PROCESS | 4754 | ------- Summary: start ------- 01:51:49 INFO - PROCESS | 4754 | Number of tests: 6 01:51:49 INFO - PROCESS | 4754 | 01:51:49 INFO - PROCESS | 4754 | [#0] dojo.html Cycles:165 Average:5735.33 Median:5996.52 stddev:658.97 (11.0%) stddev-sans-first:635.06 01:51:49 INFO - PROCESS | 4754 | Values: 3402.1 3445.1 3461.3 3461.8 3512.1 5628.2 5734.2 5749.0 5749.7 5783.0 5697.7 5756.5 5758.1 5760.9 5767.9 5073.3 5124.1 5125.2 5136.7 5172.6 4986.4 5005.8 5235.9 5239.4 5277.8 5088.8 5121.2 5204.8 5211.6 5225.6 5250.0 5266.6 5267.1 5269.0 5300.3 4941.5 5102.7 5170.0 5217.8 5233.7 5628.0 5635.3 5670.9 5697.7 5714.4 6183.4 6212.3 6212.3 6228.5 6235.8 6262.2 6292.1 6305.6 6312.0 6319.1 5633.5 5680.5 5767.2 5798.6 5803.5 6315.6 6323.3 6327.3 6327.6 6332.7 6095.7 6127.9 6155.1 6155.4 6158.1 5967.0 5996.5 6112.6 6125.0 6128.1 6165.4 6205.3 6208.3 6209.6 6218.1 5863.7 5977.7 5983.0 6111.3 6203.5 4722.1 4749.9 4767.2 4772.2 4781.9 4102.4 4233.4 4256.5 4262.0 4294.7 5856.7 5890.4 5929.9 6004.8 6027.5 6199.8 6222.9 6223.7 6231.6 6236.4 5991.9 5992.8 6016.1 6021.3 6033.2 5074.9 5107.2 5167.9 5257.6 5272.2 6485.2 6487.2 6490.0 6491.4 6492.9 6096.7 6188.4 6200.9 6207.7 6236.8 6195.2 6237.2 6486.1 6487.9 6501.6 6059.8 6068.4 6130.6 6151.0 6160.0 6165.8 6166.7 6168.9 6174.8 6190.2 5847.4 6069.3 6076.8 6082.3 6100.0 5958.4 5995.6 6018.4 6065.9 6136.0 6064.7 6075.9 6077.7 6079.6 6082.2 5844.4 5894.6 5965.3 6090.3 6111.7 5921.2 5952.1 6005.1 6036.2 6053.2 01:51:49 INFO - PROCESS | 4754 | 01:51:49 INFO - PROCESS | 4754 | [#1] ext.html Cycles:180 Average:44618.05 Median:31504.61 stddev:71505.76 (227.0%) stddev-sans-first:71630.40 01:51:49 INFO - PROCESS | 4754 | Values: 723.8 798.9 817.8 886.2 903.7 31381.5 43403.8 44195.3 44262.3 44374.8 44467.0 44689.8 44728.8 44811.8 44824.8 7613.5 7779.8 9135.7 9275.5 9281.0 10477.2 10705.0 11004.5 11024.7 11051.7 10803.6 10818.8 10822.0 10845.3 10848.4 10759.1 10792.7 10796.6 10808.4 10817.4 10587.2 10632.7 10649.4 10654.0 10657.7 42233.6 42325.6 42436.0 42464.6 42537.6 4123.5 4172.7 4205.6 4294.4 4298.9 29943.7 30078.4 30431.2 30461.7 31627.7 4293.2 4305.2 4390.2 4391.9 4492.9 230739.0 230794.0 231208.0 232251.0 232482.0 54265.5 54341.0 54371.7 54392.2 54424.5 56480.4 56542.7 56573.0 56633.2 56745.0 14655.3 14909.9 14922.2 14980.5 15001.7 12735.6 12761.4 12767.8 13363.0 13666.5 12531.3 12991.2 13261.7 13312.7 13367.2 5425.8 5529.1 5556.5 5629.9 5660.8 994.4 1001.1 1003.8 1018.7 1025.0 26840.3 26901.9 26949.7 27170.6 27283.9 1072.4 1073.0 1077.5 1078.0 1094.8 13871.7 14783.7 14809.0 14904.2 14964.6 307933.0 308100.0 308580.0 308690.0 309016.0 55154.0 55206.0 55217.0 55282.4 55410.2 1481.6 1518.2 1535.9 1540.8 1551.0 24890.6 26086.3 26357.2 26580.7 26601.3 39864.6 39894.4 39904.2 39958.4 39997.4 276827.0 277309.0 277339.0 278545.0 278570.0 29602.4 30278.5 33856.3 34894.3 34909.3 43447.6 44206.0 45732.5 46596.3 48039.0 33807.3 34278.0 34313.5 34737.3 34944.3 33543.2 33991.7 34066.1 34367.8 34420.8 38873.2 39181.2 39348.2 39731.6 39868.4 32317.4 32367.0 32499.2 32714.0 33156.8 24687.8 25253.6 25292.7 25537.6 25834.7 01:51:49 INFO - PROCESS | 4754 | 01:51:49 INFO - PROCESS | 4754 | [#2] jquery.html Cycles:180 Average:37617.19 Median:12662.46 stddev:107378.15 (848.0%) stddev-sans-first:107643.13 01:51:49 INFO - PROCESS | 4754 | Values: 458.6 467.0 468.9 481.5 487.1 19862.7 21171.4 21548.9 21919.0 22145.6 22160.0 22169.7 22528.4 22616.8 22985.9 5015.8 6593.7 6749.1 6779.7 6801.0 6639.7 6730.3 6742.0 6747.3 6748.5 7158.4 7391.4 7597.8 7603.9 7609.6 7526.5 7534.1 7539.2 7557.0 7631.5 7213.0 7424.2 7465.6 7467.7 7482.4 25592.0 25729.6 26037.3 26085.2 26146.6 3126.3 3162.4 3178.1 3247.3 3267.2 15393.2 16265.7 16490.3 16769.0 16777.6 2242.3 2339.1 2355.6 2399.0 2404.1 114103.0 116153.0 116267.0 116383.8 120042.4 17925.5 17961.6 18095.6 18105.8 18155.3 32144.0 32611.3 32623.5 32677.5 32951.0 10662.3 10728.9 10751.5 10852.3 10963.7 9015.3 9131.0 9171.9 9362.2 9390.0 8884.0 9218.9 9392.3 9397.7 9470.6 3624.3 3696.4 3827.4 3844.3 4000.6 957.5 973.3 980.8 984.3 987.9 21029.6 21291.4 21364.9 21392.1 21410.1 964.4 966.6 993.2 993.3 993.9 10784.6 11825.4 11890.5 11916.9 11919.6 631712.0 632101.0 651429.0 659226.0 679759.0 109975.0 111739.0 114446.0 116751.0 118354.0 1299.2 1303.5 1313.5 1319.7 1333.6 18024.0 18256.5 18560.4 18733.7 18752.8 46536.3 48782.5 49181.0 49414.0 50474.5 63358.7 63484.7 64409.0 75970.6 78388.0 12322.9 12932.9 12946.2 12998.9 13051.5 14426.9 14451.0 14501.4 14560.1 14646.7 12230.9 12271.3 12318.3 12358.6 12414.1 10714.5 10785.8 10864.8 11023.4 11231.4 12845.9 12896.7 12920.8 13048.7 13050.5 12263.9 12356.3 12395.8 12554.8 12765.9 11834.3 12072.7 12239.4 12979.8 12994.5 01:51:49 INFO - PROCESS | 4754 | 01:51:49 INFO - PROCESS | 4754 | [#3] mootools.html Cycles:180 Average:7028.66 Median:2409.11 stddev:4484.04 (186.1%) stddev-sans-first:4477.15 01:51:49 INFO - PROCESS | 4754 | Values: 1466.8 1582.2 1603.1 1603.1 1610.8 9231.2 10814.4 11137.1 11151.6 11161.2 11185.7 11248.6 11281.7 11297.0 11300.0 2026.0 2101.9 2290.6 2321.6 2323.7 2390.0 2407.8 2457.5 2464.0 2476.7 2334.0 2340.0 2349.2 2364.6 2366.2 2410.4 2438.4 2441.8 2442.6 2448.5 2292.0 2298.7 2303.8 2305.9 2309.7 11286.0 11369.5 11369.9 11376.0 11383.1 5665.7 5718.8 5782.4 5783.8 5784.9 3227.7 3318.7 3454.5 3469.7 3493.7 1351.1 1374.4 1397.3 1404.1 1433.2 16991.0 17072.0 17098.1 17101.0 17124.1 4727.0 4872.3 4877.4 4925.6 4973.6 13993.8 14047.9 14064.6 14098.6 14136.2 5893.2 5899.4 5899.5 5900.6 5901.1 5134.2 5387.4 5427.8 5433.9 5462.2 4201.5 4239.6 4264.5 4316.4 4323.8 1120.8 1128.4 1132.3 1142.6 1148.0 959.3 976.0 976.3 982.0 995.2 6764.8 6900.4 6904.1 7030.5 7070.9 1002.5 1034.4 1037.9 1061.2 1070.3 4543.4 4582.5 4597.4 4686.7 4703.7 13410.6 14049.6 14054.1 14060.0 14074.2 13474.7 13898.9 13909.1 13961.9 14249.0 10458.8 10758.4 10765.9 10901.0 10940.5 6988.2 7268.3 7292.6 7314.1 7377.3 12326.0 12496.5 12594.6 12917.6 12923.3 12642.8 12750.0 12841.6 12923.9 12988.1 9772.5 9829.8 9858.6 9915.3 9930.3 10523.8 10568.0 10660.1 10677.4 10769.9 8507.2 8553.7 8595.7 8695.0 8699.3 8447.0 8624.5 8651.7 8776.3 8850.9 8002.4 8039.9 8147.3 8203.1 8209.8 6028.8 6066.5 6161.2 6175.5 6224.2 6121.5 6157.4 6281.2 6293.1 6365.1 01:51:49 INFO - PROCESS | 4754 | 01:51:49 INFO - PROCESS | 4754 | [#4] prototype.html Cycles:180 Average:4886.16 Median:5324.59 stddev:1268.36 (23.8%) stddev-sans-first:1226.30 01:51:49 INFO - PROCESS | 4754 | Values: 394.5 425.8 426.5 436.3 439.9 5054.6 5185.4 5247.2 5320.3 5328.9 5091.6 5134.5 5144.3 5206.8 5236.3 4442.8 4452.9 4458.0 4467.4 4476.5 4268.7 4324.3 4326.3 4357.4 4456.4 4299.3 4358.9 4389.5 4414.2 4432.6 4422.7 4428.2 4446.8 4447.8 4450.3 4228.4 4248.9 4250.7 4293.4 4294.9 5093.6 5107.2 5113.2 5125.7 5164.1 5184.1 5221.9 5233.6 5266.3 5299.7 5382.9 5584.9 5604.2 5636.1 5636.3 4779.5 4797.3 4811.8 4838.8 4838.9 5721.8 5742.1 5782.5 5811.5 5855.7 4809.3 5044.8 5050.5 5070.1 5071.4 4873.2 5094.2 5147.3 5148.4 5161.8 5127.1 5151.6 5221.7 5222.2 5249.3 5594.2 5598.5 5600.3 5607.8 5628.7 1740.2 1769.2 1773.0 1785.7 1803.6 1403.3 1438.7 1444.0 1458.2 1473.5 5482.5 5482.5 5488.4 5494.5 5577.8 5669.0 5706.9 5753.5 5788.7 5795.6 5168.3 5359.2 5390.4 5474.7 5510.8 3009.4 3009.7 3017.9 3021.3 3032.8 5779.5 5928.2 5949.7 5971.4 5983.9 5835.2 5835.6 5842.6 5844.2 5850.1 5847.4 5944.4 5975.4 5994.4 6007.2 5594.7 5637.4 5651.5 5669.9 5676.1 5555.9 5600.9 5607.3 5623.3 5644.9 5516.1 5707.2 5783.8 5804.2 5935.6 4958.5 4978.0 4987.7 4993.3 5014.6 5434.8 5498.8 5512.6 5652.6 5654.1 5510.8 5527.6 5534.7 5575.8 5579.7 5352.7 5524.7 5539.3 5550.0 5617.7 5465.9 5534.3 5551.4 5563.2 5590.9 5562.9 5620.5 5643.3 5696.7 5707.7 5293.0 5348.9 5391.9 5437.9 5564.1 01:51:49 INFO - PROCESS | 4754 | 01:51:49 INFO - PROCESS | 4754 | [#5] yui.html Cycles:180 Average:18581.26 Median:4806.94 stddev:22607.57 (470.3%) stddev-sans-first:22631.28 01:51:49 INFO - PROCESS | 4754 | Values: 737.5 864.3 898.8 903.4 904.0 17161.0 17215.2 17294.8 17519.6 18353.5 16426.6 16567.8 16758.2 17019.9 17145.7 851.8 868.5 877.4 882.5 894.4 896.4 898.8 899.7 901.4 901.5 947.7 948.1 948.5 949.8 950.1 941.5 941.8 941.9 941.9 944.0 695.0 695.5 696.2 696.6 697.1 17326.0 17338.2 17609.0 17832.4 17875.8 14667.8 15617.9 15864.6 16098.7 16380.5 15069.7 15137.3 15175.6 15192.8 15835.5 4822.6 4833.1 4932.6 4960.5 4974.5 86581.0 89254.7 90185.0 91127.1 91348.1 12685.0 12721.5 12834.6 12918.9 12945.6 22633.9 22935.8 22942.5 23003.8 23004.5 8492.1 8510.4 8664.1 8834.0 9406.9 4791.3 4841.2 4904.8 4933.4 5038.9 3867.1 4043.6 4112.3 4117.4 4124.7 650.4 652.7 661.3 661.6 671.9 853.3 874.5 878.2 880.6 889.1 11530.3 11666.2 11807.4 11841.1 12136.5 850.2 857.0 865.3 882.3 884.7 5322.3 5487.3 5508.0 5557.3 5603.7 69634.3 71907.3 75876.6 78209.6 80579.0 69034.7 70306.0 70950.6 71446.6 73430.0 50973.7 62672.0 62877.4 62966.0 63173.4 11531.5 12331.3 12592.9 12611.0 12721.7 40747.8 41283.0 41306.8 41470.8 42077.8 49534.5 49629.3 50193.2 50250.0 50267.7 13882.0 13930.8 14088.3 14095.6 14255.8 16082.8 16270.9 16322.2 16340.4 16487.5 15997.4 16067.4 16080.1 16083.3 16332.7 15472.3 15536.0 15716.4 15725.2 15841.2 14897.3 15020.3 15164.3 15224.0 15453.9 12008.2 12087.3 12223.8 12391.6 12696.9 12579.9 12920.7 12999.5 13158.0 13205.1 01:51:49 INFO - PROCESS | 4754 | -------- Summary: end -------- 01:51:49 INFO - PROCESS | 4754 | 01:51:50 INFO - TEST-INFO | 4754: exit 0 01:51:50 INFO - TEST-OK | dromaeo_css | took 1115946ms 01:51:50 INFO - TEST-START | kraken 01:51:50 INFO - operating with platform_type : linux_ 01:51:50 INFO - Initialising browser for kraken test... 01:51:50 INFO - TEST-INFO | started process 5080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HiIy3/profile http://localhost:35127/getInfo.html) 01:51:54 INFO - PROCESS | 5080 | __metrics Screen width/height:1600/1200 01:51:54 INFO - PROCESS | 5080 | colorDepth:24 01:51:54 INFO - PROCESS | 5080 | Browser inner width/height: 1024/697 01:51:54 INFO - PROCESS | 5080 | __metrics 01:51:55 INFO - PROCESS | 5080 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:51:55 INFO - PROCESS | 5080 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:51:56 INFO - TEST-INFO | 5080: exit 0 01:51:56 INFO - Browser initialized. 01:51:56 INFO - Running cycle 1/1 for kraken test... 01:51:56 INFO - TEST-INFO | started process 5177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HiIy3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:08 INFO - PROCESS | 5177 | RSS: Main: 139776000 01:52:08 INFO - PROCESS | 5177 | 01:52:10 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35127/tests/kraken/driver.html?testName=audio-beat-detection) 01:52:11 INFO - PROCESS | 5177 | RSS: Main: 183623680 01:52:11 INFO - PROCESS | 5177 | 01:52:13 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35127/tests/kraken/driver.html?testName=audio-dft) 01:52:14 INFO - PROCESS | 5177 | RSS: Main: 174481408 01:52:14 INFO - PROCESS | 5177 | 01:52:17 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35127/tests/kraken/driver.html?testName=audio-fft) 01:52:17 INFO - PROCESS | 5177 | RSS: Main: 265658368 01:52:17 INFO - PROCESS | 5177 | 01:52:19 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35127/tests/kraken/driver.html?testName=audio-oscillator) 01:52:20 INFO - PROCESS | 5177 | RSS: Main: 172240896 01:52:20 INFO - PROCESS | 5177 | 01:52:22 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35127/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:52:23 INFO - PROCESS | 5177 | RSS: Main: 174493696 01:52:23 INFO - PROCESS | 5177 | 01:52:26 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35127/tests/kraken/driver.html?testName=imaging-darkroom) 01:52:26 INFO - PROCESS | 5177 | RSS: Main: 212860928 01:52:26 INFO - PROCESS | 5177 | 01:52:30 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35127/tests/kraken/driver.html?testName=imaging-desaturate) 01:52:30 INFO - PROCESS | 5177 | RSS: Main: 212062208 01:52:30 INFO - PROCESS | 5177 | 01:52:33 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35127/tests/kraken/driver.html?testName=json-parse-financial) 01:52:34 INFO - PROCESS | 5177 | RSS: Main: 210989056 01:52:34 INFO - PROCESS | 5177 | 01:52:35 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35127/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:52:36 INFO - PROCESS | 5177 | RSS: Main: 173109248 01:52:36 INFO - PROCESS | 5177 | 01:52:37 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:52:38 INFO - PROCESS | 5177 | RSS: Main: 179634176 01:52:38 INFO - PROCESS | 5177 | 01:52:40 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:52:41 INFO - PROCESS | 5177 | RSS: Main: 184741888 01:52:41 INFO - PROCESS | 5177 | 01:52:43 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:52:44 INFO - PROCESS | 5177 | RSS: Main: 180842496 01:52:44 INFO - PROCESS | 5177 | 01:52:47 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:52:47 INFO - PROCESS | 5177 | RSS: Main: 184565760 01:52:47 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35127/tests/kraken/driver.html?testName=ai-astar) 01:52:49 INFO - PROCESS | 5177 | RSS: Main: 238469120 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | __start_tp_report 01:52:49 INFO - PROCESS | 5177 | _x_x_mozilla_page_load 01:52:49 INFO - PROCESS | 5177 | _x_x_mozilla_page_load_details 01:52:49 INFO - PROCESS | 5177 | |i|pagename|runs| 01:52:49 INFO - PROCESS | 5177 | |0;ai-astar;110;113;112;112;113;112;112;113;112;113 01:52:49 INFO - PROCESS | 5177 | |1;audio-beat-detection;147;115;116;156;115;116;116;116;131;115 01:52:49 INFO - PROCESS | 5177 | |2;audio-dft;162;159;160;163;161;164;162;162;160;163 01:52:49 INFO - PROCESS | 5177 | |3;audio-fft;75;75;75;106;77;76;75;76;92;74 01:52:49 INFO - PROCESS | 5177 | |4;audio-oscillator;84;83;108;83;84;83;98;82;82;100 01:52:49 INFO - PROCESS | 5177 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;113;113;113 01:52:49 INFO - PROCESS | 5177 | |6;imaging-darkroom;148;147;147;147;148;146;148;146;147;148 01:52:49 INFO - PROCESS | 5177 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 01:52:49 INFO - PROCESS | 5177 | |8;json-parse-financial;60;55;54;54;55;54;55;55;58;54 01:52:49 INFO - PROCESS | 5177 | |9;json-stringify-tinderbox;53;53;53;53;53;53;56;54;53;53 01:52:49 INFO - PROCESS | 5177 | |10;stanford-crypto-aes;81;80;82;81;82;81;79;82;79;105 01:52:49 INFO - PROCESS | 5177 | |11;stanford-crypto-ccm;122;131;125;135;119;118;120;119;139;126 01:52:49 INFO - PROCESS | 5177 | |12;stanford-crypto-pbkdf2;160;163;174;158;155;163;159;162;163;159 01:52:49 INFO - PROCESS | 5177 | |13;stanford-crypto-sha256-iterative;63;60;59;59;60;59;59;60;58;58 01:52:49 INFO - PROCESS | 5177 | __end_tp_report 01:52:49 INFO - PROCESS | 5177 | __start_cc_report 01:52:49 INFO - PROCESS | 5177 | _x_x_mozilla_cycle_collect,1651 01:52:49 INFO - PROCESS | 5177 | __end_cc_report 01:52:49 INFO - PROCESS | 5177 | __startTimestamp1494233569686__endTimestamp 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | ------- Summary: start ------- 01:52:49 INFO - PROCESS | 5177 | Number of tests: 14 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:0.92 (0.8%) stddev-sans-first:0.53 01:52:49 INFO - PROCESS | 5177 | Values: 110.0 113.0 112.0 112.0 113.0 112.0 112.0 113.0 112.0 113.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:116.00 stddev:15.28 (13.2%) stddev-sans-first:13.82 01:52:49 INFO - PROCESS | 5177 | Values: 147.0 115.0 116.0 156.0 115.0 116.0 116.0 116.0 131.0 115.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 01:52:49 INFO - PROCESS | 5177 | Values: 162.0 159.0 160.0 163.0 161.0 164.0 162.0 162.0 160.0 163.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.50 stddev:10.52 (13.9%) stddev-sans-first:11.00 01:52:49 INFO - PROCESS | 5177 | Values: 75.0 75.0 75.0 106.0 77.0 76.0 75.0 76.0 92.0 74.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:83.00 stddev:9.53 (11.5%) stddev-sans-first:9.96 01:52:49 INFO - PROCESS | 5177 | Values: 84.0 83.0 108.0 83.0 84.0 83.0 98.0 82.0 82.0 100.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:52:49 INFO - PROCESS | 5177 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 01:52:49 INFO - PROCESS | 5177 | Values: 148.0 147.0 147.0 147.0 148.0 146.0 148.0 146.0 147.0 148.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:52:49 INFO - PROCESS | 5177 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.01 (3.7%) stddev-sans-first:1.27 01:52:49 INFO - PROCESS | 5177 | Values: 60.0 55.0 54.0 54.0 55.0 54.0 55.0 55.0 58.0 54.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 01:52:49 INFO - PROCESS | 5177 | Values: 53.0 53.0 53.0 53.0 53.0 53.0 56.0 54.0 53.0 53.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:81.00 stddev:7.74 (9.6%) stddev-sans-first:8.17 01:52:49 INFO - PROCESS | 5177 | Values: 81.0 80.0 82.0 81.0 82.0 81.0 79.0 82.0 79.0 105.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:125.50 stddev:7.35 (5.9%) stddev-sans-first:7.69 01:52:49 INFO - PROCESS | 5177 | Values: 122.0 131.0 125.0 135.0 119.0 118.0 120.0 119.0 139.0 126.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.50 stddev:5.08 (3.1%) stddev-sans-first:5.36 01:52:49 INFO - PROCESS | 5177 | Values: 160.0 163.0 174.0 158.0 155.0 163.0 159.0 162.0 163.0 159.0 01:52:49 INFO - PROCESS | 5177 | 01:52:49 INFO - PROCESS | 5177 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:59.50 stddev:1.43 (2.4%) stddev-sans-first:0.78 01:52:49 INFO - PROCESS | 5177 | Values: 63.0 60.0 59.0 59.0 60.0 59.0 59.0 60.0 58.0 58.0 01:52:49 INFO - PROCESS | 5177 | -------- Summary: end -------- 01:52:49 INFO - PROCESS | 5177 | 01:52:50 INFO - TEST-INFO | 5177: exit 0 01:52:50 INFO - TEST-OK | kraken | took 60661ms 01:52:50 INFO - SUITE-END | took 1176s 01:52:50 INFO - Completed test suite (00:19:36) 01:52:50 INFO - javascript benchmark 01:52:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7898.39649894846, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3402.064432281122, 3445.104272889048, 3461.3077384523103, 3461.8442170102353, 3512.086857417071, 5628.183913332565, 5734.168545560891, 5748.9999999999945, 5749.655020698761, 5782.971085144568, 5697.6866272355, 5756.510696590794, 5758.136279558068, 5760.855978600537, 5767.884642307151, 5073.3404657394485, 5124.0776660201145, 5125.231215317714, 5136.743162841862, 5172.612054095939, 4986.4265609455015, 5005.849824505252, 5235.895282094356, 5239.423663397023, 5277.762500687459, 5088.847334579968, 5121.155009423441, 5204.791808327663, 5211.609129315298, 5225.555827754645, 5249.973750131244, 5266.552343050846, 5267.130923397634, 5268.999999999981, 5300.284461597674, 4941.505849415065, 5102.668326558799, 5170.0, 5217.817376391846, 5233.738313084331, 5627.971860140714, 5635.323761148688, 5670.943290567124, 5697.715114244271, 5714.371419143891, 6183.350748171422, 6212.316645169028, 6212.347703491158, 6228.532860035515, 6235.781747638856, 6262.2172228471445, 6292.087647291117, 6305.558610897239, 6312.0, 6319.052142178664, 5633.492985631272, 5680.517156041741, 5767.1637612546365, 5798.594098413155, 5803.5357171426185, 6315.55791094619, 6323.30443651198, 6327.335629758809, 6327.588706734047, 6332.746690132435, 6095.725692343766, 6127.877442451126, 6155.138280640714, 6155.415235552616, 6158.107074474176, 5967.0, 5996.5202783777195, 6112.5946701277735, 6125.0, 6128.1364821545585, 6165.352637973038, 6205.286392064971, 6208.255009398811, 6209.565330426917, 6218.129461875341, 5863.677497737665, 5977.731002104916, 5983.0, 6111.266648002268, 6203.503719702413, 4722.079194557028, 4749.857504274877, 4767.189577771718, 4772.188727916263, 4781.856544303677, 4102.384642303618, 4233.364995250676, 4256.531781504032, 4261.957380426218, 4294.677899157513, 5856.707164641751, 5890.410958904075, 5929.881402371929, 6004.819855404345, 6027.487663548647, 6199.845003874939, 6222.906656400158, 6223.688815559204, 6231.563790534709, 6236.407541283571, 5991.880162396727, 5992.790252341147, 6016.127661489147, 6021.337652858182, 6033.245844269466, 5074.873128171826, 5107.182850743938, 5167.896642067138, 5257.605679574047, 5272.2355258487305, 6485.221773387224, 6487.156669633012, 6490.026496025728, 6491.448226900767, 6492.935070649233, 6096.725647345968, 6188.412100850412, 6200.906986395298, 6207.720652570555, 6236.781712640036, 6195.19462469876, 6237.220347456568, 6486.091947127312, 6487.935120648922, 6501.609903405811, 6059.818205453844, 6068.362821903813, 6130.612163469812, 6151.046587778901, 6159.969200153971, 6165.753369865334, 6166.722497487534, 6168.876622467616, 6174.8147555573405, 6190.226221722285, 5847.44449277318, 6069.33237343883, 6076.817695469143, 6082.300535438481, 6099.992026154221, 5958.433948774859, 5995.5803093783015, 6018.428249316483, 6065.909011364744, 6135.969320153371, 6064.666443345658, 6075.939240607538, 6077.726502307319, 6079.574429789872, 6082.2093127893095, 5844.415558444121, 5894.587378883437, 5965.343812180743, 6090.269167699905, 6111.663858487826, 5921.230240068763, 5952.077427998667, 6005.129256257906, 6036.245469316335, 6053.243344581927], "value": 5691.5252128286775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.7792473295646, 798.8921495598095, 817.8486979908718, 886.1670030171642, 903.7198468474777, 31381.529277060832, 43403.78298108509, 44195.3370699439, 44262.336064959054, 44374.778126109406, 44467.0, 44689.776551117284, 44728.77635611826, 44811.77594112025, 44824.77587612066, 7613.543187408745, 7779.805504862367, 9135.68025119121, 9275.489848058354, 9281.0, 10477.161827053817, 10705.036546710795, 11004.504797284142, 11024.669259922215, 11051.668449946474, 10803.621873234439, 10818.783624327509, 10822.0, 10845.295055821385, 10848.403337816417, 10759.085477734401, 10792.676219713381, 10796.622118225825, 10808.351498910091, 10817.405042722647, 10587.15302775776, 10632.734181645443, 10649.361038337647, 10654.0, 10657.680269591847, 42233.57766422358, 42325.57674423278, 42436.0, 42464.57535424637, 42537.57462425367, 4123.505179378464, 4172.749635021908, 4205.5794420558, 4294.4202532658, 4298.882290604434, 29943.700562994527, 30078.398432031456, 30431.23921901948, 30461.695383046106, 31627.683723162932, 4293.162833247518, 4305.22505948929, 4390.165868484977, 4391.912161756779, 4492.865214043584, 230739.0, 230794.0, 231208.0, 232251.0, 232482.0, 54265.45734542604, 54341.0, 54371.72814135904, 54392.18411723827, 54424.45575544273, 56480.43519564834, 56542.7172864133, 56573.0, 56633.150502742494, 56745.0, 14655.267236638125, 14909.925450372679, 14922.179280139697, 14980.475683351031, 15001.699966000837, 12735.554255601195, 12761.361931903368, 12767.808482872764, 13363.0, 13666.52167174144, 12531.310777907303, 12991.155574887602, 13261.73476530464, 13312.667183320495, 13367.197968121944, 5425.755840987086, 5529.142982837667, 5556.472135147154, 5629.887402251932, 5660.820584075161, 994.3983889746744, 1001.114014097529, 1003.7942221844504, 1018.7249442650443, 1024.9846252306222, 26840.32899177536, 26901.865490672422, 26949.73050269472, 27170.5924411134, 27283.86358068197, 1072.4423299884018, 1072.9678109656722, 1077.498962982217, 1078.0, 1094.7974624694457, 13871.653208669864, 14783.704325913637, 14809.0, 14904.18027008525, 14964.551063468114, 307933.0, 308100.0, 308580.0, 308690.0, 309016.0, 55154.0, 55206.0, 55217.0, 55282.447175527726, 55410.16884746732, 1481.6369989352677, 1518.2105305241212, 1535.9462418815287, 1540.7919930809421, 1550.99224503879, 24890.631015294333, 26086.34784130412, 26357.20928372152, 26580.734192657826, 26601.33496662599, 39864.60135398609, 39894.40158397685, 39904.2019159621, 39958.400623990085, 39997.40003900002, 276827.0, 277309.0, 277339.0, 278545.0, 278570.0, 29602.407951841273, 30278.54582181225, 33856.322873541896, 34894.30211395809, 34909.301813964084, 43447.565524344354, 44206.0, 45732.54267457416, 46596.30105548352, 48039.0, 33807.32385352328, 34278.0, 34313.48529772006, 34737.26313684356, 34944.30111397809, 33543.16142096467, 33991.66008339885, 34066.14834629154, 34367.82816085903, 34420.82789586036, 38873.2225355497, 39181.2163756729, 39348.213035739696, 39731.60268397395, 39868.40197397099, 32317.35365292728, 32367.0, 32499.187520311236, 32714.0, 33156.83421582876, 24687.753122469265, 25253.621195682448, 25292.74707252904, 25537.61693574635, 25834.741652583234], "value": 18837.74484077939, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.62851090616584, 466.9719816810992, 468.9437267527896, 481.52088671771594, 487.1085912779613, 19862.702059469102, 21171.364859054214, 21548.89225553874, 21919.0, 22145.55708885821, 22160.0, 22169.667454988186, 22528.436789080282, 22616.77383226167, 22985.850707464644, 5015.774290156934, 6593.670316484168, 6749.088873002131, 6779.661016949158, 6801.047853300542, 6639.701213445406, 6730.259671436138, 6741.966290168542, 6747.257801641816, 6748.460123190133, 7158.35574798268, 7391.371733402667, 7597.8480430391355, 7603.885941710879, 7609.619519024054, 7526.548407095537, 7534.0582427196605, 7539.208383119776, 7557.0, 7631.54210747357, 7213.0, 7424.183339832614, 7465.626718664045, 7467.663955122032, 7482.363999060087, 25592.0, 25729.584872831987, 26037.349066273306, 26085.230149197447, 26146.607800883, 3126.3278395145153, 3162.3675264946874, 3178.110129163838, 3247.3180632067056, 3267.1668724475107, 15393.230338483143, 16265.674686506203, 16490.34038638453, 16769.0, 16777.580560485963, 2242.260054182132, 2339.0760649543336, 2355.5759963206615, 2398.9520209595885, 2404.0767386091234, 114103.0, 116153.0, 116267.0, 116383.83616163814, 120042.39978800138, 17925.462236132676, 17961.640767184843, 18095.638087238443, 18105.818941810412, 18155.273789048555, 32144.0, 32611.347773044406, 32623.51064734031, 32677.50983735246, 32951.0, 10662.306950048222, 10728.94635526833, 10751.51618177184, 10852.294600850919, 10963.725906852393, 9015.323850711091, 9130.95434522823, 9171.90828091724, 9362.204212642002, 9389.953050234704, 8883.955580222058, 9218.86171707425, 9392.342536022414, 9397.718068457958, 9470.573824177929, 3624.3294990426857, 3696.3900956341904, 3827.4067519534515, 3844.3474002937883, 4000.5599384067727, 957.5260246178186, 973.2749101919115, 980.7891303369667, 984.3060642247199, 987.8616993620899, 21029.579408412053, 21291.36125916225, 21364.893175534024, 21392.144314227568, 21410.143594256057, 964.4165280005636, 966.6423423333412, 993.1955116355775, 993.3344659078434, 993.8857031441477, 10784.56861725538, 11825.408729563487, 11890.464929078213, 11916.940415297868, 11919.642410727693, 631712.0, 632101.0, 651429.0, 659226.0, 679759.0, 109975.0, 111739.0, 114446.0, 116751.0, 118354.0, 1299.226959958823, 1303.4655791125592, 1313.4549162097815, 1319.7096638739463, 1333.6132521568636, 18024.0, 18256.452306430827, 18560.443186704422, 18733.718994214825, 18752.812471875106, 46536.301955470015, 48782.5121748778, 49181.0, 49414.0, 50474.49525504698, 63358.68320658551, 63484.68257658867, 64409.0, 75970.62014690113, 78388.0, 12322.876771232173, 12932.93533532364, 12946.158499697489, 12998.935005324913, 13051.477940882258, 14426.927865360605, 14451.0, 14501.419943202576, 14560.126392416489, 14646.707065858836, 12230.877691222973, 12271.325077120844, 12318.322492263012, 12358.567450139202, 12414.131010829517, 10714.517846697074, 10785.784284314113, 10864.782704345711, 11023.393713345842, 11231.4384280784, 12845.935770321088, 12896.677583060498, 12920.806187907001, 13048.673783155496, 13050.477980880658, 12263.87736122663, 12356.320402377956, 12395.814062788884, 12554.811677825022, 12765.93617031909, 11834.349110798988, 12072.698182545506, 12239.449224784728, 12979.805302920275, 12994.480220791062], "value": 11629.011862683143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.7506523890938, 1582.16936108543, 1603.0702192728215, 1603.1102737980423, 1610.7664388663643, 9231.169194772468, 10814.351138931659, 11137.05335046521, 11151.609693660723, 11161.162912781534, 11185.66443006709, 11248.55005799767, 11281.661550153489, 11297.0, 11300.0, 2026.0275067967384, 2101.8843963582, 2290.5876942150367, 2321.5589038082794, 2323.663068855015, 2389.9522009559887, 2407.831451798375, 2457.4716435966266, 2463.950720985579, 2476.6904136982876, 2333.9883300583474, 2339.9766002340016, 2349.166046053652, 2364.5743766122177, 2366.2428023032635, 2410.3974006498374, 2438.439158993424, 2441.7680320369536, 2442.6091825307954, 2448.5470188015183, 2292.0258889971697, 2298.7471378148557, 2303.8041766449874, 2305.884705764705, 2309.7228332600193, 11286.0, 11369.488373023234, 11369.943150284196, 11376.0, 11383.089352851752, 5665.716714164275, 5718.828435146952, 5782.392848750863, 5783.797567085174, 5784.8843023139725, 3227.7095061444347, 3318.6515415881227, 3454.5336379588684, 3469.705075068622, 3493.6855682988653, 1351.108268542757, 1374.4364810427776, 1397.343248673122, 1404.0522647213193, 1433.2403825972146, 16991.0, 17072.0, 17098.14509274544, 17101.0, 17124.05817680027, 4726.976365118152, 4872.342233798392, 4877.365942427533, 4925.556699896955, 4973.577245934064, 13993.790093148611, 14047.85952140486, 14064.578062658136, 14098.577042688736, 14136.222507761966, 5893.2044174035955, 5899.380565040695, 5899.46904778572, 5900.616459930091, 5901.114832775118, 5134.229865520202, 5387.3804512481565, 5427.810026649048, 5433.945660543423, 5462.235287059815, 4201.495820501498, 4239.618434340924, 4264.530901600821, 4316.374125751749, 4323.762193079411, 1120.8374785656197, 1128.3850301585655, 1132.2810015639964, 1142.628645690154, 1148.012709070199, 959.2709540748941, 975.9853602195973, 976.3019441099648, 981.9705408837747, 995.1789773436943, 6764.830879228059, 6900.447964162855, 6904.13698287714, 7030.472714546429, 7070.858582828418, 1002.4636819301638, 1034.374203606822, 1037.8754549454113, 1061.2253055269541, 1070.29895418501, 4543.409356783597, 4582.495925448198, 4597.379353787196, 4686.742229177428, 4703.74129422885, 13410.597682069554, 14049.648758780908, 14054.086484378482, 14060.0, 14074.225917574631, 13474.730505389838, 13898.86101138996, 13909.0959087661, 13961.860381396056, 14249.0, 10458.790824183627, 10758.40828754426, 10765.946170269099, 10900.96440838135, 10940.507677154546, 6988.161420629557, 7268.27317268269, 7292.635368231673, 7314.08573928259, 7377.262273772794, 12326.0, 12496.500139994298, 12594.559190428658, 12917.612471625866, 12923.289219092663, 12642.810357844455, 12750.0, 12841.614751557468, 12923.870761292266, 12988.090833641554, 9772.462514561767, 9829.754256143367, 9858.55636496345, 9915.25635577349, 9930.25523085786, 10523.78952420932, 10568.0, 10660.147188225079, 10677.359358438518, 10769.892301077203, 8507.234348908629, 8553.657853685783, 8595.742127736177, 8695.043545209895, 8699.347548933729, 8446.957765211135, 8624.525651089, 8651.740447786577, 8776.297896168164, 8850.911490885008, 8002.399820013638, 8039.919600803917, 8147.3482121431325, 8203.0566484855, 8209.83580328402, 6028.75884964614, 6066.545009124245, 6161.199044124235, 6175.475084617858, 6224.221972253468, 6121.47967422774, 6157.353477884937, 6281.214848143982, 6293.056041593798, 6365.108884756045], "value": 5330.727831859754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.46155997064017, 425.7785951305321, 426.5201648145836, 436.30627302588886, 439.9142167277382, 5054.646174767768, 5185.4296027437, 5247.239150323206, 5320.308359913206, 5328.866778330534, 5091.567216786578, 5134.485326828585, 5144.279800827887, 5206.750379908823, 5236.266922630825, 4442.800443880151, 4452.949729435331, 4457.977710111453, 4467.374567560544, 4476.462824461053, 4268.743875367472, 4324.318922268199, 4326.264535029037, 4357.3899654048455, 4456.376107344974, 4299.31211006239, 4358.891027724317, 4389.517153113155, 4414.161309351213, 4432.601065904068, 4422.7346359218545, 4428.180786554498, 4446.799894004777, 4447.842796243819, 4450.287953927356, 4228.441528659906, 4248.915021699549, 4250.702450828443, 4293.441852559178, 4294.892627684301, 5093.617978651616, 5107.182850743863, 5113.2330150477355, 5125.666831655931, 5164.096283150471, 5184.11869982104, 5221.947780522184, 5233.581313494911, 5266.2890509781455, 5299.708516031616, 5382.865428364283, 5584.86037849053, 5604.243427137325, 5636.126400407902, 5636.267285252891, 4779.522047795227, 4797.304390863305, 4811.831585894512, 4838.782254798542, 4838.879028024292, 5721.799737009184, 5742.109972954198, 5782.537397008271, 5811.535077193815, 5855.707214639294, 4809.278608208727, 5044.848654540369, 5050.4697006814495, 5070.138076527, 5071.442141364447, 4873.244647079709, 5094.2358646203365, 5147.330846989942, 5148.382194136728, 5161.767720452589, 5127.102757017582, 5151.562117220078, 5221.686698798084, 5222.242774797709, 5249.291345668362, 5594.24477695514, 5598.480683692354, 5600.283862326768, 5607.831765047055, 5628.690422026828, 1740.1560243282, 1769.177332540375, 1773.0, 1785.749995000701, 1803.5761596024925, 1403.3123769352944, 1438.7123524445772, 1444.0, 1458.176130486293, 1473.5338338353406, 5482.533984611273, 5482.533984611353, 5488.423715509894, 5494.478024587658, 5577.8047768327915, 5668.971655141698, 5706.885862282731, 5753.482186603226, 5788.710564471759, 5795.565332600072, 5168.250603662448, 5359.222912677717, 5390.407055223922, 5474.671519708751, 5510.8071217507995, 3009.435093751237, 3009.6689364169924, 3017.89437369691, 3021.2778716132034, 3032.7565698063686, 5779.508741756998, 5928.229330187048, 5949.672767997715, 5971.373005834412, 5983.940160598426, 5835.2414186156375, 5835.599456130498, 5842.575331237574, 5844.152597873284, 5850.069477072556, 5847.44449277318, 5944.405559444021, 5975.37258587842, 5994.400559943971, 6007.249093863267, 5594.664320140804, 5637.43625637433, 5651.524312547671, 5669.858253543694, 5676.148577713376, 5555.8888822222525, 5600.887982240414, 5607.299087614048, 5623.297087864017, 5644.915326270027, 5516.14499752539, 5707.2332260707735, 5783.768649253982, 5804.245448091721, 5935.5548333875995, 4958.537231516639, 4977.950220497749, 4987.725675087905, 4993.325901003318, 5014.61805642317, 5434.83695489136, 5498.80754173602, 5512.641678290898, 5652.604317697722, 5654.123610840326, 5510.834674959758, 5527.640703354269, 5534.667919924656, 5575.832725018256, 5579.665220086646, 5352.705601191972, 5524.66851988882, 5539.335279766454, 5550.001999280336, 5617.6910269933915, 5465.945340546544, 5534.280543529316, 5551.389347171727, 5563.221149039056, 5590.881823635208, 5562.944370556243, 5620.494155526022, 5643.294588176478, 5696.658200507983, 5707.714614269353, 5292.994331077237, 5348.860455817704, 5391.892162156656, 5437.945620543744, 5564.081926482085], "value": 4525.54290961154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.4579683932305, 864.2912811494573, 898.8407335572168, 903.408267584732, 903.9965638141666, 17161.0, 17215.22531486083, 17294.82705172948, 17519.562010949732, 18353.541161470952, 16426.589335266624, 16567.751483727752, 16758.16209189539, 17019.91490042548, 17145.74281385777, 851.7572491839827, 868.513632365874, 877.4121338703085, 882.5234373438368, 894.3784070071302, 896.3546246702364, 898.8202359528087, 899.6626265150569, 901.4456109492647, 901.5131828812433, 947.7393716727886, 948.0803620488116, 948.4830767231875, 949.781550243441, 950.1021534649759, 941.4962994797785, 941.8398872191743, 941.905809419056, 941.9340646154806, 944.0182210501071, 694.9652517374161, 695.5200911371188, 696.1750325863817, 696.5681277607915, 697.1111832413662, 17326.0, 17338.2197801098, 17609.0, 17832.3758668446, 17875.821241787675, 14667.77998330026, 15617.921910390376, 15864.60338491547, 16098.678026439406, 16380.508584742476, 15069.698606027818, 15137.318820653098, 15175.620609484851, 15192.848071519255, 15835.524934251876, 4822.614190864722, 4833.10587541306, 4932.5807306379, 4960.528749768766, 4974.527419895104, 86581.0, 89254.661180083, 90185.0, 91127.08872911253, 91348.08651913462, 12685.0, 12721.491140354283, 12834.614961551168, 12918.935405322913, 12945.611631651065, 22633.88683056574, 22935.770642293697, 22942.541149176923, 23003.769962300164, 23004.53990920172, 8492.108328625529, 8510.446820956618, 8664.09027052163, 8834.0, 9406.858897116548, 4791.257355109963, 4841.205658889256, 4904.779284932187, 4933.383327084114, 5038.899222015539, 3867.149227170018, 4043.555208927016, 4112.259793237246, 4117.423560701504, 4124.711270211056, 650.3561474140662, 652.7454292825802, 661.3419647450721, 661.5567569728294, 671.9496037797185, 853.2832420766586, 874.5277550122862, 878.152582757642, 880.6169316347409, 889.0798024045082, 11530.250533715282, 11666.183367164387, 11807.350595717146, 11841.058285259667, 12136.45385957634, 850.2050582705191, 856.9535302001444, 865.260202526843, 882.302980645283, 884.6903583745637, 5322.2548843161985, 5487.341519017744, 5508.008558459435, 5557.277553918046, 5603.663780173202, 69634.30365696279, 71907.28092719006, 75876.62061689656, 78209.60895195487, 80579.0, 69034.65482672554, 70306.0, 70950.64524677343, 71446.64276678584, 73430.0, 50973.745131274845, 62672.0, 62877.371226288065, 62966.0, 63173.368266317666, 11531.481083351437, 12331.321777302335, 12592.893521729638, 12611.0, 12721.745565088831, 40747.796261018506, 41283.0, 41306.793466032475, 41470.792646037786, 42077.78961105298, 49534.50465495443, 49629.25556116589, 50193.24710129278, 50250.0, 50267.74330641763, 13882.0, 13930.79103813464, 14088.290600841765, 14095.577132686036, 14255.786163207767, 16082.758758618864, 16270.918645406697, 16322.183890805649, 16340.428085016967, 16487.505374838773, 15997.360105596112, 16067.357305708108, 16080.115593642462, 16083.276252568428, 16332.67334653324, 15472.303746331667, 15536.0, 15716.449924252596, 15725.21373931276, 15841.207939603204, 14897.255137243312, 15020.324085415963, 15164.31760570799, 15224.0, 15453.922730386275, 12008.159428840247, 12087.305494636677, 12223.75552488963, 12391.566295179626, 12696.873031269939, 12579.87420125787, 12920.741585168433, 12999.480020799441, 13158.0, 13205.130750749817], "value": 8071.197534637604, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 116.0, 156.0, 115.0, 116.0, 116.0, 116.0, 131.0, 115.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 163.0, 161.0, 164.0, 162.0, 162.0, 160.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 106.0, 77.0, 76.0, 75.0, 76.0, 92.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 83.0, 84.0, 83.0, 98.0, 82.0, 82.0, 100.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 148.0, 146.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0, 58.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 56.0, 54.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 81.0, 82.0, 81.0, 79.0, 82.0, 79.0, 105.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 125.0, 135.0, 119.0, 118.0, 120.0, 119.0, 139.0, 126.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 174.0, 158.0, 155.0, 163.0, 159.0, 162.0, 163.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 58.0, 58.0], "value": 59.5, "unit": "score"}]}]} 01:52:50 INFO - Return code: 0 01:52:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:52:51 ERROR - # TBPL SUCCESS # 01:52:51 INFO - Running post-action listener: _resource_record_post_action 01:52:51 INFO - [mozharness: 2017-05-08 08:52:51.030168Z] Finished run-tests step (success) 01:52:51 INFO - Running post-run listener: _resource_record_post_run 01:52:51 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 270336; Write bytes: 364367872; Read time: 40; Write time: 185580 01:52:51 INFO - TinderboxPrint: CPU usage
13.1% 01:52:51 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 40 01:52:51 INFO - TinderboxPrint: I/O write bytes / time
364,367,872 / 185,580 01:52:51 INFO - TinderboxPrint: CPU idle
8,269.2 (86.8%) 01:52:51 INFO - TinderboxPrint: CPU user
1,203.7 (12.6%) 01:52:51 INFO - TinderboxPrint: Swap in / out
0 / 0 01:52:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110227456; Read time: 0; Write time: 76588 01:52:51 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 270336; Write bytes: 254140416; Read time: 40; Write time: 108992 01:52:51 INFO - Running post-run listener: _upload_blobber_files 01:52:51 INFO - Blob upload gear active. 01:52:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:52:51 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 01:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:52:52 INFO - (blobuploader) - INFO - Open directory for files ... 01:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:52 INFO - (blobuploader) - INFO - Done attempting. 01:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:56 INFO - (blobuploader) - INFO - Done attempting. 01:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:52:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:57 INFO - (blobuploader) - INFO - Done attempting. 01:52:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:52:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:52:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:58 INFO - (blobuploader) - INFO - Done attempting. 01:52:58 INFO - (blobuploader) - INFO - Iteration through files over. 01:52:58 INFO - Return code: 0 01:52:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:52:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:52:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/afbace65d6e00214a52057d7c73bc55bce86bb95ceac6fa76ff7f2af287e9bbeebf0c33fa7d4665fd05e6df560eb2563ba84f2c302f171cf3590e8ec63de2d84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/541cb2c03dcdf81d5868fe6143f65e5223dcc0707c37016a53f36ddb5563db636b552afab8808d606fa80d91ad685164e1d8be6d715ff30e858108b57cf0fc96", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3eecf0649948a412d7c5cd50b6e4c8bb4848fbde8b7082cd230403e0d771aa633e6246366c1dab4d2fc3934edae393308625a02fcca58b2741935fb56d0aa3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3073198d39df86eb91b508985d9bdd5b47fafa93168ca1ecb79548406e551f7dd4d3d6d85fbf971fa7aac476db9900bce97b45e90e8c1814d4190f3440354e3a"} 01:52:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:52:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:52:58 INFO - Contents: 01:52:58 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/afbace65d6e00214a52057d7c73bc55bce86bb95ceac6fa76ff7f2af287e9bbeebf0c33fa7d4665fd05e6df560eb2563ba84f2c302f171cf3590e8ec63de2d84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/541cb2c03dcdf81d5868fe6143f65e5223dcc0707c37016a53f36ddb5563db636b552afab8808d606fa80d91ad685164e1d8be6d715ff30e858108b57cf0fc96", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3eecf0649948a412d7c5cd50b6e4c8bb4848fbde8b7082cd230403e0d771aa633e6246366c1dab4d2fc3934edae393308625a02fcca58b2741935fb56d0aa3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3073198d39df86eb91b508985d9bdd5b47fafa93168ca1ecb79548406e551f7dd4d3d6d85fbf971fa7aac476db9900bce97b45e90e8c1814d4190f3440354e3a"} 01:52:58 INFO - Running post-run listener: copy_logs_to_upload_dir 01:52:58 INFO - Copying logs to upload dir... 01:52:58 INFO - mkdir: /builds/slave/test/build/upload/logs 01:52:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.036571 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-05-08 01:52:57.059112) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 01:52:57.063634) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/afbace65d6e00214a52057d7c73bc55bce86bb95ceac6fa76ff7f2af287e9bbeebf0c33fa7d4665fd05e6df560eb2563ba84f2c302f171cf3590e8ec63de2d84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/541cb2c03dcdf81d5868fe6143f65e5223dcc0707c37016a53f36ddb5563db636b552afab8808d606fa80d91ad685164e1d8be6d715ff30e858108b57cf0fc96", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3eecf0649948a412d7c5cd50b6e4c8bb4848fbde8b7082cd230403e0d771aa633e6246366c1dab4d2fc3934edae393308625a02fcca58b2741935fb56d0aa3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3073198d39df86eb91b508985d9bdd5b47fafa93168ca1ecb79548406e551f7dd4d3d6d85fbf971fa7aac476db9900bce97b45e90e8c1814d4190f3440354e3a"} build_url:https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/LX26AeTfTpiDB4KsEKvVAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/afbace65d6e00214a52057d7c73bc55bce86bb95ceac6fa76ff7f2af287e9bbeebf0c33fa7d4665fd05e6df560eb2563ba84f2c302f171cf3590e8ec63de2d84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/541cb2c03dcdf81d5868fe6143f65e5223dcc0707c37016a53f36ddb5563db636b552afab8808d606fa80d91ad685164e1d8be6d715ff30e858108b57cf0fc96", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3eecf0649948a412d7c5cd50b6e4c8bb4848fbde8b7082cd230403e0d771aa633e6246366c1dab4d2fc3934edae393308625a02fcca58b2741935fb56d0aa3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3073198d39df86eb91b508985d9bdd5b47fafa93168ca1ecb79548406e551f7dd4d3d6d85fbf971fa7aac476db9900bce97b45e90e8c1814d4190f3440354e3a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 01:52:57.096506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 01:52:57.096932) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1494226298.966638-1039069848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 01:52:57.146865) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 01:52:57.150229) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 01:52:57.150566) ========= ========= Total master_lag: 0.30 =========