builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-087 starttime: 1494146422.49 results: success (0) revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.490131) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.490597) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.490875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.541069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.541394) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-07 01:40:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 74.4M=0s 2017-05-07 01:40:22 (74.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168338 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.769211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.769530) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017055 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.819433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:22.819778) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-07 01:40:22,955 truncating revision to first 12 chars 2017-05-07 01:40:22,955 Setting DEBUG logging. 2017-05-07 01:40:22,955 attempt 1/10 2017-05-07 01:40:22,955 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-07 01:40:23,350 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:23.557848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:23.558130) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:23.558537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:23.558857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 01:40:23.568732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-05-07 01:40:23.569090) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:40:23 INFO - MultiFileLogger online at 20170507 01:40:23 in /builds/slave/test 01:40:23 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:40:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:40:23 INFO - {'append_to_log': False, 01:40:23 INFO - 'base_work_dir': '/builds/slave/test', 01:40:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:40:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:40:23 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:40:23 INFO - 'buildbot_json_path': 'buildprops.json', 01:40:23 INFO - 'config_files': ('talos/linux_config.py',), 01:40:23 INFO - 'default_actions': ('clobber', 01:40:23 INFO - 'read-buildbot-config', 01:40:23 INFO - 'download-and-extract', 01:40:23 INFO - 'populate-webroot', 01:40:23 INFO - 'create-virtualenv', 01:40:23 INFO - 'install', 01:40:23 INFO - 'run-tests'), 01:40:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:40:23 INFO - 'download_minidump_stackwalk': True, 01:40:23 INFO - 'download_symbols': 'ondemand', 01:40:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:40:23 INFO - 'tooltool.py': '/tools/tooltool.py', 01:40:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:40:23 INFO - '/tools/misc-python/virtualenv.py')}, 01:40:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:40:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:40:23 INFO - 'gecko_profile': False, 01:40:23 INFO - 'gecko_profile_interval': 0, 01:40:23 INFO - 'installer_path': 'installer.exe', 01:40:23 INFO - 'log_level': 'info', 01:40:23 INFO - 'log_name': 'talos', 01:40:23 INFO - 'log_to_console': True, 01:40:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:40:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:40:23 INFO - 'opt_config_files': (), 01:40:23 INFO - 'pip_index': False, 01:40:23 INFO - 'suite': 'dromaeojs', 01:40:23 INFO - 'system_bits': '32', 01:40:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:40:23 INFO - 'title': 'talos-linux64-ix-087', 01:40:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:40:23 INFO - 'use_talos_json': True, 01:40:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:40:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:40:23 INFO - 'work_dir': 'build'} 01:40:23 INFO - [mozharness: 2017-05-07 08:40:23.921663Z] Running clobber step. 01:40:23 INFO - Running pre-action listener: _resource_record_pre_action 01:40:23 INFO - Running main action method: clobber 01:40:23 INFO - rmtree: /builds/slave/test/build 01:40:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:40:24 INFO - Running post-action listener: _resource_record_post_action 01:40:24 INFO - [mozharness: 2017-05-07 08:40:24.808214Z] Finished clobber step (success) 01:40:24 INFO - [mozharness: 2017-05-07 08:40:24.808314Z] Running read-buildbot-config step. 01:40:24 INFO - Running pre-action listener: _resource_record_pre_action 01:40:24 INFO - Running main action method: read_buildbot_config 01:40:24 INFO - Using buildbot properties: 01:40:24 INFO - { 01:40:24 INFO - "project": "", 01:40:24 INFO - "product": "firefox", 01:40:24 INFO - "who": "nobody@mozilla.org", 01:40:24 INFO - "installer_path": "public/build/target.tar.bz2", 01:40:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:40:24 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:40:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:40:24 INFO - "stage_platform": "linux64", 01:40:24 INFO - "basedir": "/builds/slave/test", 01:40:24 INFO - "buildnumber": 2, 01:40:24 INFO - "platform": "ubuntu64_hw", 01:40:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:40:24 INFO - "slavebuilddir": "test", 01:40:24 INFO - "taskId": "KfGMNWmGTmOi_e91UWyDDw", 01:40:24 INFO - "branch": "mozilla-aurora", 01:40:24 INFO - "script_repo_revision": "production", 01:40:24 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 01:40:24 INFO - "slavename": "talos-linux64-ix-087", 01:40:24 INFO - "repo_path": "releases/mozilla-aurora" 01:40:24 INFO - } 01:40:24 INFO - Finding installer, test and symbols from parent task. 01:40:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KfGMNWmGTmOi_e91UWyDDw'}, attempt #1 01:40:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KfGMNWmGTmOi_e91UWyDDw'}, attempt #1 01:40:25 INFO - Task dependencies: UdlQ-uUqQfeZLQTefxU-Qg 01:40:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg'}, attempt #1 01:40:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.tar.bz2 01:40:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/test_packages.json 01:40:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.crashreporter-symbols.zip 01:40:26 INFO - Running post-action listener: _resource_record_post_action 01:40:26 INFO - [mozharness: 2017-05-07 08:40:26.172953Z] Finished read-buildbot-config step (success) 01:40:26 INFO - [mozharness: 2017-05-07 08:40:26.173171Z] Running download-and-extract step. 01:40:26 INFO - Running pre-action listener: _resource_record_pre_action 01:40:26 INFO - Running main action method: download_and_extract 01:40:26 INFO - mkdir: /builds/slave/test/build/tests 01:40:26 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:40:26 INFO - trying https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.test_packages.json 01:40:26 INFO - Downloading https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:40:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:40:26 INFO - Downloaded 896 bytes. 01:40:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:40:26 INFO - Using the following test package requirements: 01:40:26 INFO - {u'common': [u'target.common.tests.zip'], 01:40:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:40:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:40:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:40:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:40:26 INFO - u'mozbase': [u'target.common.tests.zip'], 01:40:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:40:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:40:26 INFO - u'web-platform': [u'target.common.tests.zip', 01:40:26 INFO - u'target.web-platform.tests.zip'], 01:40:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:40:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:40:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.common.tests.zip 01:40:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:40:26 INFO - Fetch https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.common.tests.zip into memory 01:40:28 INFO - Expected file size: 59541726 01:40:28 INFO - Obtained file size: 59541726 01:40:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:40:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.common.tests.zip 01:40:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:40:38 INFO - Fetch https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.common.tests.zip into memory 01:40:39 INFO - Expected file size: 59541726 01:40:39 INFO - Obtained file size: 59541726 01:40:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.talos.tests.zip 01:40:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:40:50 INFO - Fetch https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.talos.tests.zip into memory 01:40:51 INFO - Expected file size: 14404424 01:40:51 INFO - Obtained file size: 14404424 01:40:52 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:40:52 INFO - trying https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.tar.bz2 01:40:52 INFO - Downloading https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:40:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:40:54 INFO - Downloaded 66790684 bytes. 01:40:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.tar.bz2 01:40:54 INFO - mkdir: /builds/slave/test/properties 01:40:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:40:54 INFO - Writing to file /builds/slave/test/properties/build_url 01:40:54 INFO - Contents: 01:40:54 INFO - build_url:https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.tar.bz2 01:40:54 INFO - Running post-action listener: _resource_record_post_action 01:40:54 INFO - Running post-action listener: set_extra_try_arguments 01:40:54 INFO - [mozharness: 2017-05-07 08:40:54.633184Z] Finished download-and-extract step (success) 01:40:54 INFO - [mozharness: 2017-05-07 08:40:54.633280Z] Running populate-webroot step. 01:40:54 INFO - Running pre-action listener: _resource_record_pre_action 01:40:54 INFO - Running main action method: populate_webroot 01:40:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:40:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:40:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:40:54 INFO - '--tppagecycles', 01:40:54 INFO - '7'], 01:40:54 INFO - 'tests': ['tsvgm']}}, 01:40:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:40:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:40:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:40:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:40:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['damp', 'tps']}, 01:40:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'tests': ['damp', 'tps']}, 01:40:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['dromaeo_dom']}, 01:40:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:40:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['basic_compositor_video']}, 01:40:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:40:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other-e10s': {'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['tsvgx', 01:40:54 INFO - 'tsvgr_opacity', 01:40:54 INFO - 'tart', 01:40:54 INFO - 'tscrollx', 01:40:54 INFO - 'cart', 01:40:54 INFO - 'tsvg_static']}, 01:40:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:40:54 INFO - 'tsvgr_opacity', 01:40:54 INFO - 'tart', 01:40:54 INFO - 'tscrollx', 01:40:54 INFO - 'cart', 01:40:54 INFO - 'tsvg_static']}, 01:40:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['tp5o']}, 01:40:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:40:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--disable-e10s', 01:40:54 INFO - '--xperf_path', 01:40:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:54 INFO - 'tests': ['tp5n']}, 01:40:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--xperf_path', 01:40:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:54 INFO - 'tests': ['tp5n']}}, 01:40:54 INFO - 'talos.zip': {'path': '', 01:40:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:40:54 INFO - Running post-action listener: _resource_record_post_action 01:40:54 INFO - [mozharness: 2017-05-07 08:40:54.646436Z] Finished populate-webroot step (success) 01:40:54 INFO - [mozharness: 2017-05-07 08:40:54.646526Z] Running create-virtualenv step. 01:40:54 INFO - Running pre-action listener: _resource_record_pre_action 01:40:54 INFO - Running main action method: create_virtualenv 01:40:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:40:54 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:40:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:40:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:40:54 INFO - Using real prefix '/usr' 01:40:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:40:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:40:57 INFO - Installing pip.................done. 01:40:57 INFO - Return code: 0 01:40:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:40:57 INFO - Reading from file tmpfile_stdout 01:40:57 INFO - Output received: 01:40:57 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:40:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:57 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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:40:57 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:40:57 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:40:57 INFO - Using env: {'DISPLAY': ':0', 01:40:57 INFO - 'HOME': '/home/cltbld', 01:40:57 INFO - 'LANG': 'en_US.UTF-8', 01:40:57 INFO - 'LANGUAGE': 'en_US:en', 01:40:57 INFO - 'LOGNAME': 'cltbld', 01:40:57 INFO - 'MAIL': '/var/mail/cltbld', 01:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:57 INFO - 'MOZ_NO_REMOTE': '1', 01:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:57 INFO - 'NO_EM_RESTART': '1', 01:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:57 INFO - 'PWD': '/builds/slave/test', 01:40:57 INFO - 'SHELL': '/bin/bash', 01:40:57 INFO - 'SHLVL': '1', 01:40:57 INFO - 'TERM': 'linux', 01:40:57 INFO - 'TMOUT': '86400', 01:40:57 INFO - 'USER': 'cltbld', 01:40:57 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:57 INFO - '_': '/tools/buildbot/bin/python'} 01:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:57 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:40:57 INFO - Cleaning up... 01:40:57 INFO - Return code: 0 01:40:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:57 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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:40:57 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:40:57 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:40:57 INFO - Using env: {'DISPLAY': ':0', 01:40:57 INFO - 'HOME': '/home/cltbld', 01:40:57 INFO - 'LANG': 'en_US.UTF-8', 01:40:57 INFO - 'LANGUAGE': 'en_US:en', 01:40:57 INFO - 'LOGNAME': 'cltbld', 01:40:57 INFO - 'MAIL': '/var/mail/cltbld', 01:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:57 INFO - 'MOZ_NO_REMOTE': '1', 01:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:57 INFO - 'NO_EM_RESTART': '1', 01:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:57 INFO - 'PWD': '/builds/slave/test', 01:40:57 INFO - 'SHELL': '/bin/bash', 01:40:57 INFO - 'SHLVL': '1', 01:40:57 INFO - 'TERM': 'linux', 01:40:57 INFO - 'TMOUT': '86400', 01:40:57 INFO - 'USER': 'cltbld', 01:40:57 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:57 INFO - '_': '/tools/buildbot/bin/python'} 01:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:58 INFO - Downloading/unpacking psutil>=3.1.1 01:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:40:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:59 INFO - Installing collected packages: psutil 01:40:59 INFO - Running setup.py install for psutil 01:40:59 INFO - building 'psutil._psutil_linux' extension 01:40:59 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:41:00 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:41:00 INFO - building 'psutil._psutil_posix' extension 01:41:00 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:41:00 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:41:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:41:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:41:00 INFO - Successfully installed psutil 01:41:00 INFO - Cleaning up... 01:41:00 INFO - Return code: 0 01:41:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:00 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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:41:00 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:41:00 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:41:00 INFO - Using env: {'DISPLAY': ':0', 01:41:00 INFO - 'HOME': '/home/cltbld', 01:41:00 INFO - 'LANG': 'en_US.UTF-8', 01:41:00 INFO - 'LANGUAGE': 'en_US:en', 01:41:00 INFO - 'LOGNAME': 'cltbld', 01:41:00 INFO - 'MAIL': '/var/mail/cltbld', 01:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:00 INFO - 'MOZ_NO_REMOTE': '1', 01:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:00 INFO - 'NO_EM_RESTART': '1', 01:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:00 INFO - 'PWD': '/builds/slave/test', 01:41:00 INFO - 'SHELL': '/bin/bash', 01:41:00 INFO - 'SHLVL': '1', 01:41:00 INFO - 'TERM': 'linux', 01:41:00 INFO - 'TMOUT': '86400', 01:41:00 INFO - 'USER': 'cltbld', 01:41:00 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:00 INFO - '_': '/tools/buildbot/bin/python'} 01:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:41:02 INFO - Installing collected packages: mozsystemmonitor 01:41:02 INFO - Running setup.py install for mozsystemmonitor 01:41:02 INFO - Successfully installed mozsystemmonitor 01:41:02 INFO - Cleaning up... 01:41:02 INFO - Return code: 0 01:41:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:41:02 INFO - Using env: {'DISPLAY': ':0', 01:41:02 INFO - 'HOME': '/home/cltbld', 01:41:02 INFO - 'LANG': 'en_US.UTF-8', 01:41:02 INFO - 'LANGUAGE': 'en_US:en', 01:41:02 INFO - 'LOGNAME': 'cltbld', 01:41:02 INFO - 'MAIL': '/var/mail/cltbld', 01:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:02 INFO - 'MOZ_NO_REMOTE': '1', 01:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:02 INFO - 'NO_EM_RESTART': '1', 01:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:02 INFO - 'PWD': '/builds/slave/test', 01:41:02 INFO - 'SHELL': '/bin/bash', 01:41:02 INFO - 'SHLVL': '1', 01:41:02 INFO - 'TERM': 'linux', 01:41:02 INFO - 'TMOUT': '86400', 01:41:02 INFO - 'USER': 'cltbld', 01:41:02 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:02 INFO - '_': '/tools/buildbot/bin/python'} 01:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:02 INFO - Downloading/unpacking jsonschema==2.5.1 01:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:41:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:03 INFO - Downloading functools32-3.2.3-2.tar.gz 01:41:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:41:03 INFO - warning: no files found matching '*.txt' 01:41:03 INFO - no previously-included directories found matching 'build' 01:41:03 INFO - no previously-included directories found matching 'dist' 01:41:03 INFO - no previously-included directories found matching '.git*' 01:41:03 INFO - Installing collected packages: jsonschema, functools32 01:41:03 INFO - Running setup.py install for functools32 01:41:03 INFO - warning: no files found matching '*.txt' 01:41:03 INFO - no previously-included directories found matching 'build' 01:41:03 INFO - no previously-included directories found matching 'dist' 01:41:03 INFO - no previously-included directories found matching '.git*' 01:41:03 INFO - Successfully installed jsonschema functools32 01:41:03 INFO - Cleaning up... 01:41:03 INFO - Return code: 0 01:41:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:41:03 INFO - Using env: {'DISPLAY': ':0', 01:41:03 INFO - 'HOME': '/home/cltbld', 01:41:03 INFO - 'LANG': 'en_US.UTF-8', 01:41:03 INFO - 'LANGUAGE': 'en_US:en', 01:41:03 INFO - 'LOGNAME': 'cltbld', 01:41:03 INFO - 'MAIL': '/var/mail/cltbld', 01:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:03 INFO - 'MOZ_NO_REMOTE': '1', 01:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:03 INFO - 'NO_EM_RESTART': '1', 01:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:03 INFO - 'PWD': '/builds/slave/test', 01:41:03 INFO - 'SHELL': '/bin/bash', 01:41:03 INFO - 'SHLVL': '1', 01:41:03 INFO - 'TERM': 'linux', 01:41:03 INFO - 'TMOUT': '86400', 01:41:03 INFO - 'USER': 'cltbld', 01:41:03 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:03 INFO - '_': '/tools/buildbot/bin/python'} 01:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:41:04 INFO - Cleaning up... 01:41:04 INFO - Return code: 0 01:41:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:41:04 INFO - Using env: {'DISPLAY': ':0', 01:41:04 INFO - 'HOME': '/home/cltbld', 01:41:04 INFO - 'LANG': 'en_US.UTF-8', 01:41:04 INFO - 'LANGUAGE': 'en_US:en', 01:41:04 INFO - 'LOGNAME': 'cltbld', 01:41:04 INFO - 'MAIL': '/var/mail/cltbld', 01:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:04 INFO - 'MOZ_NO_REMOTE': '1', 01:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:04 INFO - 'NO_EM_RESTART': '1', 01:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:04 INFO - 'PWD': '/builds/slave/test', 01:41:04 INFO - 'SHELL': '/bin/bash', 01:41:04 INFO - 'SHLVL': '1', 01:41:04 INFO - 'TERM': 'linux', 01:41:04 INFO - 'TMOUT': '86400', 01:41:04 INFO - 'USER': 'cltbld', 01:41:04 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:04 INFO - '_': '/tools/buildbot/bin/python'} 01:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:04 INFO - Downloading/unpacking blobuploader==1.2.4 01:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:05 INFO - Downloading blobuploader-1.2.4.tar.gz 01:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:41:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:41:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 INFO - Downloading docopt-0.6.1.tar.gz 01:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:41:05 INFO - Installing collected packages: blobuploader, requests, docopt 01:41:05 INFO - Running setup.py install for blobuploader 01:41:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:41:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:41:06 INFO - Running setup.py install for requests 01:41:06 INFO - Running setup.py install for docopt 01:41:06 INFO - Successfully installed blobuploader requests docopt 01:41:06 INFO - Cleaning up... 01:41:06 INFO - Return code: 0 01:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:06 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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:41:06 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:41:06 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:41:06 INFO - Using env: {'DISPLAY': ':0', 01:41:06 INFO - 'HOME': '/home/cltbld', 01:41:06 INFO - 'LANG': 'en_US.UTF-8', 01:41:06 INFO - 'LANGUAGE': 'en_US:en', 01:41:06 INFO - 'LOGNAME': 'cltbld', 01:41:06 INFO - 'MAIL': '/var/mail/cltbld', 01:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:06 INFO - 'MOZ_NO_REMOTE': '1', 01:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:06 INFO - 'NO_EM_RESTART': '1', 01:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:06 INFO - 'PWD': '/builds/slave/test', 01:41:06 INFO - 'SHELL': '/bin/bash', 01:41:06 INFO - 'SHLVL': '1', 01:41:06 INFO - 'TERM': 'linux', 01:41:06 INFO - 'TMOUT': '86400', 01:41:06 INFO - 'USER': 'cltbld', 01:41:06 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:06 INFO - '_': '/tools/buildbot/bin/python'} 01:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:06 INFO - Running setup.py (path:/tmp/pip-8tzYhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:06 INFO - Running setup.py (path:/tmp/pip-pCFNLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:06 INFO - Running setup.py (path:/tmp/pip-bGgWPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:06 INFO - Running setup.py (path:/tmp/pip-veqEsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:07 INFO - Running setup.py (path:/tmp/pip-KgxvYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:07 INFO - Running setup.py (path:/tmp/pip-DokDzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:07 INFO - Running setup.py (path:/tmp/pip-2qWtrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:07 INFO - Running setup.py (path:/tmp/pip-Hm3Iiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:07 INFO - Running setup.py (path:/tmp/pip-AIgJ2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:07 INFO - Running setup.py (path:/tmp/pip-KiqPDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:07 INFO - Running setup.py (path:/tmp/pip-JtfoI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:07 INFO - Running setup.py (path:/tmp/pip-ToHIPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:07 INFO - Running setup.py (path:/tmp/pip-iZNiHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:07 INFO - Running setup.py (path:/tmp/pip-rKelr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:07 INFO - Running setup.py (path:/tmp/pip-E4g5yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:07 INFO - Running setup.py (path:/tmp/pip-Vv_Rfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:07 INFO - Running setup.py (path:/tmp/pip-BuoeyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:41:07 INFO - Running setup.py install for manifestparser 01:41:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Running setup.py install for mozcrash 01:41:08 INFO - Running setup.py install for mozdebug 01:41:08 INFO - Running setup.py install for mozdevice 01:41:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Running setup.py install for mozfile 01:41:08 INFO - Running setup.py install for mozhttpd 01:41:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Running setup.py install for mozinfo 01:41:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Running setup.py install for mozInstall 01:41:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Running setup.py install for mozleak 01:41:08 INFO - Running setup.py install for mozlog 01:41:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:41:08 INFO - Running setup.py install for moznetwork 01:41:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:41:09 INFO - Running setup.py install for mozprocess 01:41:09 INFO - Running setup.py install for mozprofile 01:41:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:41:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:41:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:41:09 INFO - Running setup.py install for mozrunner 01:41:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:41:09 INFO - Running setup.py install for mozscreenshot 01:41:09 INFO - Running setup.py install for moztest 01:41:09 INFO - Running setup.py install for mozversion 01:41:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:41:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:41:09 INFO - Cleaning up... 01:41:09 INFO - Return code: 0 01:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:09 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:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:09 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:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:09 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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:41:09 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:41:09 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:41:09 INFO - Using env: {'DISPLAY': ':0', 01:41:09 INFO - 'HOME': '/home/cltbld', 01:41:09 INFO - 'LANG': 'en_US.UTF-8', 01:41:09 INFO - 'LANGUAGE': 'en_US:en', 01:41:09 INFO - 'LOGNAME': 'cltbld', 01:41:09 INFO - 'MAIL': '/var/mail/cltbld', 01:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:09 INFO - 'MOZ_NO_REMOTE': '1', 01:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:09 INFO - 'NO_EM_RESTART': '1', 01:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:09 INFO - 'PWD': '/builds/slave/test', 01:41:09 INFO - 'SHELL': '/bin/bash', 01:41:09 INFO - 'SHLVL': '1', 01:41:09 INFO - 'TERM': 'linux', 01:41:09 INFO - 'TMOUT': '86400', 01:41:09 INFO - 'USER': 'cltbld', 01:41:09 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:09 INFO - '_': '/tools/buildbot/bin/python'} 01:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:09 INFO - Running setup.py (path:/tmp/pip-1kmlFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:10 INFO - Running setup.py (path:/tmp/pip-IsM5JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:10 INFO - Running setup.py (path:/tmp/pip-d3cArB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:10 INFO - Running setup.py (path:/tmp/pip-vd1lhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:10 INFO - Running setup.py (path:/tmp/pip-q4iUOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:10 INFO - Running setup.py (path:/tmp/pip-SEa2MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:10 INFO - Running setup.py (path:/tmp/pip-Xq8jHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:10 INFO - Running setup.py (path:/tmp/pip-_orokB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:10 INFO - Running setup.py (path:/tmp/pip-wiSGTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:10 INFO - Running setup.py (path:/tmp/pip-Wh0dor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:10 INFO - Running setup.py (path:/tmp/pip-BPJhKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:10 INFO - Running setup.py (path:/tmp/pip-t9Gx8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:10 INFO - Running setup.py (path:/tmp/pip-U_BKgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:10 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:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:10 INFO - Running setup.py (path:/tmp/pip-IoLW5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:11 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:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:11 INFO - Running setup.py (path:/tmp/pip-oZ9uY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:11 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:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:11 INFO - Running setup.py (path:/tmp/pip-5QRQyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:11 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:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:11 INFO - Running setup.py (path:/tmp/pip-UzaUH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:11 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:41:11 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:41:11 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:41:11 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:41:11 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:41:11 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:41:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:12 INFO - Downloading blessings-1.6.tar.gz 01:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:41:12 INFO - Installing collected packages: blessings 01:41:12 INFO - Running setup.py install for blessings 01:41:12 INFO - Successfully installed blessings 01:41:12 INFO - Cleaning up... 01:41:12 INFO - Return code: 0 01:41:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:12 INFO - Reading from file tmpfile_stdout 01:41:12 INFO - Current package versions: 01:41:12 INFO - argparse == 1.2.1 01:41:12 INFO - blessings == 1.6 01:41:12 INFO - blobuploader == 1.2.4 01:41:12 INFO - docopt == 0.6.1 01:41:12 INFO - functools32 == 3.2.3-2 01:41:12 INFO - jsonschema == 2.5.1 01:41:12 INFO - manifestparser == 1.1 01:41:12 INFO - mozInstall == 1.12 01:41:12 INFO - mozcrash == 1.0 01:41:12 INFO - mozdebug == 0.1 01:41:12 INFO - mozdevice == 0.49 01:41:12 INFO - mozfile == 1.2 01:41:12 INFO - mozhttpd == 0.7 01:41:12 INFO - mozinfo == 0.9 01:41:12 INFO - mozleak == 0.1 01:41:12 INFO - mozlog == 3.4 01:41:12 INFO - moznetwork == 0.27 01:41:12 INFO - mozprocess == 0.25 01:41:12 INFO - mozprofile == 0.28 01:41:12 INFO - mozrunner == 6.13 01:41:12 INFO - mozscreenshot == 0.1 01:41:12 INFO - mozsystemmonitor == 0.3 01:41:12 INFO - moztest == 0.8 01:41:12 INFO - mozversion == 1.4 01:41:12 INFO - psutil == 3.1.1 01:41:12 INFO - requests == 1.2.3 01:41:12 INFO - wsgiref == 0.1.2 01:41:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:12 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 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:41:12 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:41:12 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:41:12 INFO - Using env: {'DISPLAY': ':0', 01:41:12 INFO - 'HOME': '/home/cltbld', 01:41:12 INFO - 'LANG': 'en_US.UTF-8', 01:41:12 INFO - 'LANGUAGE': 'en_US:en', 01:41:12 INFO - 'LOGNAME': 'cltbld', 01:41:12 INFO - 'MAIL': '/var/mail/cltbld', 01:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:12 INFO - 'MOZ_NO_REMOTE': '1', 01:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:12 INFO - 'NO_EM_RESTART': '1', 01:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:12 INFO - 'PWD': '/builds/slave/test', 01:41:12 INFO - 'SHELL': '/bin/bash', 01:41:12 INFO - 'SHLVL': '1', 01:41:12 INFO - 'TERM': 'linux', 01:41:12 INFO - 'TMOUT': '86400', 01:41:12 INFO - 'USER': 'cltbld', 01:41:12 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:12 INFO - '_': '/tools/buildbot/bin/python'} 01:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:13 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:41:13 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:41:13 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:41:13 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:41:13 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:41:13 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:41:13 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:41:13 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:41:13 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:41:13 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:41:13 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:41:13 INFO - Cleaning up... 01:41:13 INFO - Return code: 0 01:41:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:41: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:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', '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:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:41:13 INFO - Using env: {'DISPLAY': ':0', 01:41:13 INFO - 'HOME': '/home/cltbld', 01:41:13 INFO - 'LANG': 'en_US.UTF-8', 01:41:13 INFO - 'LANGUAGE': 'en_US:en', 01:41:13 INFO - 'LOGNAME': 'cltbld', 01:41:13 INFO - 'MAIL': '/var/mail/cltbld', 01:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:13 INFO - 'MOZ_NO_REMOTE': '1', 01:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:13 INFO - 'NO_EM_RESTART': '1', 01:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:13 INFO - 'PWD': '/builds/slave/test', 01:41:13 INFO - 'SHELL': '/bin/bash', 01:41:13 INFO - 'SHLVL': '1', 01:41:13 INFO - 'TERM': 'linux', 01:41:13 INFO - 'TMOUT': '86400', 01:41:13 INFO - 'USER': 'cltbld', 01:41:13 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:13 INFO - '_': '/tools/buildbot/bin/python'} 01:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:41:13 INFO - Cleaning up... 01:41:13 INFO - Return code: 0 01:41:13 INFO - Running post-action listener: _resource_record_post_action 01:41:13 INFO - Running post-action listener: _start_resource_monitoring 01:41:13 INFO - Starting resource monitoring. 01:41:13 INFO - [mozharness: 2017-05-07 08:41:13.293751Z] Finished create-virtualenv step (success) 01:41:13 INFO - [mozharness: 2017-05-07 08:41:13.294720Z] Running install step. 01:41:13 INFO - Running pre-action listener: _resource_record_pre_action 01:41:13 INFO - Running main action method: install 01:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:13 INFO - Reading from file tmpfile_stdout 01:41:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:41:13 INFO - Reading from file tmpfile_stdout 01:41:13 INFO - Output received: 01:41:13 INFO - Usage: mozinstall [options] installer 01:41:13 INFO - Options: 01:41:13 INFO - -h, --help show this help message and exit 01:41:13 INFO - -d DEST, --destination=DEST 01:41:13 INFO - Directory to install application into. [default: 01:41:13 INFO - "/builds/slave/test"] 01:41:13 INFO - --app=APP Application being installed. [default: firefox] 01:41:13 INFO - mkdir: /builds/slave/test/build/application 01:41:13 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:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:41:30 INFO - Reading from file tmpfile_stdout 01:41:30 INFO - Output received: 01:41:30 INFO - /builds/slave/test/build/application/firefox/firefox 01:41:30 INFO - Running post-action listener: _resource_record_post_action 01:41:30 INFO - [mozharness: 2017-05-07 08:41:30.145231Z] Finished install step (success) 01:41:30 INFO - [mozharness: 2017-05-07 08:41:30.145504Z] Running run-tests step. 01:41:30 INFO - Running pre-action listener: _resource_record_pre_action 01:41:30 INFO - Running main action method: run_tests 01:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:41:30 INFO - Python 2.7.3 01:41:30 INFO - Return code: 0 01:41:30 INFO - grabbing minidump binary from tooltool 01:41:30 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:41:30 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 0x26d1400>, '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 0x26d23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:41:30 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:41:30 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:41:30 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:41:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:41:30 INFO - Return code: 0 01:41:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:41:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:41:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:41:30 INFO - ENV: RUST_BACKTRACE is now 1 01:41:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:41:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:41:30 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/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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:41:30 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/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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:41:30 INFO - Using env: {'DISPLAY': ':0', 01:41:30 INFO - 'HOME': '/home/cltbld', 01:41:30 INFO - 'LANG': 'en_US.UTF-8', 01:41:30 INFO - 'LANGUAGE': 'en_US:en', 01:41:30 INFO - 'LOGNAME': 'cltbld', 01:41:30 INFO - 'MAIL': '/var/mail/cltbld', 01:41:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:41:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:30 INFO - 'MOZ_NO_REMOTE': '1', 01:41:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:30 INFO - 'NO_EM_RESTART': '1', 01:41:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:30 INFO - 'PWD': '/builds/slave/test', 01:41:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:41:30 INFO - 'RUST_BACKTRACE': '1', 01:41:30 INFO - 'SHELL': '/bin/bash', 01:41:30 INFO - 'SHLVL': '1', 01:41:30 INFO - 'TERM': 'linux', 01:41:30 INFO - 'TMOUT': '86400', 01:41:30 INFO - 'USER': 'cltbld', 01:41:30 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641', 01:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:30 INFO - '_': '/tools/buildbot/bin/python'} 01:41:30 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/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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:41:30 INFO - mozversion application_buildid: 20170507074728 01:41:30 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:41:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:41:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:41:30 INFO - mozversion application_name: Firefox 01:41:30 INFO - mozversion application_remotingname: firefox-dev 01:41:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:41:30 INFO - mozversion application_vendor: Mozilla 01:41:30 INFO - mozversion application_version: 54.0a2 01:41:30 INFO - mozversion platform_buildid: 20170507074728 01:41:30 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:41:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:41:30 INFO - mozversion platform_version: 54.0a2 01:41:30 INFO - using testdate: 1494146490 01:41:30 INFO - actual date: 1494146490 01:41:30 INFO - starting webserver on 'localhost:47369' 01:41:30 INFO - SUITE-START | Running 2 tests 01:41:30 INFO - TEST-START | dromaeo_css 01:41:30 INFO - operating with platform_type : linux_ 01:41:30 INFO - Initialising browser for dromaeo_css test... 01:41:30 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTk4BB/profile http://localhost:47369/getInfo.html) 01:41:35 INFO - PROCESS | 3333 | __metrics Screen width/height:1600/1200 01:41:35 INFO - PROCESS | 3333 | colorDepth:24 01:41:35 INFO - PROCESS | 3333 | Browser inner width/height: 1024/697 01:41:35 INFO - PROCESS | 3333 | __metrics 01:41:36 INFO - PROCESS | 3333 | 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:41:36 INFO - PROCESS | 3333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:41:37 INFO - TEST-INFO | 3333: exit 0 01:41:37 INFO - Browser initialized. 01:41:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:41:37 INFO - TEST-INFO | started process 3424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTk4BB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:49 INFO - PROCESS | 3424 | RSS: Main: 140021760 01:41:49 INFO - PROCESS | 3424 | 01:44:50 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:47369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47369/tests/dromaeo/cssquery-ext.html) 01:44:52 INFO - PROCESS | 3424 | RSS: Main: 282353664 01:44:52 INFO - PROCESS | 3424 | 01:46:38 INFO - PROCESS | 3424 | ************************* 01:46:38 INFO - PROCESS | 3424 | A coding exception was thrown and uncaught in a Task. 01:46:38 INFO - PROCESS | 3424 | 01:46:38 ERROR - PROCESS | 3424 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:38 INFO - PROCESS | 3424 | Full stack: 01:46:38 INFO - PROCESS | 3424 | ************************* 01:46:38 INFO - PROCESS | 3424 | ************************* 01:46:38 INFO - PROCESS | 3424 | A coding exception was thrown and uncaught in a Task. 01:46:38 INFO - PROCESS | 3424 | 01:46:38 ERROR - PROCESS | 3424 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:38 INFO - PROCESS | 3424 | Full stack: 01:46:38 INFO - PROCESS | 3424 | ************************* 01:46:38 INFO - PROCESS | 3424 | ************************* 01:46:38 INFO - PROCESS | 3424 | A coding exception was thrown and uncaught in a Task. 01:46:38 INFO - PROCESS | 3424 | 01:46:38 ERROR - PROCESS | 3424 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:38 INFO - PROCESS | 3424 | Full stack: 01:46:38 INFO - PROCESS | 3424 | ************************* 01:46:38 INFO - PROCESS | 3424 | ************************* 01:46:38 INFO - PROCESS | 3424 | A coding exception was thrown and uncaught in a Task. 01:46:38 INFO - PROCESS | 3424 | 01:46:38 ERROR - PROCESS | 3424 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:38 INFO - PROCESS | 3424 | Full stack: 01:46:38 INFO - PROCESS | 3424 | ************************* 01:47:54 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:47369/tests/dromaeo/cssquery-ext.html (next: http://localhost:47369/tests/dromaeo/cssquery-jquery.html) 01:47:55 INFO - PROCESS | 3424 | RSS: Main: 223350784 01:47:55 INFO - PROCESS | 3424 | 01:50:56 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:47369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47369/tests/dromaeo/cssquery-mootools.html) 01:50:57 INFO - PROCESS | 3424 | RSS: Main: 202366976 01:50:57 INFO - PROCESS | 3424 | 01:53:59 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:47369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47369/tests/dromaeo/cssquery-prototype.html) 01:54:00 INFO - PROCESS | 3424 | RSS: Main: 169758720 01:54:00 INFO - PROCESS | 3424 | 01:57:02 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:47369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47369/tests/dromaeo/cssquery-yui.html) 01:57:03 INFO - PROCESS | 3424 | RSS: Main: 177410048 01:57:03 INFO - PROCESS | 3424 | 02:00:05 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:47369/tests/dromaeo/cssquery-yui.html (next: http://localhost:47369/tests/dromaeo/cssquery-dojo.html) 02:00:06 INFO - PROCESS | 3424 | RSS: Main: 269250560 02:00:06 INFO - PROCESS | 3424 | 02:00:06 INFO - PROCESS | 3424 | __start_tp_report 02:00:06 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 02:00:06 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 02:00:06 INFO - PROCESS | 3424 | |i|pagename|runs| 02:00:06 INFO - PROCESS | 3424 | |0;dojo.html;3450.4824276358545;3506.316268327674;3521.6478352164804;3524.788512689239;3546.680798728114;5882.9411705882985;5944.10838374243;5967.403259674031;5973.432523910233;5991.790287339944;5928.88142237155;5962.105684147369;5965.43328383804;5986.311574168972;6003;5284.894302113956;5308.389535203462;5332.413434522199;5335.866603334928;5374.946250537503;5159.690418574897;5164.457731938149;5391.056565101111;5403.054465468547;5408.972955135238;5277.577793776508;5321.095413779647;5377.838664840061;5385.78456861725;5400.972995135019;5385.353757549119;5386.73066346685;5387.730613469311;5388.568914486851;5393.99999999998;5066.316047333637;5078.61910356721;5222.190560463135;5321.600879934021;5360.169173778032;5810.535157187457;5821.53427725781;5857.092150716646;5893.557983151238;5924.851878703023;6274.87450250997;6357.777477788301;6365.936340636581;6367.07677386781;6372.267189273247;6103.694815259264;6428.678566071678;6434.871302573923;6455.967720161416;6456.418922297016;5765.682887441189;5903.557233207526;5937.584369094208;5940.108983652401;5946.970265148647;6470.191226096738;6492.253390860017;6529.673516324165;6535.738570457129;6541.967290163519;6277.52918531112;6310.1796766420075;6314.0528920661345;6315.842103947438;6320.936790632127;6065.787697430657;6106.72519736613;6224.875502489925;6244.2506899171485;6275.152854364694;6367.586106903036;6371.299157092716;6373.5857169283845;6374.235091789015;6374.394432528995;6113.424164191899;6113.694315284307;6141.324454310023;6159.692015399301;6388.073729309224;4708.387909571734;4801.447833499193;4803.135435621622;4825.420949486014;4827.300041493963;4170.186813571385;4173.478315210598;4211.178820130107;4237.512686041083;4266.4240327556;6130.979101201984;6138.235132557318;6149.569530132937;6153.600015998945;6159.969200153971;6442.452391546677;6458.321876203025;6470.417662410406;6472.579282346726;6476.935230647728;5849.970750146222;5872.559558033165;6167.691615419211;6181.196444462191;6181.443670069715;5312.5484333832055;5388.245645609618;5432.348118225838;5438.809641662523;5439.646422982493;6591.143151390289;6658.1344425224415;6670.132882725215;6688.732450702015;6688.799336019927;6333.429991300805;6435.099086127852;6462.612243265419;6464.09502669636;6467.676616169078;6353.809385718436;6396.616203027647;6546.705398257185;6575.736970521126;6621.867562648624;6340.587861789153;6347.492200623847;6352.301246862934;6354;6360.109584658244;6378.77674281398;6398.808035758934;6434.774782882577;6439.162908821823;6448.226212854487;6015.097735339734;6037.849053773691;6143.8326717923455;6176.505879529537;6275.937240627535;6178.752849886134;6196.597221180609;6197.194364732736;6206.224221972254;6208.1308616792785;5969;6164.4143806338325;6196.752129914933;6213.254409470893;6227.314995350598;6065.514758819372;6114.960456722457;6171.59884607499;6245.0632405139595;6300.432961033529;6145.938540614716;6164.137020817179;6178.907316390168;6185.195924529782;6187.690615469299 02:00:06 INFO - PROCESS | 3424 | |1;ext.html;729.3071581997101;805.9556724380159;811.0470197517915;870.2820173356982;879.810840669256;30621.08136755898;42944.35583466251;43363.78318108413;43412;43450.34824477635;43809.78095109528;44006;44021.55978440215;44082.55917440825;44111.338329925;7616.162222155586;7754.767356979271;8957.10428957104;9088.50013249271;9089.091090890925;10270.9486452568;10470.633527826527;10484.475776211197;10490.108340791043;10746;10570.207234457408;10581.682549523526;10618.309809862334;10619.734506637318;10625.256232063759;10469.685909422691;10498.685039448828;10500.78998420035;10510.632127875488;10515.211359148094;10005;10050.597976080948;10088.092071713581;10104.04011618895;10140.340877842991;39800.60199397998;40025.39961900574;40034.59965400338;40083.198336033405;40562.188756225005;4239.724417912857;4308.590683885026;4325.221460137174;4423.734575925422;4426.04839959407;28709.85645071782;29002.564961525593;29137.125886223446;29513.26216844596;30350;4171.165766846643;4245.61789438952;4264.445622069142;4288.592583704543;4369.4756629204385;233097;234052;235098;236079;236374;51437.7428112857;51873;51926.22110668343;51978;52010.73994630078;53853.461465385626;53922.730386347816;53943.730281349126;53945;53983.46016539863;15156;15434.459793907385;15488.22558872052;15505.922470387575;15521.84478155204;12454.875451245372;12507.312097834707;13402.195868247936;13430.328483575782;14045.227512486912;12584.937075314749;12587.559435419716;12640.367981600883;12699.492020319269;12748.745025099446;5374.623776335619;5515.586331025189;5541.972290138524;5547.502174412966;5581.748821303051;1020.7397113736098;1027.209049032241;1029.7065336379096;1030.3251370352432;1030.7062487191265;28495.28761780972;28531.429371412454;28681.856590716914;28883.71116288852;28932.42135157285;1092.5520536579963;1098.9450527473593;1101.9724506887233;1137.9089672826153;1190.2323001663879;14569.854301457062;16346.75479867803;16795.91602041982;16948.783001665055;17288.394906178222;301626;301763;302622;303194;303900;57038;57528.12359382014;57531;57540;57611.13583296254;1529.3653133949508;1553.9223038848013;1558.5090696430814;1560.485039936818;1584.4771225495558;29600.259993500335;30773.8461307692;30802.537961930142;30947.89924357736;31233;42753.5724642762;42805.14389712251;42832.57167428286;42844.143117138105;42890.35664465098;261944;262138;262340;262861;263393;28886;33960.66039339575;34505.48241776426;34738.305233895684;34924.65075349214;35270.8236458816;36648.63351366559;45137;48330.5166948326;48722.5127748718;33664.66335336615;34040.31919361649;34055.659443405246;34189.14527136742;34423.31153376868;33962.49056264207;34282.80010199631;34303.82848085744;34343.656563434044;34864.47703284503;39533;40162;40299.79850100848;40655.186896261315;40930.1813963725;32880.1779955503;32963.505547417284;33148.502772458916;33487.33025339528;33794;26257.606135907594;26949.86525067362;27094.458110837277;27271.31883674101;27539.862300688368 02:00:06 INFO - PROCESS | 3424 | |2;jquery.html;461.90992756412516;468.54551085447105;469.91071696377685;476.67824218652424;488.7849346287633;19678.90160549197;20970.580588388242;21361;21689.891550542226;22072;21739.3478195654;21842.89078554605;22266.22068227612;22349.553008939813;22362.66456003161;6655.134832471772;6686.0973768541235;6793.0829338039475;6847.2125705544;6857.58854468731;6705.966470167642;6738.494612904027;6847.589144651337;7213;7529.698812047512;7711.26742959418;7723.72966946157;7733.188015258401;7735.1491335953;7741.071071471403;7438.925610743878;7552.509086909361;7582.696692132308;7589.924100758977;7593.392528597699;7238.674259658328;7399.112106547195;7511.511751736174;7569;7570.886436703454;25646.871765641237;25816.87091564549;26102.608460873103;26251;26526.46947061048;3002.369502404498;3029.59100521429;3116.719495245416;3120.0015994881646;3241.7568682348683;15837.92081039599;16356.591085222846;16515.504534863972;16589;16727.414540491147;2202.515446601745;2262.5814224368546;2295.437617783637;2339.9298021059394;2344.6717459555675;93156;114946.42526787313;115101.42449287784;116134;117469;18024.729629055575;18242.63514729698;18365.90817045933;18366.265349385874;18836.81163188378;32361.35277294441;32537.837310813295;32841.3431731364;32965;32968.175795605304;10297.511931773768;10369.896301037044;10456.947715261374;10480.580776768844;10605.363678179334;8604.8709269361;8628.870566941501;8647.264982476434;8899.199072083544;8915.777105572282;9287.257019438428;9380.48407337603;9432;9530.521359703658;9557.23542116629;3934.3279106380246;3949.150932549516;3968.40473928913;4003.179348233605;4011.939820902689;945.4138434170858;963.8602402651576;966.0580933589694;971.4462756228882;980.475445636581;19976.500587485138;21411.250606228707;21425.89287053586;21721.239756608444;21762.347129586138;974.3033730882453;974.9421877263107;978.7308490165119;998.7153661206667;1015.9898401016043;11288.54845806175;11849.940750296193;11865.050795936304;11906.523739050514;11919.225250358699;637691;643776;647118;657972;661203;86838.13161868427;87886.99999999872;109769;109872;110338.44830775795;1304.3347892574666;1342.7773343974734;1360.6190266725134;1365.528892532075;1377.9242141682103;18951.620967580846;19614.019299034706;19685.21259149675;19701;19724.40826775199;52407;53277.4672253288;53407.46592534025;53505.4649453516;53673;62542.06186907109;70621.64689176521;71261.64369178121;71636;71868.64065679639;11786;12137;12651.683707907376;12753;13291.867081329063;14231.715365692835;14264.643383915485;14286.928565357106;14293.857061429253;14393.92803035978;11809.881901180877;11848.526058957545;11886.881131188577;11907.106966977339;13020.414081366172;10912.945435272773;11177.66467005991;11295.491702873225;11299.830502542303;11718.179727419;12922.353882305659;12928.159669621444;13113.606591802261;13116.868831311565;13124.606261812161;12201.450934708137;12239.20445171061;12389.194702344319;12677;12755.55355562588;8980.521881652056;12687.555935542212;12776.808347874976;12856.935715321737;12915.35423228816 02:00:06 INFO - PROCESS | 3424 | |3;mootools.html;1441.5675297410774;1593.2750598477694;1606.357457017193;1619.643678390754;1629.9266533006014;9313.860292095616;10939.23425360224;11327.546898124076;11708.765824683502;11838.881611183886;11447.08423326134;11539.423028848565;11540.307581545114;11543.653690389281;11544.595939142131;2059.052835695582;2122.7134336864556;2511.1964171465092;2550.681164854393;2551.170869467421;2477.8884950177194;2528.4816612594373;2535.467551814121;2541.783948364391;2548.7196408395153;2450.215930902112;2454.275988583372;2467.222824810179;2471.950560988779;2476.529459402717;2369.336585755991;2373.7863592276776;2380;2381.9761802382013;2412.3245491262473;2374.1453076892303;2398.568257713611;2428.86641234732;2438.329459398662;2442.7312995570474;11539.711507212303;11644.76710465786;11651.650450486499;11662.416879156008;11670.941645291805;5770.8268751937085;5801.24583804107;6027.7287522061615;6065.029595264737;6101.237345331833;3488.8778892738887;3590.6588874056924;3611.6388361163936;3654.798986055766;3808.7905165215902;1323.841139063309;1358.592422273314;1385.238119034537;1400.3628349101134;1431.4059665238913;17977.10114494283;17993.55016124594;18034.36879709204;18050.18774155166;18054.819451805444;5091.9236211456855;5279.973600131974;5319.6808191508635;5345.610141363273;5366.490183432567;13441;13548.525801596898;13568.253746043865;13570;13582.728345433234;6043.546733994968;6233.438990490878;6235.127082208494;6236.345183755731;6241.469475094577;4736.265878788793;4833.709977401367;5411.891762164734;5608.719564021782;5658.405867383948;4190.664746820247;4247.5540068293;4262.65898728101;4309.612134907873;4318.827246910151;1103.9116870650328;1126.4987080749152;1132.1282612388416;1141.4007645985923;1145.352875625269;1040.3497813866334;1057.9047885690325;1058.3755584205355;1066.4720963123305;1075.9354438733544;7031.507794454441;7132.857342853217;7138.393236574845;7232.132144142736;7251.601161936039;1041.4324193314662;1042.3329069395593;1055.5619417941623;1073.5222825842425;1078.6494389323345;4730.645201609893;4816.4220293564995;4838.516148385203;4944.703317800943;5039.042581909425;13869.445222191;14338.641533961525;14401.711965760625;14897.329620167118;15107.39570417171;14682.412703491955;14699.11805291686;14781.92609036948;14789.11265324084;14827;10604.257701960789;10735.731606709738;10821.134309255242;10853.891461085446;10858.891411085788;7587.506812057199;7736.419768517271;7806.609669516615;7839.725609603636;7960.442769006346;13129.212247265195;13143.211407315592;13257.933710331772;13370.799438008633;13445.394957227143;13749.175049497062;13792.586222413343;13802.378892950042;13827.930860345634;13916.930415347859;8379.371547133867;9466.384684995453;9773.218142548436;9784.315097943076;9952.402855828674;11247.268927519684;11316.094712423152;11350.205485615928;11372.090232781524;11373.090152787592;9022.90977090247;9329.346945713734;9460.668876589287;9462.101100395452;9537;8829.337799664921;8833.160849719266;8901.243394311556;8905.599248033725;9014.549272536478;8421.87367189505;8522.446041007315;8587.441816281922;8601.569921504026;8634.050254471877;6059.878802424015;6069.696515174312;6112.816615501542;6163.660998645118;6258.186435763321;5685.744141513725;6219.626822390671;6277.874442511215;6302.936970630419;6536.738530458729 02:00:06 INFO - PROCESS | 3424 | |4;prototype.html;416.70830418706873;436.86893931820447;440.2164147816886;442.8627125591067;454.56361892583124;5233.633645644802;5288.524032837044;5303.4431384704585;5312.442193569668;5329.9733501332485;4944.9121193337405;5163.302954101196;5193.376794784622;5215.400228973669;5248.8687782805355;4303.644352029117;4336.783160841946;4352.934705979413;4354.390385346054;4355.281378572532;4347.239233134204;4369.536205371204;4376.934345984812;4382.583654552828;4385.429894113777;4329.502107257658;4350.108227813306;4379.627731642814;4382.255016647177;4433.512313645512;4071.1857628474277;4343.739375637456;4366.432363792718;4382.824687012516;4411.250087485135;4082.6529744971713;4088.795560221977;4090.8363665453644;4099.85650502234;4100;5057.898842023139;5091.974540127276;5095.955329157514;5130.820421285274;5153.948460515385;4937.075025354851;5004;5057.797688092472;5086.92369614456;5133.691978481265;5433.864153396157;5438.755256013489;5465.316835395575;5492.286002819648;5515.503604675559;4504.842330518416;4526;4551.704139230939;4581.67928245023;4628.514006029386;5374.596905232123;5489.560835133179;5534.584906132016;5539;5601.243832082698;4599.517050709695;4616.3537104805355;4634.675572709945;4700.55344742249;4797;4718.9292160617615;4745.7898235949615;4825.758712064383;4832.033593281358;4870.586000189953;4773.331733557305;4775.307580400892;5023.246513023076;5031.77357018935;5067.898642027212;5424.663831743528;5454.59090568209;5460.6996615186545;5507.311586051744;5539.778408863681;1633.3629884345114;1648.8103868055086;1652.6529428819842;1655.337864854044;1655.991720041392;1218.9207701499552;1276.310792172235;1283.5828355784408;1286.2346903592347;1306.490468717201;5167.6641018333685;5345.732713364317;5412.810551630674;5420.945790542123;5446.836594902159;5473.890522189534;5481.725913704299;5484;5520.3841483828155;5581.804636837691;5347.491988261109;5352.304200453916;5376.865578360573;5381.219723140122;5402.945970540323;2825.6609206895305;2951.9704802951696;2952.6456825180685;2962.6298960831678;2974.1672331747145;5816.447437493432;5818.709064546756;5835.328937172195;5837.153612726131;5863;5748.396418376094;5752.741126649227;5762.2509073820975;5767.22142510764;5773.24947756789;5512.830122679476;5804.419558044162;5834.883302334015;5861.032929566659;5874.383189765184;5653.293338332708;5661.547076233974;5668.376478587435;5673.234113394639;5677.77288908439;5454.754536045808;5589.748461319169;5614.382417934105;5647.661140331593;5655;5514.36584792754;5631.267935168566;5786.884262314814;5837.591368604157;5897.764089436375;4666.253399456071;4686.343911852412;4703.247480403119;4717.608305549939;4738.36032135671;5366.7656439018465;5629.3112066380745;5629.480040389154;5648.915266270927;5689.943100568941;5523.619095226193;5527.972360138174;5530.336359636869;5547.389787123332;5553;5478.849661444606;5540.556755459473;5570.86072848182;5589.664620122806;5623.738231825613;5331.333583302087;5446.264754258124;5478.945210547843;5485.915352166151;5490.870203983851;5478.479544443271;5555.611107222618;5585.385607583244;5592.384837667934;5619.409961953936;5230.607704422107;5334.359876814807;5374.570034397317;5454.890902182014;5479 02:00:06 INFO - PROCESS | 3424 | |5;yui.html;820.2718643764096;836.5733475927275;925.6528801699362;942.5899733615873;971.5482300730162;16864.831351686495;18125;18905;19513.024348782576;19607.901960490213;18824.90587547064;18853;18865.811341886576;18936.242550298008;19025.429237122873;882.2985726347537;885.0397318908991;888.6534251641849;901.1619194149439;918.481058202117;902.634433054614;907.6959218661756;907.8774365460645;911.2436677557645;913.1963871792813;955.5461155950902;957.0859828863454;958.3435346787472;959.8704174936364;961.2502248246379;944.9905500944972;951.9809603807885;952.4808979106404;952.7046615549202;953.0231512699469;709.8970649255829;711.5410560188701;711.8006958051753;712.4122598855964;712.7434123715458;17766.022868742213;17792.644147117113;18020.909895450437;18719.064046797605;19081.045947702558;15833.762493562606;16080.919595402065;16248.83751162485;16327.755083673754;16467.917660411742;13512.59462216135;13621.727565448635;13992.160470371708;14005;14035.929820350833;4039.9596004039877;4080.469538959916;4139.461869956916;4141.399497072937;4158.2307273154565;82138.58930705368;83653;84218;84809.15190848074;85744;11306.095512358992;11404.144689148347;11431.14266430021;11437;11796.76406471883;23218.53562928732;23463.648045279333;23672.28983130509;23688.763112369;23715.407114821923;8580.613872375758;8654.394192406471;8762.299016078698;8789.252913502423;8817.559122043873;4728.8801963797505;4850.151223535867;4857.222844344888;4960.751962401865;4971.850844474671;3786.981065094657;3837.788921609338;3850.2876967760494;3853.5761066282685;3886.630770076838;623.6725718997562;624.7594676049663;630.6373835044867;631.5768435148461;639.5427269502235;835.757630287222;850.4047166983013;868.7046404222594;878.8286284174652;881.0924747510074;10379.429131397847;10535.209859260585;10787.568497260021;10849;10947.56209751617;823.4812068396872;832.4173078844833;836.180543067797;849.9872501912477;856.5032281276845;5306.363236411656;5399.460053994648;5481.369642491165;5482.259894914216;5504.6421982571;80066.5996670013;80280.78876844977;81075;81942.51793517965;83606;67760.32239677639;68833.65583172052;69087.3091269091;69118;69378;55647;57306.42693573011;61779;61995.690021549606;62478;10544.103751180928;11184;11187.888121118685;11199.72000699989;11388.487518061873;36175.81912090423;37261;38088.23823523459;40226.79886600548;43176;53901.46098539121;54243.45756542384;55778.72110639421;55931.44068559425;56184.719076404355;13344.199348039148;13446.327683615977;13749.518766843512;13770.380332884844;13885;16174.433894813625;16418.67162656764;16561.83438165651;16770.748438773186;16798.160091995596;14946.626334341294;15304.31130599148;15511.379544818532;16024.198790060684;16398;14496.420143194155;14701.264936753334;15148.394064237307;15639.218039098227;15694.293756780744;15167.241637918281;15374.231288435758;15572.377104915677;16375.263113160174;16382.443667851536;9758.9024109758;10096.141827944413;10210.540525676213;10611.204159688208;10677.199210059121;11153.386563739072;11351.37567433799;12167.2699638022;12372.690682732644;12432.689182770504 02:00:06 INFO - PROCESS | 3424 | __end_tp_report 02:00:06 INFO - PROCESS | 3424 | __start_cc_report 02:00:06 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,1401 02:00:06 INFO - PROCESS | 3424 | __end_cc_report 02:00:06 INFO - PROCESS | 3424 | __startTimestamp1494147606217__endTimestamp 02:00:06 INFO - PROCESS | 3424 | 02:00:06 INFO - PROCESS | 3424 | ------- Summary: start ------- 02:00:06 INFO - PROCESS | 3424 | Number of tests: 6 02:00:06 INFO - PROCESS | 3424 | 02:00:06 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:5888.56 Median:6149.57 stddev:692.20 (11.3%) stddev-sans-first:667.37 02:00:06 INFO - PROCESS | 3424 | Values: 3450.5 3506.3 3521.6 3524.8 3546.7 5882.9 5944.1 5967.4 5973.4 5991.8 5928.9 5962.1 5965.4 5986.3 6003.0 5284.9 5308.4 5332.4 5335.9 5374.9 5159.7 5164.5 5391.1 5403.1 5409.0 5277.6 5321.1 5377.8 5385.8 5401.0 5385.4 5386.7 5387.7 5388.6 5394.0 5066.3 5078.6 5222.2 5321.6 5360.2 5810.5 5821.5 5857.1 5893.6 5924.9 6274.9 6357.8 6365.9 6367.1 6372.3 6103.7 6428.7 6434.9 6456.0 6456.4 5765.7 5903.6 5937.6 5940.1 5947.0 6470.2 6492.3 6529.7 6535.7 6542.0 6277.5 6310.2 6314.1 6315.8 6320.9 6065.8 6106.7 6224.9 6244.3 6275.2 6367.6 6371.3 6373.6 6374.2 6374.4 6113.4 6113.7 6141.3 6159.7 6388.1 4708.4 4801.4 4803.1 4825.4 4827.3 4170.2 4173.5 4211.2 4237.5 4266.4 6131.0 6138.2 6149.6 6153.6 6160.0 6442.5 6458.3 6470.4 6472.6 6476.9 5850.0 5872.6 6167.7 6181.2 6181.4 5312.5 5388.2 5432.3 5438.8 5439.6 6591.1 6658.1 6670.1 6688.7 6688.8 6333.4 6435.1 6462.6 6464.1 6467.7 6353.8 6396.6 6546.7 6575.7 6621.9 6340.6 6347.5 6352.3 6354.0 6360.1 6378.8 6398.8 6434.8 6439.2 6448.2 6015.1 6037.8 6143.8 6176.5 6275.9 6178.8 6196.6 6197.2 6206.2 6208.1 5969.0 6164.4 6196.8 6213.3 6227.3 6065.5 6115.0 6171.6 6245.1 6300.4 6145.9 6164.1 6178.9 6185.2 6187.7 02:00:06 INFO - PROCESS | 3424 | 02:00:06 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:44206.47 Median:31090.45 stddev:69746.76 (224.3%) stddev-sans-first:69866.03 02:00:06 INFO - PROCESS | 3424 | Values: 729.3 806.0 811.0 870.3 879.8 30621.1 42944.4 43363.8 43412.0 43450.3 43809.8 44006.0 44021.6 44082.6 44111.3 7616.2 7754.8 8957.1 9088.5 9089.1 10270.9 10470.6 10484.5 10490.1 10746.0 10570.2 10581.7 10618.3 10619.7 10625.3 10469.7 10498.7 10500.8 10510.6 10515.2 10005.0 10050.6 10088.1 10104.0 10140.3 39800.6 40025.4 40034.6 40083.2 40562.2 4239.7 4308.6 4325.2 4423.7 4426.0 28709.9 29002.6 29137.1 29513.3 30350.0 4171.2 4245.6 4264.4 4288.6 4369.5 233097.0 234052.0 235098.0 236079.0 236374.0 51437.7 51873.0 51926.2 51978.0 52010.7 53853.5 53922.7 53943.7 53945.0 53983.5 15156.0 15434.5 15488.2 15505.9 15521.8 12454.9 12507.3 13402.2 13430.3 14045.2 12584.9 12587.6 12640.4 12699.5 12748.7 5374.6 5515.6 5542.0 5547.5 5581.7 1020.7 1027.2 1029.7 1030.3 1030.7 28495.3 28531.4 28681.9 28883.7 28932.4 1092.6 1098.9 1102.0 1137.9 1190.2 14569.9 16346.8 16795.9 16948.8 17288.4 301626.0 301763.0 302622.0 303194.0 303900.0 57038.0 57528.1 57531.0 57540.0 57611.1 1529.4 1553.9 1558.5 1560.5 1584.5 29600.3 30773.8 30802.5 30947.9 31233.0 42753.6 42805.1 42832.6 42844.1 42890.4 261944.0 262138.0 262340.0 262861.0 263393.0 28886.0 33960.7 34505.5 34738.3 34924.7 35270.8 36648.6 45137.0 48330.5 48722.5 33664.7 34040.3 34055.7 34189.1 34423.3 33962.5 34282.8 34303.8 34343.7 34864.5 39533.0 40162.0 40299.8 40655.2 40930.2 32880.2 32963.5 33148.5 33487.3 33794.0 26257.6 26949.9 27094.5 27271.3 27539.9 02:00:06 INFO - PROCESS | 3424 | 02:00:06 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:37225.05 Median:2342.30 stddev:106827.02 (4560.8%) stddev-sans-first:107091.04 02:00:06 INFO - PROCESS | 3424 | Values: 461.9 468.5 469.9 476.7 488.8 19678.9 20970.6 21361.0 21689.9 22072.0 21739.3 21842.9 22266.2 22349.6 22362.7 6655.1 6686.1 6793.1 6847.2 6857.6 6706.0 6738.5 6847.6 7213.0 7529.7 7711.3 7723.7 7733.2 7735.1 7741.1 7438.9 7552.5 7582.7 7589.9 7593.4 7238.7 7399.1 7511.5 7569.0 7570.9 25646.9 25816.9 26102.6 26251.0 26526.5 3002.4 3029.6 3116.7 3120.0 3241.8 15837.9 16356.6 16515.5 16589.0 16727.4 2202.5 2262.6 2295.4 2339.9 2344.7 93156.0 114946.4 115101.4 116134.0 117469.0 18024.7 18242.6 18365.9 18366.3 18836.8 32361.4 32537.8 32841.3 32965.0 32968.2 10297.5 10369.9 10456.9 10480.6 10605.4 8604.9 8628.9 8647.3 8899.2 8915.8 9287.3 9380.5 9432.0 9530.5 9557.2 3934.3 3949.2 3968.4 4003.2 4011.9 945.4 963.9 966.1 971.4 980.5 19976.5 21411.3 21425.9 21721.2 21762.3 974.3 974.9 978.7 998.7 1016.0 11288.5 11849.9 11865.1 11906.5 11919.2 637691.0 643776.0 647118.0 657972.0 661203.0 86838.1 87887.0 109769.0 109872.0 110338.4 1304.3 1342.8 1360.6 1365.5 1377.9 18951.6 19614.0 19685.2 19701.0 19724.4 52407.0 53277.5 53407.5 53505.5 53673.0 62542.1 70621.6 71261.6 71636.0 71868.6 11786.0 12137.0 12651.7 12753.0 13291.9 14231.7 14264.6 14286.9 14293.9 14393.9 11809.9 11848.5 11886.9 11907.1 13020.4 10912.9 11177.7 11295.5 11299.8 11718.2 12922.4 12928.2 13113.6 13116.9 13124.6 12201.5 12239.2 12389.2 12677.0 12755.6 8980.5 12687.6 12776.8 12856.9 12915.4 02:00:06 INFO - PROCESS | 3424 | 02:00:06 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:7266.44 Median:2446.47 stddev:4663.31 (190.6%) stddev-sans-first:4655.85 02:00:06 INFO - PROCESS | 3424 | Values: 1441.6 1593.3 1606.4 1619.6 1629.9 9313.9 10939.2 11327.5 11708.8 11838.9 11447.1 11539.4 11540.3 11543.7 11544.6 2059.1 2122.7 2511.2 2550.7 2551.2 2477.9 2528.5 2535.5 2541.8 2548.7 2450.2 2454.3 2467.2 2472.0 2476.5 2369.3 2373.8 2380.0 2382.0 2412.3 2374.1 2398.6 2428.9 2438.3 2442.7 11539.7 11644.8 11651.7 11662.4 11670.9 5770.8 5801.2 6027.7 6065.0 6101.2 3488.9 3590.7 3611.6 3654.8 3808.8 1323.8 1358.6 1385.2 1400.4 1431.4 17977.1 17993.6 18034.4 18050.2 18054.8 5091.9 5280.0 5319.7 5345.6 5366.5 13441.0 13548.5 13568.3 13570.0 13582.7 6043.5 6233.4 6235.1 6236.3 6241.5 4736.3 4833.7 5411.9 5608.7 5658.4 4190.7 4247.6 4262.7 4309.6 4318.8 1103.9 1126.5 1132.1 1141.4 1145.4 1040.3 1057.9 1058.4 1066.5 1075.9 7031.5 7132.9 7138.4 7232.1 7251.6 1041.4 1042.3 1055.6 1073.5 1078.6 4730.6 4816.4 4838.5 4944.7 5039.0 13869.4 14338.6 14401.7 14897.3 15107.4 14682.4 14699.1 14781.9 14789.1 14827.0 10604.3 10735.7 10821.1 10853.9 10858.9 7587.5 7736.4 7806.6 7839.7 7960.4 13129.2 13143.2 13257.9 13370.8 13445.4 13749.2 13792.6 13802.4 13827.9 13916.9 8379.4 9466.4 9773.2 9784.3 9952.4 11247.3 11316.1 11350.2 11372.1 11373.1 9022.9 9329.3 9460.7 9462.1 9537.0 8829.3 8833.2 8901.2 8905.6 9014.5 8421.9 8522.4 8587.4 8601.6 8634.1 6059.9 6069.7 6112.8 6163.7 6258.2 5685.7 6219.6 6277.9 6302.9 6536.7 02:00:06 INFO - PROCESS | 3424 | 02:00:06 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:4782.98 Median:5321.21 stddev:1270.49 (23.9%) stddev-sans-first:1231.06 02:00:06 INFO - PROCESS | 3424 | Values: 416.7 436.9 440.2 442.9 454.6 5233.6 5288.5 5303.4 5312.4 5330.0 4944.9 5163.3 5193.4 5215.4 5248.9 4303.6 4336.8 4352.9 4354.4 4355.3 4347.2 4369.5 4376.9 4382.6 4385.4 4329.5 4350.1 4379.6 4382.3 4433.5 4071.2 4343.7 4366.4 4382.8 4411.3 4082.7 4088.8 4090.8 4099.9 4100.0 5057.9 5092.0 5096.0 5130.8 5153.9 4937.1 5004.0 5057.8 5086.9 5133.7 5433.9 5438.8 5465.3 5492.3 5515.5 4504.8 4526.0 4551.7 4581.7 4628.5 5374.6 5489.6 5534.6 5539.0 5601.2 4599.5 4616.4 4634.7 4700.6 4797.0 4718.9 4745.8 4825.8 4832.0 4870.6 4773.3 4775.3 5023.2 5031.8 5067.9 5424.7 5454.6 5460.7 5507.3 5539.8 1633.4 1648.8 1652.7 1655.3 1656.0 1218.9 1276.3 1283.6 1286.2 1306.5 5167.7 5345.7 5412.8 5420.9 5446.8 5473.9 5481.7 5484.0 5520.4 5581.8 5347.5 5352.3 5376.9 5381.2 5402.9 2825.7 2952.0 2952.6 2962.6 2974.2 5816.4 5818.7 5835.3 5837.2 5863.0 5748.4 5752.7 5762.3 5767.2 5773.2 5512.8 5804.4 5834.9 5861.0 5874.4 5653.3 5661.5 5668.4 5673.2 5677.8 5454.8 5589.7 5614.4 5647.7 5655.0 5514.4 5631.3 5786.9 5837.6 5897.8 4666.3 4686.3 4703.2 4717.6 4738.4 5366.8 5629.3 5629.5 5648.9 5689.9 5523.6 5528.0 5530.3 5547.4 5553.0 5478.8 5540.6 5570.9 5589.7 5623.7 5331.3 5446.3 5478.9 5485.9 5490.9 5478.5 5555.6 5585.4 5592.4 5619.4 5230.6 5334.4 5374.6 5454.9 5479.0 02:00:06 INFO - PROCESS | 3424 | 02:00:06 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:18459.67 Median:4140.43 stddev:22641.66 (546.8%) stddev-sans-first:22666.43 02:00:06 INFO - PROCESS | 3424 | Values: 820.3 836.6 925.7 942.6 971.5 16864.8 18125.0 18905.0 19513.0 19607.9 18824.9 18853.0 18865.8 18936.2 19025.4 882.3 885.0 888.7 901.2 918.5 902.6 907.7 907.9 911.2 913.2 955.5 957.1 958.3 959.9 961.3 945.0 952.0 952.5 952.7 953.0 709.9 711.5 711.8 712.4 712.7 17766.0 17792.6 18020.9 18719.1 19081.0 15833.8 16080.9 16248.8 16327.8 16467.9 13512.6 13621.7 13992.2 14005.0 14035.9 4040.0 4080.5 4139.5 4141.4 4158.2 82138.6 83653.0 84218.0 84809.2 85744.0 11306.1 11404.1 11431.1 11437.0 11796.8 23218.5 23463.6 23672.3 23688.8 23715.4 8580.6 8654.4 8762.3 8789.3 8817.6 4728.9 4850.2 4857.2 4960.8 4971.9 3787.0 3837.8 3850.3 3853.6 3886.6 623.7 624.8 630.6 631.6 639.5 835.8 850.4 868.7 878.8 881.1 10379.4 10535.2 10787.6 10849.0 10947.6 823.5 832.4 836.2 850.0 856.5 5306.4 5399.5 5481.4 5482.3 5504.6 80066.6 80280.8 81075.0 81942.5 83606.0 67760.3 68833.7 69087.3 69118.0 69378.0 55647.0 57306.4 61779.0 61995.7 62478.0 10544.1 11184.0 11187.9 11199.7 11388.5 36175.8 37261.0 38088.2 40226.8 43176.0 53901.5 54243.5 55778.7 55931.4 56184.7 13344.2 13446.3 13749.5 13770.4 13885.0 16174.4 16418.7 16561.8 16770.7 16798.2 14946.6 15304.3 15511.4 16024.2 16398.0 14496.4 14701.3 15148.4 15639.2 15694.3 15167.2 15374.2 15572.4 16375.3 16382.4 9758.9 10096.1 10210.5 10611.2 10677.2 11153.4 11351.4 12167.3 12372.7 12432.7 02:00:06 INFO - PROCESS | 3424 | -------- Summary: end -------- 02:00:06 INFO - PROCESS | 3424 | 02:00:07 INFO - TEST-INFO | 3424: exit 0 02:00:07 INFO - TEST-OK | dromaeo_css | took 1116511ms 02:00:07 INFO - TEST-START | kraken 02:00:07 INFO - operating with platform_type : linux_ 02:00:07 INFO - Initialising browser for kraken test... 02:00:07 INFO - TEST-INFO | started process 3749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpXFRd/profile http://localhost:47369/getInfo.html) 02:00:11 INFO - PROCESS | 3749 | __metrics Screen width/height:1600/1200 02:00:11 INFO - PROCESS | 3749 | colorDepth:24 02:00:11 INFO - PROCESS | 3749 | Browser inner width/height: 1024/697 02:00:11 INFO - PROCESS | 3749 | __metrics 02:00:12 INFO - PROCESS | 3749 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:00:12 INFO - PROCESS | 3749 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:00:13 INFO - TEST-INFO | 3749: exit 0 02:00:13 INFO - Browser initialized. 02:00:13 INFO - Running cycle 1/1 for kraken test... 02:00:13 INFO - TEST-INFO | started process 3845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpXFRd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:24 INFO - PROCESS | 3845 | RSS: Main: 140050432 02:00:24 INFO - PROCESS | 3845 | 02:00:27 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47369/tests/kraken/driver.html?testName=audio-beat-detection) 02:00:28 INFO - PROCESS | 3845 | RSS: Main: 183447552 02:00:28 INFO - PROCESS | 3845 | 02:00:30 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47369/tests/kraken/driver.html?testName=audio-dft) 02:00:31 INFO - PROCESS | 3845 | RSS: Main: 174403584 02:00:31 INFO - PROCESS | 3845 | 02:00:34 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47369/tests/kraken/driver.html?testName=audio-fft) 02:00:34 INFO - PROCESS | 3845 | RSS: Main: 266010624 02:00:34 INFO - PROCESS | 3845 | 02:00:36 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47369/tests/kraken/driver.html?testName=audio-oscillator) 02:00:37 INFO - PROCESS | 3845 | RSS: Main: 172412928 02:00:37 INFO - PROCESS | 3845 | 02:00:39 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:00:40 INFO - PROCESS | 3845 | RSS: Main: 174460928 02:00:40 INFO - PROCESS | 3845 | 02:00:43 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47369/tests/kraken/driver.html?testName=imaging-darkroom) 02:00:43 INFO - PROCESS | 3845 | RSS: Main: 213581824 02:00:43 INFO - PROCESS | 3845 | 02:00:47 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47369/tests/kraken/driver.html?testName=imaging-desaturate) 02:00:47 INFO - PROCESS | 3845 | RSS: Main: 212738048 02:00:47 INFO - PROCESS | 3845 | 02:00:50 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47369/tests/kraken/driver.html?testName=json-parse-financial) 02:00:51 INFO - PROCESS | 3845 | RSS: Main: 210886656 02:00:51 INFO - PROCESS | 3845 | 02:00:52 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:00:53 INFO - PROCESS | 3845 | RSS: Main: 173350912 02:00:53 INFO - PROCESS | 3845 | 02:00:54 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47369/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:00:55 INFO - PROCESS | 3845 | RSS: Main: 179683328 02:00:55 INFO - PROCESS | 3845 | 02:00:57 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:00:58 INFO - PROCESS | 3845 | RSS: Main: 189906944 02:00:58 INFO - PROCESS | 3845 | 02:01:00 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:01:01 INFO - PROCESS | 3845 | RSS: Main: 198635520 02:01:01 INFO - PROCESS | 3845 | 02:01:04 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:01:04 INFO - PROCESS | 3845 | RSS: Main: 195887104 02:01:04 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:47369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47369/tests/kraken/driver.html?testName=ai-astar) 02:01:06 INFO - PROCESS | 3845 | RSS: Main: 247033856 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | __start_tp_report 02:01:06 INFO - PROCESS | 3845 | _x_x_mozilla_page_load 02:01:06 INFO - PROCESS | 3845 | _x_x_mozilla_page_load_details 02:01:06 INFO - PROCESS | 3845 | |i|pagename|runs| 02:01:06 INFO - PROCESS | 3845 | |0;ai-astar;102;113;111;110;112;112;110;112;111;111 02:01:06 INFO - PROCESS | 3845 | |1;audio-beat-detection;142;121;116;162;121;116;115;118;134;115 02:01:06 INFO - PROCESS | 3845 | |2;audio-dft;161;161;162;160;159;165;159;161;162;159 02:01:06 INFO - PROCESS | 3845 | |3;audio-fft;76;75;75;110;76;76;76;74;92;75 02:01:06 INFO - PROCESS | 3845 | |4;audio-oscillator;82;82;104;82;83;83;97;82;82;111 02:01:06 INFO - PROCESS | 3845 | |5;imaging-gaussian-blur;113;114;114;113;112;113;113;113;113;113 02:01:06 INFO - PROCESS | 3845 | |6;imaging-darkroom;146;146;148;146;146;146;148;146;146;147 02:01:06 INFO - PROCESS | 3845 | |7;imaging-desaturate;94;93;94;93;94;94;94;94;94;94 02:01:06 INFO - PROCESS | 3845 | |8;json-parse-financial;54;53;53;53;53;55;54;54;54;54 02:01:06 INFO - PROCESS | 3845 | |9;json-stringify-tinderbox;53;54;53;53;53;53;52;52;53;53 02:01:06 INFO - PROCESS | 3845 | |10;stanford-crypto-aes;76;81;80;82;81;79;80;75;81;79 02:01:06 INFO - PROCESS | 3845 | |11;stanford-crypto-ccm;120;131;122;120;119;125;118;124;166;138 02:01:06 INFO - PROCESS | 3845 | |12;stanford-crypto-pbkdf2;161;157;162;158;169;160;159;159;159;157 02:01:06 INFO - PROCESS | 3845 | |13;stanford-crypto-sha256-iterative;63;60;60;61;59;61;60;59;60;58 02:01:06 INFO - PROCESS | 3845 | __end_tp_report 02:01:06 INFO - PROCESS | 3845 | __start_cc_report 02:01:06 INFO - PROCESS | 3845 | _x_x_mozilla_cycle_collect,1670 02:01:06 INFO - PROCESS | 3845 | __end_cc_report 02:01:06 INFO - PROCESS | 3845 | __startTimestamp1494147666488__endTimestamp 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | ------- Summary: start ------- 02:01:06 INFO - PROCESS | 3845 | Number of tests: 14 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.10 (2.8%) stddev-sans-first:1.00 02:01:06 INFO - PROCESS | 3845 | Values: 102.0 113.0 111.0 110.0 112.0 112.0 110.0 112.0 111.0 111.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:121.00 stddev:15.53 (12.8%) stddev-sans-first:15.36 02:01:06 INFO - PROCESS | 3845 | Values: 142.0 121.0 116.0 162.0 121.0 116.0 115.0 118.0 134.0 115.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.85 (1.2%) stddev-sans-first:1.96 02:01:06 INFO - PROCESS | 3845 | Values: 161.0 161.0 162.0 160.0 159.0 165.0 159.0 161.0 162.0 159.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:11.63 (15.3%) stddev-sans-first:12.22 02:01:06 INFO - PROCESS | 3845 | Values: 76.0 75.0 75.0 110.0 76.0 76.0 76.0 74.0 92.0 75.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:11.00 (13.4%) stddev-sans-first:11.39 02:01:06 INFO - PROCESS | 3845 | Values: 82.0 82.0 104.0 82.0 83.0 83.0 97.0 82.0 82.0 111.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:01:06 INFO - PROCESS | 3845 | Values: 113.0 114.0 114.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 02:01:06 INFO - PROCESS | 3845 | Values: 146.0 146.0 148.0 146.0 146.0 146.0 148.0 146.0 146.0 147.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:01:06 INFO - PROCESS | 3845 | Values: 94.0 93.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 02:01:06 INFO - PROCESS | 3845 | Values: 54.0 53.0 53.0 53.0 53.0 55.0 54.0 54.0 54.0 54.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#9] json-stringify-tinderbox Cycles:10 Average:52.90 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 02:01:06 INFO - PROCESS | 3845 | Values: 53.0 54.0 53.0 53.0 53.0 53.0 52.0 52.0 53.0 53.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.50 stddev:2.27 (2.8%) stddev-sans-first:2.05 02:01:06 INFO - PROCESS | 3845 | Values: 76.0 81.0 80.0 82.0 81.0 79.0 80.0 75.0 81.0 79.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:124.50 stddev:14.61 (11.7%) stddev-sans-first:15.19 02:01:06 INFO - PROCESS | 3845 | Values: 120.0 131.0 122.0 120.0 119.0 125.0 118.0 124.0 166.0 138.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:159.50 stddev:3.51 (2.2%) stddev-sans-first:3.71 02:01:06 INFO - PROCESS | 3845 | Values: 161.0 157.0 162.0 158.0 169.0 160.0 159.0 159.0 159.0 157.0 02:01:06 INFO - PROCESS | 3845 | 02:01:06 INFO - PROCESS | 3845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.00 stddev:1.37 (2.3%) stddev-sans-first:0.97 02:01:06 INFO - PROCESS | 3845 | Values: 63.0 60.0 60.0 61.0 59.0 61.0 60.0 59.0 60.0 58.0 02:01:06 INFO - PROCESS | 3845 | -------- Summary: end -------- 02:01:06 INFO - PROCESS | 3845 | 02:01:07 INFO - TEST-INFO | 3845: exit 0 02:01:07 INFO - TEST-OK | kraken | took 60543ms 02:01:07 INFO - SUITE-END | took 1177s 02:01:07 INFO - Completed test suite (00:19:37) 02:01:07 INFO - javascript benchmark 02:01:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7924.231614733225, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3450.4824276358545, 3506.316268327674, 3521.6478352164804, 3524.788512689239, 3546.680798728114, 5882.9411705882985, 5944.10838374243, 5967.403259674031, 5973.432523910233, 5991.790287339944, 5928.88142237155, 5962.105684147369, 5965.43328383804, 5986.311574168972, 6003.0, 5284.894302113956, 5308.389535203462, 5332.413434522199, 5335.866603334928, 5374.946250537503, 5159.690418574897, 5164.457731938149, 5391.056565101111, 5403.054465468547, 5408.972955135238, 5277.577793776508, 5321.095413779647, 5377.838664840061, 5385.78456861725, 5400.972995135019, 5385.353757549119, 5386.73066346685, 5387.730613469311, 5388.568914486851, 5393.99999999998, 5066.316047333637, 5078.61910356721, 5222.190560463135, 5321.600879934021, 5360.169173778032, 5810.535157187457, 5821.53427725781, 5857.092150716646, 5893.557983151238, 5924.851878703023, 6274.87450250997, 6357.777477788301, 6365.936340636581, 6367.07677386781, 6372.267189273247, 6103.694815259264, 6428.678566071678, 6434.871302573923, 6455.967720161416, 6456.418922297016, 5765.682887441189, 5903.557233207526, 5937.584369094208, 5940.108983652401, 5946.970265148647, 6470.191226096738, 6492.253390860017, 6529.673516324165, 6535.738570457129, 6541.967290163519, 6277.52918531112, 6310.1796766420075, 6314.0528920661345, 6315.842103947438, 6320.936790632127, 6065.787697430657, 6106.72519736613, 6224.875502489925, 6244.2506899171485, 6275.152854364694, 6367.586106903036, 6371.299157092716, 6373.5857169283845, 6374.235091789015, 6374.394432528995, 6113.424164191899, 6113.694315284307, 6141.324454310023, 6159.692015399301, 6388.073729309224, 4708.387909571734, 4801.447833499193, 4803.135435621622, 4825.420949486014, 4827.300041493963, 4170.186813571385, 4173.478315210598, 4211.178820130107, 4237.512686041083, 4266.4240327556, 6130.979101201984, 6138.235132557318, 6149.569530132937, 6153.600015998945, 6159.969200153971, 6442.452391546677, 6458.321876203025, 6470.417662410406, 6472.579282346726, 6476.935230647728, 5849.970750146222, 5872.559558033165, 6167.691615419211, 6181.196444462191, 6181.443670069715, 5312.5484333832055, 5388.245645609618, 5432.348118225838, 5438.809641662523, 5439.646422982493, 6591.143151390289, 6658.1344425224415, 6670.132882725215, 6688.732450702015, 6688.799336019927, 6333.429991300805, 6435.099086127852, 6462.612243265419, 6464.09502669636, 6467.676616169078, 6353.809385718436, 6396.616203027647, 6546.705398257185, 6575.736970521126, 6621.867562648624, 6340.587861789153, 6347.492200623847, 6352.301246862934, 6354.0, 6360.109584658244, 6378.77674281398, 6398.808035758934, 6434.774782882577, 6439.162908821823, 6448.226212854487, 6015.097735339734, 6037.849053773691, 6143.8326717923455, 6176.505879529537, 6275.937240627535, 6178.752849886134, 6196.597221180609, 6197.194364732736, 6206.224221972254, 6208.1308616792785, 5969.0, 6164.4143806338325, 6196.752129914933, 6213.254409470893, 6227.314995350598, 6065.514758819372, 6114.960456722457, 6171.59884607499, 6245.0632405139595, 6300.432961033529, 6145.938540614716, 6164.137020817179, 6178.907316390168, 6185.195924529782, 6187.690615469299], "value": 5841.0554436137545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.3071581997101, 805.9556724380159, 811.0470197517915, 870.2820173356982, 879.810840669256, 30621.08136755898, 42944.35583466251, 43363.78318108413, 43412.0, 43450.34824477635, 43809.78095109528, 44006.0, 44021.55978440215, 44082.55917440825, 44111.338329925, 7616.162222155586, 7754.767356979271, 8957.10428957104, 9088.50013249271, 9089.091090890925, 10270.9486452568, 10470.633527826527, 10484.475776211197, 10490.108340791043, 10746.0, 10570.207234457408, 10581.682549523526, 10618.309809862334, 10619.734506637318, 10625.256232063759, 10469.685909422691, 10498.685039448828, 10500.78998420035, 10510.632127875488, 10515.211359148094, 10005.0, 10050.597976080948, 10088.092071713581, 10104.04011618895, 10140.340877842991, 39800.60199397998, 40025.39961900574, 40034.59965400338, 40083.198336033405, 40562.188756225005, 4239.724417912857, 4308.590683885026, 4325.221460137174, 4423.734575925422, 4426.04839959407, 28709.85645071782, 29002.564961525593, 29137.125886223446, 29513.26216844596, 30350.0, 4171.165766846643, 4245.61789438952, 4264.445622069142, 4288.592583704543, 4369.4756629204385, 233097.0, 234052.0, 235098.0, 236079.0, 236374.0, 51437.7428112857, 51873.0, 51926.22110668343, 51978.0, 52010.73994630078, 53853.461465385626, 53922.730386347816, 53943.730281349126, 53945.0, 53983.46016539863, 15156.0, 15434.459793907385, 15488.22558872052, 15505.922470387575, 15521.84478155204, 12454.875451245372, 12507.312097834707, 13402.195868247936, 13430.328483575782, 14045.227512486912, 12584.937075314749, 12587.559435419716, 12640.367981600883, 12699.492020319269, 12748.745025099446, 5374.623776335619, 5515.586331025189, 5541.972290138524, 5547.502174412966, 5581.748821303051, 1020.7397113736098, 1027.209049032241, 1029.7065336379096, 1030.3251370352432, 1030.7062487191265, 28495.28761780972, 28531.429371412454, 28681.856590716914, 28883.71116288852, 28932.42135157285, 1092.5520536579963, 1098.9450527473593, 1101.9724506887233, 1137.9089672826153, 1190.2323001663879, 14569.854301457062, 16346.75479867803, 16795.91602041982, 16948.783001665055, 17288.394906178222, 301626.0, 301763.0, 302622.0, 303194.0, 303900.0, 57038.0, 57528.12359382014, 57531.0, 57540.0, 57611.13583296254, 1529.3653133949508, 1553.9223038848013, 1558.5090696430814, 1560.485039936818, 1584.4771225495558, 29600.259993500335, 30773.8461307692, 30802.537961930142, 30947.89924357736, 31233.0, 42753.5724642762, 42805.14389712251, 42832.57167428286, 42844.143117138105, 42890.35664465098, 261944.0, 262138.0, 262340.0, 262861.0, 263393.0, 28886.0, 33960.66039339575, 34505.48241776426, 34738.305233895684, 34924.65075349214, 35270.8236458816, 36648.63351366559, 45137.0, 48330.5166948326, 48722.5127748718, 33664.66335336615, 34040.31919361649, 34055.659443405246, 34189.14527136742, 34423.31153376868, 33962.49056264207, 34282.80010199631, 34303.82848085744, 34343.656563434044, 34864.47703284503, 39533.0, 40162.0, 40299.79850100848, 40655.186896261315, 40930.1813963725, 32880.1779955503, 32963.505547417284, 33148.502772458916, 33487.33025339528, 33794.0, 26257.606135907594, 26949.86525067362, 27094.458110837277, 27271.31883674101, 27539.862300688368], "value": 18914.85262032872, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.90992756412516, 468.54551085447105, 469.91071696377685, 476.67824218652424, 488.7849346287633, 19678.90160549197, 20970.580588388242, 21361.0, 21689.891550542226, 22072.0, 21739.3478195654, 21842.89078554605, 22266.22068227612, 22349.553008939813, 22362.66456003161, 6655.134832471772, 6686.0973768541235, 6793.0829338039475, 6847.2125705544, 6857.58854468731, 6705.966470167642, 6738.494612904027, 6847.589144651337, 7213.0, 7529.698812047512, 7711.26742959418, 7723.72966946157, 7733.188015258401, 7735.1491335953, 7741.071071471403, 7438.925610743878, 7552.509086909361, 7582.696692132308, 7589.924100758977, 7593.392528597699, 7238.674259658328, 7399.112106547195, 7511.511751736174, 7569.0, 7570.886436703454, 25646.871765641237, 25816.87091564549, 26102.608460873103, 26251.0, 26526.46947061048, 3002.369502404498, 3029.59100521429, 3116.719495245416, 3120.0015994881646, 3241.7568682348683, 15837.92081039599, 16356.591085222846, 16515.504534863972, 16589.0, 16727.414540491147, 2202.515446601745, 2262.5814224368546, 2295.437617783637, 2339.9298021059394, 2344.6717459555675, 93156.0, 114946.42526787313, 115101.42449287784, 116134.0, 117469.0, 18024.729629055575, 18242.63514729698, 18365.90817045933, 18366.265349385874, 18836.81163188378, 32361.35277294441, 32537.837310813295, 32841.3431731364, 32965.0, 32968.175795605304, 10297.511931773768, 10369.896301037044, 10456.947715261374, 10480.580776768844, 10605.363678179334, 8604.8709269361, 8628.870566941501, 8647.264982476434, 8899.199072083544, 8915.777105572282, 9287.257019438428, 9380.48407337603, 9432.0, 9530.521359703658, 9557.23542116629, 3934.3279106380246, 3949.150932549516, 3968.40473928913, 4003.179348233605, 4011.939820902689, 945.4138434170858, 963.8602402651576, 966.0580933589694, 971.4462756228882, 980.475445636581, 19976.500587485138, 21411.250606228707, 21425.89287053586, 21721.239756608444, 21762.347129586138, 974.3033730882453, 974.9421877263107, 978.7308490165119, 998.7153661206667, 1015.9898401016043, 11288.54845806175, 11849.940750296193, 11865.050795936304, 11906.523739050514, 11919.225250358699, 637691.0, 643776.0, 647118.0, 657972.0, 661203.0, 86838.13161868427, 87886.99999999872, 109769.0, 109872.0, 110338.44830775795, 1304.3347892574666, 1342.7773343974734, 1360.6190266725134, 1365.528892532075, 1377.9242141682103, 18951.620967580846, 19614.019299034706, 19685.21259149675, 19701.0, 19724.40826775199, 52407.0, 53277.4672253288, 53407.46592534025, 53505.4649453516, 53673.0, 62542.06186907109, 70621.64689176521, 71261.64369178121, 71636.0, 71868.64065679639, 11786.0, 12137.0, 12651.683707907376, 12753.0, 13291.867081329063, 14231.715365692835, 14264.643383915485, 14286.928565357106, 14293.857061429253, 14393.92803035978, 11809.881901180877, 11848.526058957545, 11886.881131188577, 11907.106966977339, 13020.414081366172, 10912.945435272773, 11177.66467005991, 11295.491702873225, 11299.830502542303, 11718.179727419, 12922.353882305659, 12928.159669621444, 13113.606591802261, 13116.868831311565, 13124.606261812161, 12201.450934708137, 12239.20445171061, 12389.194702344319, 12677.0, 12755.55355562588, 8980.521881652056, 12687.555935542212, 12776.808347874976, 12856.935715321737, 12915.35423228816], "value": 11635.469509102755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.5675297410774, 1593.2750598477694, 1606.357457017193, 1619.643678390754, 1629.9266533006014, 9313.860292095616, 10939.23425360224, 11327.546898124076, 11708.765824683502, 11838.881611183886, 11447.08423326134, 11539.423028848565, 11540.307581545114, 11543.653690389281, 11544.595939142131, 2059.052835695582, 2122.7134336864556, 2511.1964171465092, 2550.681164854393, 2551.170869467421, 2477.8884950177194, 2528.4816612594373, 2535.467551814121, 2541.783948364391, 2548.7196408395153, 2450.215930902112, 2454.275988583372, 2467.222824810179, 2471.950560988779, 2476.529459402717, 2369.336585755991, 2373.7863592276776, 2380.0, 2381.9761802382013, 2412.3245491262473, 2374.1453076892303, 2398.568257713611, 2428.86641234732, 2438.329459398662, 2442.7312995570474, 11539.711507212303, 11644.76710465786, 11651.650450486499, 11662.416879156008, 11670.941645291805, 5770.8268751937085, 5801.24583804107, 6027.7287522061615, 6065.029595264737, 6101.237345331833, 3488.8778892738887, 3590.6588874056924, 3611.6388361163936, 3654.798986055766, 3808.7905165215902, 1323.841139063309, 1358.592422273314, 1385.238119034537, 1400.3628349101134, 1431.4059665238913, 17977.10114494283, 17993.55016124594, 18034.36879709204, 18050.18774155166, 18054.819451805444, 5091.9236211456855, 5279.973600131974, 5319.6808191508635, 5345.610141363273, 5366.490183432567, 13441.0, 13548.525801596898, 13568.253746043865, 13570.0, 13582.728345433234, 6043.546733994968, 6233.438990490878, 6235.127082208494, 6236.345183755731, 6241.469475094577, 4736.265878788793, 4833.709977401367, 5411.891762164734, 5608.719564021782, 5658.405867383948, 4190.664746820247, 4247.5540068293, 4262.65898728101, 4309.612134907873, 4318.827246910151, 1103.9116870650328, 1126.4987080749152, 1132.1282612388416, 1141.4007645985923, 1145.352875625269, 1040.3497813866334, 1057.9047885690325, 1058.3755584205355, 1066.4720963123305, 1075.9354438733544, 7031.507794454441, 7132.857342853217, 7138.393236574845, 7232.132144142736, 7251.601161936039, 1041.4324193314662, 1042.3329069395593, 1055.5619417941623, 1073.5222825842425, 1078.6494389323345, 4730.645201609893, 4816.4220293564995, 4838.516148385203, 4944.703317800943, 5039.042581909425, 13869.445222191, 14338.641533961525, 14401.711965760625, 14897.329620167118, 15107.39570417171, 14682.412703491955, 14699.11805291686, 14781.92609036948, 14789.11265324084, 14827.0, 10604.257701960789, 10735.731606709738, 10821.134309255242, 10853.891461085446, 10858.891411085788, 7587.506812057199, 7736.419768517271, 7806.609669516615, 7839.725609603636, 7960.442769006346, 13129.212247265195, 13143.211407315592, 13257.933710331772, 13370.799438008633, 13445.394957227143, 13749.175049497062, 13792.586222413343, 13802.378892950042, 13827.930860345634, 13916.930415347859, 8379.371547133867, 9466.384684995453, 9773.218142548436, 9784.315097943076, 9952.402855828674, 11247.268927519684, 11316.094712423152, 11350.205485615928, 11372.090232781524, 11373.090152787592, 9022.90977090247, 9329.346945713734, 9460.668876589287, 9462.101100395452, 9537.0, 8829.337799664921, 8833.160849719266, 8901.243394311556, 8905.599248033725, 9014.549272536478, 8421.87367189505, 8522.446041007315, 8587.441816281922, 8601.569921504026, 8634.050254471877, 6059.878802424015, 6069.696515174312, 6112.816615501542, 6163.660998645118, 6258.186435763321, 5685.744141513725, 6219.626822390671, 6277.874442511215, 6302.936970630419, 6536.738530458729], "value": 5499.267258569552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.70830418706873, 436.86893931820447, 440.2164147816886, 442.8627125591067, 454.56361892583124, 5233.633645644802, 5288.524032837044, 5303.4431384704585, 5312.442193569668, 5329.9733501332485, 4944.9121193337405, 5163.302954101196, 5193.376794784622, 5215.400228973669, 5248.8687782805355, 4303.644352029117, 4336.783160841946, 4352.934705979413, 4354.390385346054, 4355.281378572532, 4347.239233134204, 4369.536205371204, 4376.934345984812, 4382.583654552828, 4385.429894113777, 4329.502107257658, 4350.108227813306, 4379.627731642814, 4382.255016647177, 4433.512313645512, 4071.1857628474277, 4343.739375637456, 4366.432363792718, 4382.824687012516, 4411.250087485135, 4082.6529744971713, 4088.795560221977, 4090.8363665453644, 4099.85650502234, 4100.0, 5057.898842023139, 5091.974540127276, 5095.955329157514, 5130.820421285274, 5153.948460515385, 4937.075025354851, 5004.0, 5057.797688092472, 5086.92369614456, 5133.691978481265, 5433.864153396157, 5438.755256013489, 5465.316835395575, 5492.286002819648, 5515.503604675559, 4504.842330518416, 4526.0, 4551.704139230939, 4581.67928245023, 4628.514006029386, 5374.596905232123, 5489.560835133179, 5534.584906132016, 5539.0, 5601.243832082698, 4599.517050709695, 4616.3537104805355, 4634.675572709945, 4700.55344742249, 4797.0, 4718.9292160617615, 4745.7898235949615, 4825.758712064383, 4832.033593281358, 4870.586000189953, 4773.331733557305, 4775.307580400892, 5023.246513023076, 5031.77357018935, 5067.898642027212, 5424.663831743528, 5454.59090568209, 5460.6996615186545, 5507.311586051744, 5539.778408863681, 1633.3629884345114, 1648.8103868055086, 1652.6529428819842, 1655.337864854044, 1655.991720041392, 1218.9207701499552, 1276.310792172235, 1283.5828355784408, 1286.2346903592347, 1306.490468717201, 5167.6641018333685, 5345.732713364317, 5412.810551630674, 5420.945790542123, 5446.836594902159, 5473.890522189534, 5481.725913704299, 5484.0, 5520.3841483828155, 5581.804636837691, 5347.491988261109, 5352.304200453916, 5376.865578360573, 5381.219723140122, 5402.945970540323, 2825.6609206895305, 2951.9704802951696, 2952.6456825180685, 2962.6298960831678, 2974.1672331747145, 5816.447437493432, 5818.709064546756, 5835.328937172195, 5837.153612726131, 5863.0, 5748.396418376094, 5752.741126649227, 5762.2509073820975, 5767.22142510764, 5773.24947756789, 5512.830122679476, 5804.419558044162, 5834.883302334015, 5861.032929566659, 5874.383189765184, 5653.293338332708, 5661.547076233974, 5668.376478587435, 5673.234113394639, 5677.77288908439, 5454.754536045808, 5589.748461319169, 5614.382417934105, 5647.661140331593, 5655.0, 5514.36584792754, 5631.267935168566, 5786.884262314814, 5837.591368604157, 5897.764089436375, 4666.253399456071, 4686.343911852412, 4703.247480403119, 4717.608305549939, 4738.36032135671, 5366.7656439018465, 5629.3112066380745, 5629.480040389154, 5648.915266270927, 5689.943100568941, 5523.619095226193, 5527.972360138174, 5530.336359636869, 5547.389787123332, 5553.0, 5478.849661444606, 5540.556755459473, 5570.86072848182, 5589.664620122806, 5623.738231825613, 5331.333583302087, 5446.264754258124, 5478.945210547843, 5485.915352166151, 5490.870203983851, 5478.479544443271, 5555.611107222618, 5585.385607583244, 5592.384837667934, 5619.409961953936, 5230.607704422107, 5334.359876814807, 5374.570034397317, 5454.890902182014, 5479.0], "value": 4419.529096008194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.2718643764096, 836.5733475927275, 925.6528801699362, 942.5899733615873, 971.5482300730162, 16864.831351686495, 18125.0, 18905.0, 19513.024348782576, 19607.901960490213, 18824.90587547064, 18853.0, 18865.811341886576, 18936.242550298008, 19025.429237122873, 882.2985726347537, 885.0397318908991, 888.6534251641849, 901.1619194149439, 918.481058202117, 902.634433054614, 907.6959218661756, 907.8774365460645, 911.2436677557645, 913.1963871792813, 955.5461155950902, 957.0859828863454, 958.3435346787472, 959.8704174936364, 961.2502248246379, 944.9905500944972, 951.9809603807885, 952.4808979106404, 952.7046615549202, 953.0231512699469, 709.8970649255829, 711.5410560188701, 711.8006958051753, 712.4122598855964, 712.7434123715458, 17766.022868742213, 17792.644147117113, 18020.909895450437, 18719.064046797605, 19081.045947702558, 15833.762493562606, 16080.919595402065, 16248.83751162485, 16327.755083673754, 16467.917660411742, 13512.59462216135, 13621.727565448635, 13992.160470371708, 14005.0, 14035.929820350833, 4039.9596004039877, 4080.469538959916, 4139.461869956916, 4141.399497072937, 4158.2307273154565, 82138.58930705368, 83653.0, 84218.0, 84809.15190848074, 85744.0, 11306.095512358992, 11404.144689148347, 11431.14266430021, 11437.0, 11796.76406471883, 23218.53562928732, 23463.648045279333, 23672.28983130509, 23688.763112369, 23715.407114821923, 8580.613872375758, 8654.394192406471, 8762.299016078698, 8789.252913502423, 8817.559122043873, 4728.8801963797505, 4850.151223535867, 4857.222844344888, 4960.751962401865, 4971.850844474671, 3786.981065094657, 3837.788921609338, 3850.2876967760494, 3853.5761066282685, 3886.630770076838, 623.6725718997562, 624.7594676049663, 630.6373835044867, 631.5768435148461, 639.5427269502235, 835.757630287222, 850.4047166983013, 868.7046404222594, 878.8286284174652, 881.0924747510074, 10379.429131397847, 10535.209859260585, 10787.568497260021, 10849.0, 10947.56209751617, 823.4812068396872, 832.4173078844833, 836.180543067797, 849.9872501912477, 856.5032281276845, 5306.363236411656, 5399.460053994648, 5481.369642491165, 5482.259894914216, 5504.6421982571, 80066.5996670013, 80280.78876844977, 81075.0, 81942.51793517965, 83606.0, 67760.32239677639, 68833.65583172052, 69087.3091269091, 69118.0, 69378.0, 55647.0, 57306.42693573011, 61779.0, 61995.690021549606, 62478.0, 10544.103751180928, 11184.0, 11187.888121118685, 11199.72000699989, 11388.487518061873, 36175.81912090423, 37261.0, 38088.23823523459, 40226.79886600548, 43176.0, 53901.46098539121, 54243.45756542384, 55778.72110639421, 55931.44068559425, 56184.719076404355, 13344.199348039148, 13446.327683615977, 13749.518766843512, 13770.380332884844, 13885.0, 16174.433894813625, 16418.67162656764, 16561.83438165651, 16770.748438773186, 16798.160091995596, 14946.626334341294, 15304.31130599148, 15511.379544818532, 16024.198790060684, 16398.0, 14496.420143194155, 14701.264936753334, 15148.394064237307, 15639.218039098227, 15694.293756780744, 15167.241637918281, 15374.231288435758, 15572.377104915677, 16375.263113160174, 16382.443667851536, 9758.9024109758, 10096.141827944413, 10210.540525676213, 10611.204159688208, 10677.199210059121, 11153.386563739072, 11351.37567433799, 12167.2699638022, 12372.690682732644, 12432.689182770504], "value": 7924.0297694351675, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 110.0, 112.0, 112.0, 110.0, 112.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 121.0, 116.0, 162.0, 121.0, 116.0, 115.0, 118.0, 134.0, 115.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 159.0, 165.0, 159.0, 161.0, 162.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 110.0, 76.0, 76.0, 76.0, 74.0, 92.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 104.0, 82.0, 83.0, 83.0, 97.0, 82.0, 82.0, 111.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 52.0, 52.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 80.0, 82.0, 81.0, 79.0, 80.0, 75.0, 81.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 131.0, 122.0, 120.0, 119.0, 125.0, 118.0, 124.0, 166.0, 138.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 162.0, 158.0, 169.0, 160.0, 159.0, 159.0, 159.0, 157.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 61.0, 59.0, 61.0, 60.0, 59.0, 60.0, 58.0], "value": 60.1, "unit": "score"}]}]} 02:01:07 INFO - Return code: 0 02:01:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:01:07 ERROR - # TBPL SUCCESS # 02:01:07 INFO - Running post-action listener: _resource_record_post_action 02:01:07 INFO - [mozharness: 2017-05-07 09:01:07.799848Z] Finished run-tests step (success) 02:01:07 INFO - Running post-run listener: _resource_record_post_run 02:01:07 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7815168; Write bytes: 364941312; Read time: 2128; Write time: 178324 02:01:07 INFO - TinderboxPrint: CPU usage
13.1% 02:01:07 INFO - TinderboxPrint: I/O read bytes / time
7,815,168 / 2,128 02:01:07 INFO - TinderboxPrint: I/O write bytes / time
364,941,312 / 178,324 02:01:07 INFO - TinderboxPrint: CPU idle
8,278.9 (86.9%) 02:01:07 INFO - TinderboxPrint: CPU user
1,203.0 (12.6%) 02:01:07 INFO - TinderboxPrint: Swap in / out
0 / 0 02:01:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110194688; Read time: 0; Write time: 67996 02:01:07 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6070272; Write bytes: 254746624; Read time: 2084; Write time: 110328 02:01:08 INFO - Running post-run listener: _upload_blobber_files 02:01:08 INFO - Blob upload gear active. 02:01:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:01:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:01:09 INFO - (blobuploader) - INFO - Open directory for files ... 02:01:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:01:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:01:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:10 INFO - (blobuploader) - INFO - Done attempting. 02:01:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:01:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:01:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:11 INFO - (blobuploader) - INFO - Done attempting. 02:01:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:01:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:01:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:14 INFO - (blobuploader) - INFO - Done attempting. 02:01:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:01:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:15 INFO - (blobuploader) - INFO - Done attempting. 02:01:15 INFO - (blobuploader) - INFO - Iteration through files over. 02:01:15 INFO - Return code: 0 02:01:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:01:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:01:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/17eeb49664b04a97453f24c8f254d0c70e4222cf9d48641a97096d63fa8bf81160f6137c5057df08533eb60d16bcd71bc11730760d130b8c77d309f646f08f1f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8516ceda15dd63ea8fc1ad5630d937e68bbc170d60011dc2ebba9a33b764904bdd86ac3e9c372484ad923956786294baa1b6dce51ef82a36da20be1e37f5d683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/33f401e1471b204662590b97b7b2ed695b3f89a54cd556bcddf0d73500b190bf01756ec4d0880e44ace4e20717d86d27f4ded93caffd782bae76dc36c4d9bc91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/af200e034b6776a6e584af7c03dcbe75ff87d68770c558f2d723dc079c30e7447b77717d7210b82a153d2e124c9f1dd9b8f3ea46d9f210c01f784b3dbe5eee53"} 02:01:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:01:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:01:15 INFO - Contents: 02:01:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/17eeb49664b04a97453f24c8f254d0c70e4222cf9d48641a97096d63fa8bf81160f6137c5057df08533eb60d16bcd71bc11730760d130b8c77d309f646f08f1f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8516ceda15dd63ea8fc1ad5630d937e68bbc170d60011dc2ebba9a33b764904bdd86ac3e9c372484ad923956786294baa1b6dce51ef82a36da20be1e37f5d683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/33f401e1471b204662590b97b7b2ed695b3f89a54cd556bcddf0d73500b190bf01756ec4d0880e44ace4e20717d86d27f4ded93caffd782bae76dc36c4d9bc91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/af200e034b6776a6e584af7c03dcbe75ff87d68770c558f2d723dc079c30e7447b77717d7210b82a153d2e124c9f1dd9b8f3ea46d9f210c01f784b3dbe5eee53"} 02:01:15 INFO - Running post-run listener: copy_logs_to_upload_dir 02:01:15 INFO - Copying logs to upload dir... 02:01:15 INFO - mkdir: /builds/slave/test/build/upload/logs 02:01:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.932850 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-05-07 02:01:15.373804) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 02:01:15.377041) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/17eeb49664b04a97453f24c8f254d0c70e4222cf9d48641a97096d63fa8bf81160f6137c5057df08533eb60d16bcd71bc11730760d130b8c77d309f646f08f1f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8516ceda15dd63ea8fc1ad5630d937e68bbc170d60011dc2ebba9a33b764904bdd86ac3e9c372484ad923956786294baa1b6dce51ef82a36da20be1e37f5d683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/33f401e1471b204662590b97b7b2ed695b3f89a54cd556bcddf0d73500b190bf01756ec4d0880e44ace4e20717d86d27f4ded93caffd782bae76dc36c4d9bc91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/af200e034b6776a6e584af7c03dcbe75ff87d68770c558f2d723dc079c30e7447b77717d7210b82a153d2e124c9f1dd9b8f3ea46d9f210c01f784b3dbe5eee53"} build_url:https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/UdlQ-uUqQfeZLQTefxU-Qg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/17eeb49664b04a97453f24c8f254d0c70e4222cf9d48641a97096d63fa8bf81160f6137c5057df08533eb60d16bcd71bc11730760d130b8c77d309f646f08f1f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8516ceda15dd63ea8fc1ad5630d937e68bbc170d60011dc2ebba9a33b764904bdd86ac3e9c372484ad923956786294baa1b6dce51ef82a36da20be1e37f5d683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/33f401e1471b204662590b97b7b2ed695b3f89a54cd556bcddf0d73500b190bf01756ec4d0880e44ace4e20717d86d27f4ded93caffd782bae76dc36c4d9bc91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/af200e034b6776a6e584af7c03dcbe75ff87d68770c558f2d723dc079c30e7447b77717d7210b82a153d2e124c9f1dd9b8f3ea46d9f210c01f784b3dbe5eee53"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 02:01:15.402628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 02:01:15.402943) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494140395.900048-2019381641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 02:01:15.487489) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 02:01:15.487814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 02:01:15.488133) ========= ========= Total master_lag: 0.07 =========