builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1494245879.88 results: success (0) revision: 1fda52a1f3b81cf1a821155998dca637bb64e3d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 05:17:59.878387) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 05:17:59.878834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 05:17:59.879135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 05:17:59.894305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:17:59.894600) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1494243217.520519-1649372740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 05:18:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-05-08 05:18:01 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.069903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.070235) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1494243217.520519-1649372740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023066 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.119972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.120322) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1fda52a1f3b81cf1a821155998dca637bb64e3d9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 1fda52a1f3b81cf1a821155998dca637bb64e3d9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1494243217.520519-1649372740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 05:18:01,422 truncating revision to first 12 chars 2017-05-08 05:18:01,422 Setting DEBUG logging. 2017-05-08 05:18:01,422 attempt 1/10 2017-05-08 05:18:01,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1fda52a1f3b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 05:18:01,718 unpacking tar archive at: mozilla-central-1fda52a1f3b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.857997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.858307) ========= script_repo_revision: 1fda52a1f3b81cf1a821155998dca637bb64e3d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.858661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.858919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 05:18:00.870776) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-08 05:18:00.871151) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1494243217.520519-1649372740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:18:02 INFO - MultiFileLogger online at 20170508 05:18:02 in /builds/slave/test 05:18:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:18:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:02 INFO - {'append_to_log': False, 05:18:02 INFO - 'base_work_dir': '/builds/slave/test', 05:18:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:18:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:02 INFO - 'branch': 'Firefox-Non-PGO', 05:18:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:02 INFO - 'config_files': ('talos/linux_config.py',), 05:18:02 INFO - 'default_actions': ('clobber', 05:18:02 INFO - 'read-buildbot-config', 05:18:02 INFO - 'download-and-extract', 05:18:02 INFO - 'populate-webroot', 05:18:02 INFO - 'create-virtualenv', 05:18:02 INFO - 'install', 05:18:02 INFO - 'run-tests'), 05:18:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:02 INFO - 'download_minidump_stackwalk': True, 05:18:02 INFO - 'download_symbols': 'ondemand', 05:18:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:02 INFO - 'gecko_profile': False, 05:18:02 INFO - 'gecko_profile_interval': 0, 05:18:02 INFO - 'installer_path': 'installer.exe', 05:18:02 INFO - 'log_level': 'info', 05:18:02 INFO - 'log_name': 'talos', 05:18:02 INFO - 'log_to_console': True, 05:18:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:18:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:18:02 INFO - 'opt_config_files': (), 05:18:02 INFO - 'pip_index': False, 05:18:02 INFO - 'suite': 'dromaeojs', 05:18:02 INFO - 'system_bits': '32', 05:18:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:02 INFO - 'title': 'talos-linux64-ix-032', 05:18:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:02 INFO - 'use_talos_json': True, 05:18:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:02 INFO - 'work_dir': 'build'} 05:18:02 INFO - [mozharness: 2017-05-08 12:18:02.271789Z] Running clobber step. 05:18:02 INFO - Running pre-action listener: _resource_record_pre_action 05:18:02 INFO - Running main action method: clobber 05:18:02 INFO - rmtree: /builds/slave/test/build 05:18:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:03 INFO - Running post-action listener: _resource_record_post_action 05:18:03 INFO - [mozharness: 2017-05-08 12:18:03.212725Z] Finished clobber step (success) 05:18:03 INFO - [mozharness: 2017-05-08 12:18:03.212827Z] Running read-buildbot-config step. 05:18:03 INFO - Running pre-action listener: _resource_record_pre_action 05:18:03 INFO - Running main action method: read_buildbot_config 05:18:03 INFO - Using buildbot properties: 05:18:03 INFO - { 05:18:03 INFO - "project": "", 05:18:03 INFO - "product": "firefox", 05:18:03 INFO - "who": "nobody@mozilla.org", 05:18:03 INFO - "installer_path": "public/build/target.tar.bz2", 05:18:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:18:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:18:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:18:03 INFO - "stage_platform": "linux64", 05:18:03 INFO - "basedir": "/builds/slave/test", 05:18:03 INFO - "buildnumber": 1134, 05:18:03 INFO - "platform": "ubuntu64_hw", 05:18:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:18:03 INFO - "slavebuilddir": "test", 05:18:03 INFO - "taskId": "VkywbtJoSua1zxsh_G7Mlg", 05:18:03 INFO - "branch": "mozilla-central", 05:18:03 INFO - "script_repo_revision": "production", 05:18:03 INFO - "revision": "1fda52a1f3b81cf1a821155998dca637bb64e3d9", 05:18:03 INFO - "slavename": "talos-linux64-ix-032", 05:18:03 INFO - "repo_path": "mozilla-central" 05:18:03 INFO - } 05:18:03 INFO - Finding installer, test and symbols from parent task. 05:18:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VkywbtJoSua1zxsh_G7Mlg'}, attempt #1 05:18:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VkywbtJoSua1zxsh_G7Mlg'}, attempt #1 05:18:04 INFO - Task dependencies: Ux01QjPkRBa95o8xlSG6LQ 05:18:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ'}, attempt #1 05:18:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.tar.bz2 05:18:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/test_packages.json 05:18:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.crashreporter-symbols.zip 05:18:04 INFO - Running post-action listener: _resource_record_post_action 05:18:04 INFO - [mozharness: 2017-05-08 12:18:04.604201Z] Finished read-buildbot-config step (success) 05:18:04 INFO - [mozharness: 2017-05-08 12:18:04.604420Z] Running download-and-extract step. 05:18:04 INFO - Running pre-action listener: _resource_record_pre_action 05:18:04 INFO - Running main action method: download_and_extract 05:18:04 INFO - mkdir: /builds/slave/test/build/tests 05:18: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')]} 05:18:04 INFO - trying https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.test_packages.json 05:18:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:18:05 INFO - Downloaded 986 bytes. 05:18:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:18:05 INFO - Using the following test package requirements: 05:18:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:18:05 INFO - u'common': [u'target.common.tests.zip'], 05:18:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:18:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:18:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:18:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:18:05 INFO - u'mozbase': [u'target.common.tests.zip'], 05:18:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:18:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:18:05 INFO - u'web-platform': [u'target.common.tests.zip', 05:18:05 INFO - u'target.web-platform.tests.zip'], 05:18:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:18:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:18:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.common.tests.zip 05:18:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:18:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.common.tests.zip into memory 05:18:06 INFO - Content-Length response header: 60564935 05:18:06 INFO - Bytes received: 60564935 05:18:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:18:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.common.tests.zip 05:18:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:18:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.common.tests.zip into memory 05:18:17 INFO - Content-Length response header: 60564935 05:18:17 INFO - Bytes received: 60564935 05:18:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.talos.tests.zip 05:18:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:18:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.talos.tests.zip into memory 05:18:29 INFO - Content-Length response header: 14409362 05:18:29 INFO - Bytes received: 14409362 05:18:29 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')]} 05:18:29 INFO - trying https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.tar.bz2 05:18:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:18:30 INFO - Downloaded 64038401 bytes. 05:18:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.tar.bz2 05:18:30 INFO - mkdir: /builds/slave/test/properties 05:18:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:30 INFO - Contents: 05:18:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.tar.bz2 05:18:30 INFO - Running post-action listener: _resource_record_post_action 05:18:30 INFO - Running post-action listener: set_extra_try_arguments 05:18:30 INFO - [mozharness: 2017-05-08 12:18:30.566380Z] Finished download-and-extract step (success) 05:18:30 INFO - [mozharness: 2017-05-08 12:18:30.566477Z] Running populate-webroot step. 05:18:30 INFO - Running pre-action listener: _resource_record_pre_action 05:18:30 INFO - Running main action method: populate_webroot 05:18:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:30 INFO - '--tppagecycles', 05:18:30 INFO - '7'], 05:18:30 INFO - 'tests': ['tsvgm']}}, 05:18:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:18:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:18:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:18:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:18:30 INFO - 'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:18:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:18:30 INFO - 'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['damp', 'tps']}, 05:18:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:18:30 INFO - 'tests': ['damp', 'tps']}, 05:18:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['dromaeo_dom']}, 05:18:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:18:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:18:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['a11yr', 05:18:30 INFO - 'ts_paint', 05:18:30 INFO - 'tpaint', 05:18:30 INFO - 'sessionrestore', 05:18:30 INFO - 'sessionrestore_no_auto_restore', 05:18:30 INFO - 'tabpaint']}, 05:18:30 INFO - 'other-e10s': {'tests': ['a11yr', 05:18:30 INFO - 'ts_paint', 05:18:30 INFO - 'tpaint', 05:18:30 INFO - 'sessionrestore', 05:18:30 INFO - 'sessionrestore_no_auto_restore', 05:18:30 INFO - 'tabpaint']}, 05:18:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:18:30 INFO - 'ts_paint', 05:18:30 INFO - 'tpaint', 05:18:30 INFO - 'sessionrestore', 05:18:30 INFO - 'sessionrestore_no_auto_restore', 05:18:30 INFO - 'tabpaint']}, 05:18:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:18:30 INFO - 'ts_paint', 05:18:30 INFO - 'tpaint', 05:18:30 INFO - 'sessionrestore', 05:18:30 INFO - 'sessionrestore_no_auto_restore', 05:18:30 INFO - 'tabpaint']}, 05:18:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['a11yr', 05:18:30 INFO - 'ts_paint', 05:18:30 INFO - 'tpaint', 05:18:30 INFO - 'sessionrestore', 05:18:30 INFO - 'sessionrestore_no_auto_restore', 05:18:30 INFO - 'tabpaint']}, 05:18:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['a11yr', 05:18:30 INFO - 'ts_paint', 05:18:30 INFO - 'tpaint', 05:18:30 INFO - 'sessionrestore', 05:18:30 INFO - 'sessionrestore_no_auto_restore', 05:18:30 INFO - 'tabpaint']}, 05:18:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:18:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:18:30 INFO - 'bloom_basic_ref']}, 05:18:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['tsvgx', 05:18:30 INFO - 'tsvgr_opacity', 05:18:30 INFO - 'tart', 05:18:30 INFO - 'tscrollx', 05:18:30 INFO - 'cart', 05:18:30 INFO - 'tsvg_static']}, 05:18:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:18:30 INFO - 'tsvgr_opacity', 05:18:30 INFO - 'tart', 05:18:30 INFO - 'tscrollx', 05:18:30 INFO - 'cart', 05:18:30 INFO - 'tsvg_static']}, 05:18:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:18:30 INFO - 'talos_options': ['--disable-e10s'], 05:18:30 INFO - 'tests': ['tp5o']}, 05:18:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:18:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:18:30 INFO - 'talos_options': ['--disable-e10s', 05:18:30 INFO - '--xperf_path', 05:18:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:30 INFO - 'tests': ['tp5n']}, 05:18:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:18:30 INFO - 'talos_options': ['--xperf_path', 05:18:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:30 INFO - 'tests': ['tp5n']}}, 05:18:30 INFO - 'talos.zip': {'path': '', 05:18:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:30 INFO - Running post-action listener: _resource_record_post_action 05:18:30 INFO - [mozharness: 2017-05-08 12:18:30.580084Z] Finished populate-webroot step (success) 05:18:30 INFO - [mozharness: 2017-05-08 12:18:30.580177Z] Running create-virtualenv step. 05:18:30 INFO - Running pre-action listener: _resource_record_pre_action 05:18:30 INFO - Running main action method: create_virtualenv 05:18:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:30 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 05:18:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:30 INFO - Using real prefix '/usr' 05:18:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:33 INFO - Installing pip.................done. 05:18:33 INFO - Return code: 0 05:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:18:33 INFO - Reading from file tmpfile_stdout 05:18:33 INFO - Output received: 05:18:33 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) 05:18:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18:33 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')]} 05:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:33 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')]} 05:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:33 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:33 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 05:18:33 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 05:18:33 INFO - Using env: {'DISPLAY': ':0', 05:18:33 INFO - 'HOME': '/home/cltbld', 05:18:33 INFO - 'LANG': 'en_US.UTF-8', 05:18:33 INFO - 'LANGUAGE': 'en_US:en', 05:18:33 INFO - 'LOGNAME': 'cltbld', 05:18:33 INFO - 'MAIL': '/var/mail/cltbld', 05:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:33 INFO - 'MOZ_NO_REMOTE': '1', 05:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:33 INFO - 'NO_EM_RESTART': '1', 05:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:33 INFO - 'PWD': '/builds/slave/test', 05:18:33 INFO - 'SHELL': '/bin/bash', 05:18:33 INFO - 'SHLVL': '1', 05:18:33 INFO - 'TERM': 'linux', 05:18:33 INFO - 'TMOUT': '86400', 05:18:33 INFO - 'USER': 'cltbld', 05:18:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:33 INFO - '_': '/tools/buildbot/bin/python'} 05:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:33 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 05:18:33 INFO - Cleaning up... 05:18:33 INFO - Return code: 0 05:18:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:18:33 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')]} 05:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:33 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')]} 05:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:33 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:33 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 05:18:33 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 05:18:33 INFO - Using env: {'DISPLAY': ':0', 05:18:33 INFO - 'HOME': '/home/cltbld', 05:18:33 INFO - 'LANG': 'en_US.UTF-8', 05:18:33 INFO - 'LANGUAGE': 'en_US:en', 05:18:33 INFO - 'LOGNAME': 'cltbld', 05:18:33 INFO - 'MAIL': '/var/mail/cltbld', 05:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:33 INFO - 'MOZ_NO_REMOTE': '1', 05:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:33 INFO - 'NO_EM_RESTART': '1', 05:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:33 INFO - 'PWD': '/builds/slave/test', 05:18:33 INFO - 'SHELL': '/bin/bash', 05:18:33 INFO - 'SHLVL': '1', 05:18:33 INFO - 'TERM': 'linux', 05:18:33 INFO - 'TMOUT': '86400', 05:18:33 INFO - 'USER': 'cltbld', 05:18:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:33 INFO - '_': '/tools/buildbot/bin/python'} 05:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:33 INFO - Downloading/unpacking psutil>=3.1.1 05:18:33 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 05:18:33 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 05:18:33 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 05:18:33 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 05:18:33 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 05:18:33 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 05:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:35 INFO - Installing collected packages: psutil 05:18:35 INFO - Running setup.py install for psutil 05:18:35 INFO - building 'psutil._psutil_linux' extension 05:18:35 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 05:18:35 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 05:18:35 INFO - building 'psutil._psutil_posix' extension 05:18:35 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 05:18:35 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 05:18:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:35 INFO - Successfully installed psutil 05:18:35 INFO - Cleaning up... 05:18:35 INFO - Return code: 0 05:18:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:18:35 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')]} 05:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 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')]} 05:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:35 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 05:18:35 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 05:18:35 INFO - Using env: {'DISPLAY': ':0', 05:18:35 INFO - 'HOME': '/home/cltbld', 05:18:35 INFO - 'LANG': 'en_US.UTF-8', 05:18:35 INFO - 'LANGUAGE': 'en_US:en', 05:18:35 INFO - 'LOGNAME': 'cltbld', 05:18:35 INFO - 'MAIL': '/var/mail/cltbld', 05:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:35 INFO - 'MOZ_NO_REMOTE': '1', 05:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:35 INFO - 'NO_EM_RESTART': '1', 05:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:35 INFO - 'PWD': '/builds/slave/test', 05:18:35 INFO - 'SHELL': '/bin/bash', 05:18:35 INFO - 'SHLVL': '1', 05:18:35 INFO - 'TERM': 'linux', 05:18:35 INFO - 'TMOUT': '86400', 05:18:35 INFO - 'USER': 'cltbld', 05:18:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:35 INFO - '_': '/tools/buildbot/bin/python'} 05:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:18:35 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 05:18:35 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 05:18:35 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 05:18:35 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 05:18:35 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 05:18:35 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 05:18:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:18:36 INFO - Installing collected packages: mozsystemmonitor 05:18:36 INFO - Running setup.py install for mozsystemmonitor 05:18:37 INFO - Successfully installed mozsystemmonitor 05:18:37 INFO - Cleaning up... 05:18:37 INFO - Return code: 0 05:18:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:18:37 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')]} 05:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:37 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')]} 05:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:37 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:37 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 05:18:37 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 05:18:37 INFO - Using env: {'DISPLAY': ':0', 05:18:37 INFO - 'HOME': '/home/cltbld', 05:18:37 INFO - 'LANG': 'en_US.UTF-8', 05:18:37 INFO - 'LANGUAGE': 'en_US:en', 05:18:37 INFO - 'LOGNAME': 'cltbld', 05:18:37 INFO - 'MAIL': '/var/mail/cltbld', 05:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:37 INFO - 'MOZ_NO_REMOTE': '1', 05:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:37 INFO - 'NO_EM_RESTART': '1', 05:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:37 INFO - 'PWD': '/builds/slave/test', 05:18:37 INFO - 'SHELL': '/bin/bash', 05:18:37 INFO - 'SHLVL': '1', 05:18:37 INFO - 'TERM': 'linux', 05:18:37 INFO - 'TMOUT': '86400', 05:18:37 INFO - 'USER': 'cltbld', 05:18:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:37 INFO - '_': '/tools/buildbot/bin/python'} 05:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:37 INFO - Downloading/unpacking jsonschema==2.5.1 05:18:37 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 05:18:37 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 05:18:37 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 05:18:37 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 05:18:37 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 05:18:37 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 05:18:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:18:38 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 05:18:38 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 05:18:38 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 05:18:38 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 05:18:38 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 05:18:38 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 05:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:38 INFO - warning: no files found matching '*.txt' 05:18:38 INFO - no previously-included directories found matching 'build' 05:18:38 INFO - no previously-included directories found matching 'dist' 05:18:38 INFO - no previously-included directories found matching '.git*' 05:18:38 INFO - Installing collected packages: jsonschema, functools32 05:18:38 INFO - Running setup.py install for functools32 05:18:38 INFO - warning: no files found matching '*.txt' 05:18:38 INFO - no previously-included directories found matching 'build' 05:18:38 INFO - no previously-included directories found matching 'dist' 05:18:38 INFO - no previously-included directories found matching '.git*' 05:18:38 INFO - Successfully installed jsonschema functools32 05:18:38 INFO - Cleaning up... 05:18:38 INFO - Return code: 0 05:18:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:38 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:38 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 05:18:38 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 05:18:38 INFO - Using env: {'DISPLAY': ':0', 05:18:38 INFO - 'HOME': '/home/cltbld', 05:18:38 INFO - 'LANG': 'en_US.UTF-8', 05:18:38 INFO - 'LANGUAGE': 'en_US:en', 05:18:38 INFO - 'LOGNAME': 'cltbld', 05:18:38 INFO - 'MAIL': '/var/mail/cltbld', 05:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:38 INFO - 'MOZ_NO_REMOTE': '1', 05:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:38 INFO - 'NO_EM_RESTART': '1', 05:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:38 INFO - 'PWD': '/builds/slave/test', 05:18:38 INFO - 'SHELL': '/bin/bash', 05:18:38 INFO - 'SHLVL': '1', 05:18:38 INFO - 'TERM': 'linux', 05:18:38 INFO - 'TMOUT': '86400', 05:18:38 INFO - 'USER': 'cltbld', 05:18:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:38 INFO - '_': '/tools/buildbot/bin/python'} 05:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:18:39 INFO - Cleaning up... 05:18:39 INFO - Return code: 0 05:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:39 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')]} 05:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:39 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')]} 05:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:39 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:39 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 05:18:39 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 05:18:39 INFO - Using env: {'DISPLAY': ':0', 05:18:39 INFO - 'HOME': '/home/cltbld', 05:18:39 INFO - 'LANG': 'en_US.UTF-8', 05:18:39 INFO - 'LANGUAGE': 'en_US:en', 05:18:39 INFO - 'LOGNAME': 'cltbld', 05:18:39 INFO - 'MAIL': '/var/mail/cltbld', 05:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:39 INFO - 'MOZ_NO_REMOTE': '1', 05:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:39 INFO - 'NO_EM_RESTART': '1', 05:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:39 INFO - 'PWD': '/builds/slave/test', 05:18:39 INFO - 'SHELL': '/bin/bash', 05:18:39 INFO - 'SHLVL': '1', 05:18:39 INFO - 'TERM': 'linux', 05:18:39 INFO - 'TMOUT': '86400', 05:18:39 INFO - 'USER': 'cltbld', 05:18:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:39 INFO - '_': '/tools/buildbot/bin/python'} 05:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:39 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 05:18:39 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 05:18:39 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 05:18:39 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 05:18:39 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 05:18:39 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 05:18:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:40 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 05:18:40 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 05:18:40 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 05:18:40 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 05:18:40 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 05:18:40 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 05:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:40 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 05:18:40 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 05:18:40 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 05:18:40 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 05:18:40 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 05:18:40 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 05:18:40 INFO - Downloading docopt-0.6.1.tar.gz 05:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:41 INFO - Running setup.py install for blobuploader 05:18:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:41 INFO - Running setup.py install for requests 05:18:41 INFO - Running setup.py install for docopt 05:18:41 INFO - Successfully installed blobuploader requests docopt 05:18:41 INFO - Cleaning up... 05:18:41 INFO - Return code: 0 05:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:41 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:41 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 05:18:41 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 05:18:41 INFO - Using env: {'DISPLAY': ':0', 05:18:41 INFO - 'HOME': '/home/cltbld', 05:18:41 INFO - 'LANG': 'en_US.UTF-8', 05:18:41 INFO - 'LANGUAGE': 'en_US:en', 05:18:41 INFO - 'LOGNAME': 'cltbld', 05:18:41 INFO - 'MAIL': '/var/mail/cltbld', 05:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:41 INFO - 'MOZ_NO_REMOTE': '1', 05:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:41 INFO - 'NO_EM_RESTART': '1', 05:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:41 INFO - 'PWD': '/builds/slave/test', 05:18:41 INFO - 'SHELL': '/bin/bash', 05:18:41 INFO - 'SHLVL': '1', 05:18:41 INFO - 'TERM': 'linux', 05:18:41 INFO - 'TMOUT': '86400', 05:18:41 INFO - 'USER': 'cltbld', 05:18:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:41 INFO - '_': '/tools/buildbot/bin/python'} 05:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:42 INFO - Running setup.py (path:/tmp/pip-KS4r_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:42 INFO - Running setup.py (path:/tmp/pip-yBefCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:42 INFO - Running setup.py (path:/tmp/pip-rr2a53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:42 INFO - Running setup.py (path:/tmp/pip-U_SLO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:42 INFO - Running setup.py (path:/tmp/pip-hho6RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:42 INFO - Running setup.py (path:/tmp/pip-bUGdH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:42 INFO - Running setup.py (path:/tmp/pip-QlCKNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:42 INFO - Running setup.py (path:/tmp/pip-049vuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:42 INFO - Running setup.py (path:/tmp/pip-Sm49jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:42 INFO - Running setup.py (path:/tmp/pip-wRcPQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:42 INFO - Running setup.py (path:/tmp/pip-PMaQtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:42 INFO - Running setup.py (path:/tmp/pip-FsS_pC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:42 INFO - Running setup.py (path:/tmp/pip-y30UfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:42 INFO - Running setup.py (path:/tmp/pip-k4MAvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:43 INFO - Running setup.py (path:/tmp/pip-apkF99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:43 INFO - Running setup.py (path:/tmp/pip-wuiKdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:43 INFO - Running setup.py (path:/tmp/pip-T7B6ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:43 INFO - Running setup.py install for manifestparser 05:18:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Running setup.py install for mozcrash 05:18:43 INFO - Running setup.py install for mozdebug 05:18:43 INFO - Running setup.py install for mozdevice 05:18:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Running setup.py install for mozfile 05:18:43 INFO - Running setup.py install for mozhttpd 05:18:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Running setup.py install for mozinfo 05:18:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Running setup.py install for mozInstall 05:18:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Running setup.py install for mozleak 05:18:44 INFO - Running setup.py install for mozlog 05:18:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:44 INFO - Running setup.py install for moznetwork 05:18:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:44 INFO - Running setup.py install for mozprocess 05:18:44 INFO - Running setup.py install for mozprofile 05:18:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:44 INFO - Running setup.py install for mozrunner 05:18:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:44 INFO - Running setup.py install for mozscreenshot 05:18:44 INFO - Running setup.py install for moztest 05:18:44 INFO - Running setup.py install for mozversion 05:18:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:44 INFO - Cleaning up... 05:18:44 INFO - Return code: 0 05:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:44 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:44 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 05:18:44 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 05:18:44 INFO - Using env: {'DISPLAY': ':0', 05:18:44 INFO - 'HOME': '/home/cltbld', 05:18:44 INFO - 'LANG': 'en_US.UTF-8', 05:18:44 INFO - 'LANGUAGE': 'en_US:en', 05:18:44 INFO - 'LOGNAME': 'cltbld', 05:18:44 INFO - 'MAIL': '/var/mail/cltbld', 05:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:44 INFO - 'MOZ_NO_REMOTE': '1', 05:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:44 INFO - 'NO_EM_RESTART': '1', 05:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:44 INFO - 'PWD': '/builds/slave/test', 05:18:44 INFO - 'SHELL': '/bin/bash', 05:18:44 INFO - 'SHLVL': '1', 05:18:44 INFO - 'TERM': 'linux', 05:18:44 INFO - 'TMOUT': '86400', 05:18:44 INFO - 'USER': 'cltbld', 05:18:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:44 INFO - '_': '/tools/buildbot/bin/python'} 05:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:45 INFO - Running setup.py (path:/tmp/pip-RzjpHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:45 INFO - Running setup.py (path:/tmp/pip-F7oC5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:45 INFO - Running setup.py (path:/tmp/pip-y2Ep4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:45 INFO - Running setup.py (path:/tmp/pip-kTfHNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:45 INFO - Running setup.py (path:/tmp/pip-o5VJIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:45 INFO - Running setup.py (path:/tmp/pip-yDi4lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:45 INFO - Running setup.py (path:/tmp/pip-faIGWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:45 INFO - Running setup.py (path:/tmp/pip-TYrmcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:45 INFO - Running setup.py (path:/tmp/pip-xEwo6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:45 INFO - Running setup.py (path:/tmp/pip-UIS5cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:45 INFO - Running setup.py (path:/tmp/pip-OrhItU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:45 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)) 05:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:45 INFO - Running setup.py (path:/tmp/pip-tWmRmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:46 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)) 05:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:46 INFO - Running setup.py (path:/tmp/pip-UFu9Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:46 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)) 05:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:46 INFO - Running setup.py (path:/tmp/pip-gJXyNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:46 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)) 05:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:46 INFO - Running setup.py (path:/tmp/pip-kDdVf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:46 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)) 05:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:46 INFO - Running setup.py (path:/tmp/pip-EPWEtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:46 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)) 05:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:46 INFO - Running setup.py (path:/tmp/pip-lmWEXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:46 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)) 05:18:46 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)) 05:18:46 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)) 05:18:46 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)) 05:18:46 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:46 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:47 INFO - Downloading blessings-1.6.tar.gz 05:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:47 INFO - Installing collected packages: blessings 05:18:47 INFO - Running setup.py install for blessings 05:18:47 INFO - Successfully installed blessings 05:18:47 INFO - Cleaning up... 05:18:47 INFO - Return code: 0 05:18:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:47 INFO - Reading from file tmpfile_stdout 05:18:47 INFO - Current package versions: 05:18:47 INFO - argparse == 1.2.1 05:18:47 INFO - blessings == 1.6 05:18:47 INFO - blobuploader == 1.2.4 05:18:47 INFO - docopt == 0.6.1 05:18:47 INFO - functools32 == 3.2.3-2 05:18:47 INFO - jsonschema == 2.5.1 05:18:47 INFO - manifestparser == 1.1 05:18:47 INFO - mozInstall == 1.12 05:18:47 INFO - mozcrash == 1.0 05:18:47 INFO - mozdebug == 0.1 05:18:47 INFO - mozdevice == 0.50 05:18:47 INFO - mozfile == 1.2 05:18:47 INFO - mozhttpd == 0.7 05:18:47 INFO - mozinfo == 0.9 05:18:47 INFO - mozleak == 0.1 05:18:47 INFO - mozlog == 3.4 05:18:47 INFO - moznetwork == 0.27 05:18:47 INFO - mozprocess == 0.25 05:18:47 INFO - mozprofile == 0.28 05:18:47 INFO - mozrunner == 6.13 05:18:47 INFO - mozscreenshot == 0.1 05:18:47 INFO - mozsystemmonitor == 0.3 05:18:47 INFO - moztest == 0.8 05:18:47 INFO - mozversion == 1.4 05:18:47 INFO - psutil == 3.1.1 05:18:47 INFO - requests == 1.2.3 05:18:47 INFO - wsgiref == 0.1.2 05:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:47 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:47 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 05:18:47 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 05:18:47 INFO - Using env: {'DISPLAY': ':0', 05:18:47 INFO - 'HOME': '/home/cltbld', 05:18:47 INFO - 'LANG': 'en_US.UTF-8', 05:18:47 INFO - 'LANGUAGE': 'en_US:en', 05:18:47 INFO - 'LOGNAME': 'cltbld', 05:18:47 INFO - 'MAIL': '/var/mail/cltbld', 05:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:47 INFO - 'MOZ_NO_REMOTE': '1', 05:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:47 INFO - 'NO_EM_RESTART': '1', 05:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:47 INFO - 'PWD': '/builds/slave/test', 05:18:47 INFO - 'SHELL': '/bin/bash', 05:18:47 INFO - 'SHLVL': '1', 05:18:47 INFO - 'TERM': 'linux', 05:18:47 INFO - 'TMOUT': '86400', 05:18:48 INFO - 'USER': 'cltbld', 05:18:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:48 INFO - '_': '/tools/buildbot/bin/python'} 05:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 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)) 05:18:48 INFO - Cleaning up... 05:18:48 INFO - Return code: 0 05:18:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:18:48 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')]} 05:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:48 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')]} 05:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:48 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 0x21ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', '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 05:18:48 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 05:18:48 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 05:18:48 INFO - Using env: {'DISPLAY': ':0', 05:18:48 INFO - 'HOME': '/home/cltbld', 05:18:48 INFO - 'LANG': 'en_US.UTF-8', 05:18:48 INFO - 'LANGUAGE': 'en_US:en', 05:18:48 INFO - 'LOGNAME': 'cltbld', 05:18:48 INFO - 'MAIL': '/var/mail/cltbld', 05:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:48 INFO - 'MOZ_NO_REMOTE': '1', 05:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:48 INFO - 'NO_EM_RESTART': '1', 05:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:48 INFO - 'PWD': '/builds/slave/test', 05:18:48 INFO - 'SHELL': '/bin/bash', 05:18:48 INFO - 'SHLVL': '1', 05:18:48 INFO - 'TERM': 'linux', 05:18:48 INFO - 'TMOUT': '86400', 05:18:48 INFO - 'USER': 'cltbld', 05:18:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:48 INFO - '_': '/tools/buildbot/bin/python'} 05:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:18:48 INFO - Cleaning up... 05:18:48 INFO - Return code: 0 05:18:48 INFO - Running post-action listener: _resource_record_post_action 05:18:48 INFO - Running post-action listener: _start_resource_monitoring 05:18:48 INFO - Starting resource monitoring. 05:18:48 INFO - [mozharness: 2017-05-08 12:18:48.484433Z] Finished create-virtualenv step (success) 05:18:48 INFO - [mozharness: 2017-05-08 12:18:48.484900Z] Running install step. 05:18:48 INFO - Running pre-action listener: _resource_record_pre_action 05:18:48 INFO - Running main action method: install 05:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:48 INFO - Reading from file tmpfile_stdout 05:18:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:48 INFO - Reading from file tmpfile_stdout 05:18:48 INFO - Output received: 05:18:48 INFO - Usage: mozinstall [options] installer 05:18:48 INFO - Options: 05:18:48 INFO - -h, --help show this help message and exit 05:18:48 INFO - -d DEST, --destination=DEST 05:18:48 INFO - Directory to install application into. [default: 05:18:48 INFO - "/builds/slave/test"] 05:18:48 INFO - --app=APP Application being installed. [default: firefox] 05:18:48 INFO - mkdir: /builds/slave/test/build/application 05:18:48 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'] 05:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:19:05 INFO - Reading from file tmpfile_stdout 05:19:05 INFO - Output received: 05:19:05 INFO - /builds/slave/test/build/application/firefox/firefox 05:19:05 INFO - Running post-action listener: _resource_record_post_action 05:19:05 INFO - [mozharness: 2017-05-08 12:19:05.514212Z] Finished install step (success) 05:19:05 INFO - [mozharness: 2017-05-08 12:19:05.514548Z] Running run-tests step. 05:19:05 INFO - Running pre-action listener: _resource_record_pre_action 05:19:05 INFO - Running main action method: run_tests 05:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:19:05 INFO - Python 2.7.3 05:19:05 INFO - Return code: 0 05:19:05 INFO - grabbing minidump binary from tooltool 05:19:05 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')]} 05:19:05 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 0x253da30>, '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 0x253e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253eca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:19:05 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 05:19:05 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 05:19:05 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 05:19:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:05 INFO - Return code: 0 05:19:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:19:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:19:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:19:05 INFO - ENV: RUST_BACKTRACE is now 1 05:19:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:19:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:19:05 INFO - Using env: {'DISPLAY': ':0', 05:19:05 INFO - 'HOME': '/home/cltbld', 05:19:05 INFO - 'LANG': 'en_US.UTF-8', 05:19:05 INFO - 'LANGUAGE': 'en_US:en', 05:19:05 INFO - 'LOGNAME': 'cltbld', 05:19:05 INFO - 'MAIL': '/var/mail/cltbld', 05:19:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:19:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:05 INFO - 'MOZ_NO_REMOTE': '1', 05:19:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:05 INFO - 'NO_EM_RESTART': '1', 05:19:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:05 INFO - 'PWD': '/builds/slave/test', 05:19:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:19:05 INFO - 'RUST_BACKTRACE': '1', 05:19:05 INFO - 'SHELL': '/bin/bash', 05:19:05 INFO - 'SHLVL': '1', 05:19:05 INFO - 'TERM': 'linux', 05:19:05 INFO - 'TMOUT': '86400', 05:19:05 INFO - 'USER': 'cltbld', 05:19:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1494243217.520519-1649372740', 05:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:05 INFO - '_': '/tools/buildbot/bin/python'} 05:19:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:19:05 INFO - mozversion application_buildid: 20170508100218 05:19:05 INFO - mozversion application_changeset: 1fda52a1f3b81cf1a821155998dca637bb64e3d9 05:19:05 INFO - mozversion application_display_name: Nightly 05:19:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:05 INFO - mozversion application_name: Firefox 05:19:05 INFO - mozversion application_remotingname: firefox 05:19:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:19:05 INFO - mozversion application_vendor: Mozilla 05:19:05 INFO - mozversion application_version: 55.0a1 05:19:05 INFO - mozversion platform_buildid: 20170508100218 05:19:05 INFO - mozversion platform_changeset: 1fda52a1f3b81cf1a821155998dca637bb64e3d9 05:19:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:19:05 INFO - mozversion platform_version: 55.0a1 05:19:05 INFO - using testdate: 1494245945 05:19:05 INFO - actual date: 1494245945 05:19:05 INFO - starting webserver on 'localhost:49211' 05:19:05 INFO - SUITE-START | Running 2 tests 05:19:05 INFO - TEST-START | dromaeo_css 05:19:05 INFO - operating with platform_type : linux_ 05:19:05 INFO - Initialising browser for dromaeo_css test... 05:19:05 INFO - TEST-INFO | started process 10526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4z0hYX/profile http://localhost:49211/getInfo.html) 05:19:09 INFO - PID 10526 | __metrics Screen width/height:1600/1200 05:19:09 INFO - PID 10526 | colorDepth:24 05:19:09 INFO - PID 10526 | Browser inner width/height: 1024/695 05:19:09 INFO - PID 10526 | __metrics 05:19:10 INFO - PID 10526 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:19:10 INFO - PID 10526 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:19:11 INFO - TEST-INFO | 10526: exit 0 05:19:11 INFO - Browser initialized. 05:19:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:19:11 INFO - TEST-INFO | started process 10624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4z0hYX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:23 INFO - PID 10624 | RSS: Main: 149823488 05:19:23 INFO - PID 10624 | 05:22:27 INFO - PID 10624 | Cycle 1(1): loaded http://localhost:49211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49211/tests/dromaeo/cssquery-ext.html) 05:22:28 INFO - PID 10624 | RSS: Main: 276107264 05:22:28 INFO - PID 10624 | 05:25:30 INFO - PID 10624 | Cycle 1(1): loaded http://localhost:49211/tests/dromaeo/cssquery-ext.html (next: http://localhost:49211/tests/dromaeo/cssquery-jquery.html) 05:25:30 INFO - PID 10624 | RSS: Main: 233582592 05:25:30 INFO - PID 10624 | 05:28:32 INFO - PID 10624 | Cycle 1(1): loaded http://localhost:49211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49211/tests/dromaeo/cssquery-mootools.html) 05:28:33 INFO - PID 10624 | RSS: Main: 221876224 05:28:33 INFO - PID 10624 | 05:31:34 INFO - PID 10624 | Cycle 1(1): loaded http://localhost:49211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49211/tests/dromaeo/cssquery-prototype.html) 05:31:35 INFO - PID 10624 | RSS: Main: 178585600 05:31:35 INFO - PID 10624 | 05:34:38 INFO - PID 10624 | Cycle 1(1): loaded http://localhost:49211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49211/tests/dromaeo/cssquery-yui.html) 05:34:38 INFO - PID 10624 | RSS: Main: 178257920 05:34:38 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | Cycle 1(1): loaded http://localhost:49211/tests/dromaeo/cssquery-yui.html (next: http://localhost:49211/tests/dromaeo/cssquery-dojo.html) 05:37:40 INFO - PID 10624 | RSS: Main: 272003072 05:37:40 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | __start_tp_report 05:37:40 INFO - PID 10624 | _x_x_mozilla_page_load 05:37:40 INFO - PID 10624 | _x_x_mozilla_page_load_details 05:37:40 INFO - PID 10624 | |i|pagename|runs| 05:37:40 INFO - PID 10624 | |0;dojo.html;3331.583552055993;3334.5998480182384;3338.6828251316133;3354.379439803638;3392.440247359186;5622.775088996445;5630.071038278679;5673;5692.772289108436;5761.078227483604;5618.381977982429;5639.661620302784;5676.063449530822;5698.886022279552;5732.828015159542;4718.110391369664;4971;5001.224810154432;5002.374703162114;5088.643794934337;5080.517350851682;5103.2090026045835;5125.2312153176945;5135.948640513584;5139.306193663863;4996.125678006352;5049.040682270357;5058.898822023539;5063.316452278968;5067.214581739836;5094.108531007059;5098.515641014098;5100.107481190814;5100.362454693163;5105;5034.421041580228;5055.494450554915;5076.060928728197;5090.49095090488;5094;5664.915026274609;5683.460071293221;5686.601937864351;5688.744006519675;5692.971535142339;6096.169680856328;6096.381358664658;6098.9768881920445;6099.497746808812;6144.815655530297;6084.5436592255755;6107.674343494563;6161.9691901540655;6163.2604087509335;6165.84585385369;5663.518600918968;5674.0637794764225;5682.318121825408;5718.628289161191;5721.370649228582;6135.263768347738;6140.570160088841;6141.477974372139;6164.599301045418;6165.568410211332;5902.38025007368;5939.613925094855;5944.078667806497;5977.163197152402;5982.910256346158;6109.5645257506285;6128.228138398591;6132.4166970161305;6132.703928623171;6133.028644417026;5458.181272809031;6084.148219249309;6091.908621370683;6098.664573448503;6098.908516372258;6097.2524665300325;6103.725332360054;6114.174586430775;6127.509799216052;6136.140940268366;4607.677462577654;4623.982723800758;4655.534446555385;4669.322948172496;4669.649776266793;4112.527059388209;4194.412782210493;4194.538600753915;4228.154369126187;4234.78826058702;5615.747291371898;5707.429257074259;5711.543076553866;5713.143028545752;5713.171590119493;6018.939810601925;6126.30393285589;6128.295246046672;6138.756267604181;6142.508599312045;5676.035074037341;5678.119891416754;5679.375268720438;5680.204771332017;5734.053881109654;5208.557272631869;5251.921221181686;5254.65844720092;5258.553022993012;5303.28405665238;6231.75072997075;6269.592476489013;6324.873502530016;6324.905126423199;6377.96811015942;6117.96941015292;6150.661713605795;6166.414190651881;6167.414095660905;6180.258368995749;6376.171097757262;6378.968105159444;6389.87220255583;6390;6390.936090639034;5875.882482350244;5957.672328021827;5974.551908606785;6011.428914253139;6034.547408944259;6099.75600975956;6104.3075792339105;6105.550726437353;6114.449440885012;6117.632942023492;5927.436893495111;5932.1694962706115;5935.732892019783;5940.762369505344;5993.460588547052;5894.852628684317;5914.02418600926;5914.2311499504785;5916.023856063702;6038.818835434944;5861.706914654165;5931.6441013539325;5952.791652292149;5979.312379076462;5986.88026239464;5888.411158884077;5948.73230704628;5950.7917222896995;5954.702264886651;5959.612625179349;5724.885502290014;5824.621399609012;5830.970845145747;5907.763689452546;5912.438318359749 05:37:40 INFO - PID 10624 | |1;ext.html;728.5992704012791;781.5935713429017;803.2048272210511;1108.5676586131415;1114.526326311318;28472.145835624913;33039;36022;36099.639003609955;36103.638963610356;36708.44937325942;36946;36977.81511092447;37015.81492092536;37063.625774262786;5542.91685624716;7073.938909163641;7124.608146551937;7137.8215544611285;7149.463790215728;5592.273004509429;6963.512554121214;7136.9286307137045;7144.28557144284;7146.428285737128;7200.495965282433;7234.529755565898;7252.45606579506;7259.74590889319;7265.636718164097;5445.482679145514;7178.066851309349;7202.351788339022;7229.31321524457;7233;5548.889022219573;6873.690683919235;7022.087128673291;7029.472789540754;7039.612821294827;34870.651293487;35231.64768352309;35263.29473410543;35389.46915796265;35472.113197170016;3516.43737002081;3558.3061303045915;3564.180238545149;3566.1084728817796;3568.3933731265747;26074.217773466826;26086;26143.60784588233;26156.869215653798;26179.738202617922;3722.516072910504;3740.7007439404783;3766.4915236443003;3779.130799916035;3791.4312853071983;187716;187920;187987;188398;188516;46225.30662040072;46259.53740462619;46306.30540541895;46336.5366346339;46360.7681961588;48496.51503484991;48560.27159592609;48643.75678121657;48651.5134848647;48693.5130648689;14820.3330850112;14895.851041489663;14903.105813651217;14905.70188596222;14927.626809329853;10386.376817390981;10662.733431664115;12194.085443591588;12212.694682632828;12221.388930553438;12404.937975310066;12933.741325173443;13036.283004434847;13087.541936032194;13212.405441754952;5276.683398996072;5462.9726851365485;5474.151506516497;5484.808031718871;5513.3108361454815;1067.3275836223286;1078.1751959750798;1096.199774164864;1104.5526561742506;1118.6140781430393;25818.870905645726;25933.61099583508;25976.350591235372;26101.73898261031;26121.869390652926;1178.7112157521462;1180.3769816502308;1205.0540325844345;1205.7106294489258;1215.6960759810047;13038.217706937614;13472.932635336761;13555.864441355658;13667.384967676478;13729.244891531062;260325;260850;262767;263370;263508;50936.23595646068;51400.742996285524;51507.74246128745;51534.74232628888;51658;1472.7128209999162;1499.2728526664778;1506;1509.2981763479816;1511.1764088571754;23870.641940370562;24568.670103400236;24784.752152478246;24834.379140521633;24947.39314936344;37844.62155378411;37993.810030949666;38009.61990380061;38017.61982380141;38026.80986595049;204347;205481;205744;206508;207885;32986.83506582452;33406.331873362884;33406.66593334036;33407.48998885119;33414;35104.29791404209;35394.522383432915;39073.413898790976;39817.2036559273;39983.80008099941;29486.557701634923;30179.849100754356;30183.245418863826;30423.239419014702;31598.52602210923;30015.399692006475;30218.24454388658;30501.84749076329;31833.36333273368;31977;34959.30081398409;35026.64973350234;35105.64894351126;35278;35389.82305088458;28184.295392614527;28213.858930705213;28285.151445456668;28837.27906802347;29660;23278;24531.754682452945;24542.63186052175;24723.381915452257;24866.502669946138 05:37:40 INFO - PID 10624 | |2;jquery.html;430.7157276197708;430.7851857761114;441.9116176764644;451.4199253958663;463.66384371330787;19841.305554305603;20140.19439222433;20722.171113155473;21090.261840835574;21328.680069798964;21891.562168756616;21950.780492195074;22207.555848883014;22715.20496782613;22971;5211.905499845037;5534.778608855641;5704.172894930232;5706.087026075828;5709.371969083398;5265.447128051538;5572.749226284827;5604.215409842625;5605.299337582802;5607.158926161068;5346.171343441753;5580.944190558103;5585.888282234353;5586.13414920688;5591.30108736408;5440.863978400552;5535.280413546254;5545.140503222007;5548.833534993936;5548.86127846803;4994.525520075587;5012.498750124958;5052.267421223902;5069.214271787842;5071.416787069497;24452.388690282885;24604.630930536056;24639.753602463927;24681.753182468125;24898.253052408458;2214.9889250553806;2221.733391992955;2221.7889300516586;2231.866088034723;2250.763669814662;16508.917455412648;16640.417585384574;16817.41139060127;16994.575135621584;17029.403970861084;2160.546285280093;2179.1936983316273;2256.537409830981;2261.570301642683;2266.8639881607155;103441.96558034398;104469;104637;105118.47440762824;106691;12056.156069075081;12414.503419863104;12456.501739930301;12493.93753031229;12629.368531573384;17823.910880445514;17849.910750446423;17863.553411164565;17869.374571889923;17892.821071789374;8658.48049117055;8772.956135219283;8813.206811386877;8900.332475064266;9000.324975626854;7920.2871741542385;7922.445428819928;8018.879716804253;8159.143289954588;8270.793230169294;7793.610319484003;7891.526508409399;7909.6836126555445;7924.48490848093;8084.797880052928;2220.9111635534723;2223.6664500325082;2232.3749350181974;2249.718785151856;2307.492351682627;1043.968680939573;1066.8186408310605;1072.8466898084591;1074.6561100447782;1080.8756992945755;20466.692999605017;20591.176352945713;20632;20680.689789653166;20785.89607051955;1095.1293721491434;1096.4956120184645;1096.6435908329665;1103.4096758234307;1114.1365441782684;10879.075278601249;11192.216544841946;11252.606158784403;11299.265547739371;11424.485898134604;527739.0139549759;531252.8435082984;536411;552907;558022;88264.67103585857;95026.52486737522;96125;97368.53947190798;99330;1169.8362229287907;1221.8594861590852;1242.8881400673802;1248.5255602871032;1251.5056552661829;16592.672586193316;16894.915525422293;17271.91364043222;17686.469405917844;17800.287988480315;44927.550724493645;45165;45296.2996290638;45654;46104.538954611366;54510;54713.72643136759;56259.43740562705;56462.1530677032;57129.42870571241;9434.48110353937;9500.904990950003;9658.7585310365;9731.41611503312;10023.498825058572;14398;14668.193249371387;14696.485623003144;14700.926495367456;14913.62715932067;11189.328640281608;11323.773524529628;11861.644150675493;12937.54718584845;12970.286634235208;11028.558857645925;11137.443127843737;11206.99137077667;11255.549778009115;11265.831012534654;11749.76500470003;11776.82334764962;13274.601761947157;13421;13499.662508437368;9302.813943721223;9715.07706767856;9787.217022638315;9951.15415189717;10238.33450825694;11974.880251197725;12285.754284914074;12301.138920275494;12746.171498852545;12747.553835615709 05:37:40 INFO - PID 10624 | |3;mootools.html;1199.0946835139468;1252.3174869696015;1259.8425196850396;1273.1024627637516;1274.579388801695;9593.616255349787;11039.39283339416;11375.374354410525;11470.426478676074;11494.655160345192;11194.832077518824;11392.658220253385;11412.31526108434;11415.31508109514;11419.143564232674;2015.475976246172;2096.716943212662;2375.4773949731116;2412.5054363855456;2413.300142958549;2345.542619189259;2383.797377222938;2406.470576473182;2414.311921102486;2418.9758102419014;2278.6354183330673;2296.8621882687007;2309.3649246457276;2315.4327189838514;2319.7100362454694;2271.693321401606;2281.2243837095384;2287.6568514722676;2288.096202000209;2289.7023386959754;2213.269621025074;2240.417491452234;2240.977590224093;2243.6858839762444;2250.774922507736;10946.781064378747;10993.505292261867;11036.668899933014;11086.889131108666;11111.111111111173;6354.110424540568;6573.638449885254;6609.372109649576;6618.139641846529;6624.3375662433855;3937.330653788863;4003.559608443069;4156.459660244179;4235.851745188904;4250.936235956463;1355.6475316417802;1377.4008306386754;1389.388668985653;1389.94440222392;1430.942762289507;17554.91222543879;17555.385561505285;17562.38531651386;17684.02737849418;17684.823151768447;5600.747966341524;5629.296337957755;5758.568107391879;5820.330661973842;5906.911396329058;14354.641133971734;14377.424903003763;14384.928075359765;14424.134551926709;14425.422983080769;6730.899036514456;6744.763933262312;6751.898721519181;6756.898646520306;6764.966175169093;6003.129546215774;6050.304215015241;6107.206063211754;6118.632882027093;6170.845728856814;4453.576910193527;4506.616937560344;4577.267637178035;4623.214053610895;4678.461976872703;1369.8561651026698;1395.1280449718927;1395.9232242226774;1411.3155119766905;1413.3357322058616;835.2733122183739;836.9748907532784;852.8336974290078;867.3928250224868;871.5772850167664;6188.783392581238;6702.396784289437;6719.630420326831;6727.091842601284;6755.628440435823;615.5906322295623;620.8447888027993;623.5261201486812;631.9936800631934;634.7016902056026;3704.962950370462;3748.3253014457114;3769.6984241260634;3834.6740527054953;3868.516435445569;13860.861391385957;14719;15134.848651513345;15276.618084547754;15381.230938453033;14609.561713148623;14748.778768318269;14856.628584285263;15154;15206;8928.73213803587;8948.73153805387;9106.681266155652;9123.589438475285;9126.133017363472;6655.334466553306;6683.598984060972;6748.797536073926;6789.762358317633;6932.23745388017;12890.935545322214;12910;12936.547220847226;12985.740285194055;13070.738585228431;13444.731105378034;13478.73042539124;13518.05373623837;13639.045266831623;13718.725625487235;9478;9482.810343793224;9536.952315238379;9584.808303833745;9644.324897257406;10890.29213101146;10996.890031099587;11053.28153670009;11055.281406708538;11058.060064894575;9229.538523073954;9352.906470935204;9439.858402124111;9529.952350238205;9611.663591774533;8759.12408759119;8768.868466972874;8832.470051796912;8902.59938302765;8953.731388058368;8013.559254240839;8025.23760242776;8114.472559283628;8172.632231549714;8242.793930151794;5653.689047102449;5759.769609215585;5862.560307976833;5938.346781853907;5961;5639.125935480007;5737.196792448977;5746.7701291949525;5871.559633027455;5895.263092113486 05:37:40 INFO - PID 10624 | |4;prototype.html;401.6521158459674;405.50933370621544;407.6483538229401;417.146934518909;422.60908659489985;5433.4566543345645;5559.833205003852;5615.578831587632;5625.296837895263;5652.971735141329;5405.18922161676;5505.174223866412;5515.669059856412;5516.227728118057;5523.696196709179;4140.958590414102;4215.768132752697;4231.788410579474;4238.745675259479;4247.065645557987;4234.724742891717;4251.6173544381;4256.2338779019765;4263.5736426357425;4263.765492897889;4210.957890421102;4222.577742225783;4223.831046758126;4226.366045093245;4227.746335219881;4120.25835349637;4196.118815048843;4213.1573685262765;4237.470316210489;4239.703220774547;3681.079730067483;3689.6679298863232;3692.9446058308877;3705.6850167735774;3706.0549559862334;5440.863978400532;5450.419378380265;5457.918131227995;5463.399026107125;5466.835994920159;4893.070316639827;4916.631252656065;4946.72792996385;4947.109520286347;4959.950400496021;5878.177055212273;5881.2942446906645;5894.646321220741;5896.439838215363;5902.734376953047;4144.834206631731;4153.335466325373;4162.146759914211;4165.708400411972;4169.624733773944;6024.759009639609;6068.33248342682;6092.45167934888;6102.206713127265;6166.136740856239;4230.2174097792;4242.596953289432;4244.660427165819;4247.00195454068;4253.617174454252;4296.312589985588;4301.096769678403;4306.913861722811;4307.267764480046;4308.1814455254025;4698.718076915396;4848.200046992207;4891.755412229374;4973.403191617029;4979.983106841735;5908.172855800191;5908.20239267702;5918.615290006136;5925.762969481172;5956.362000449911;1462.2104063805639;1474.9262536873114;1483.4437086092714;1483.8812894968376;1486.9033512821632;993.0516356879164;994.3536701144315;997.3168379659957;1000.8698869146964;1013.4881884648205;5675.347335056439;5680.176374425685;5689.800856969986;5690.573207009491;5713.314402271671;6093.96953015241;6115.571909966348;6118.357572454828;6119.755209791648;6122.265328160649;5522.564133325364;5637.3235211774845;5669.121286200645;5669.773209071674;5686.834198989197;3174.174714574181;3195.4887218045;3201.3597280543986;3201.4077395681875;3201.695838895301;6101.84745381369;6311.684415779285;6344.968275158594;6345.809625711236;6399.8080057598345;5971.611845230046;6278.4035516625845;6279.780207692709;6286.245650521967;6296.527760417987;6192.690365481708;6213.285472170668;6314.526410519229;6320.209973753281;6350.650714210763;5826.883462330645;6071.726772295346;6088.6042407243385;6090.847728806815;6092.421219984094;5654.830355089354;5989.970050149721;6000.5799594028;6057.848553786014;6070.514358851369;6271.529635277281;6303.936960630518;6304.779332723516;6327.778527751507;6347.96826015867;4573.794179261875;4642.651801114997;4701.952980470288;4711.8350857719815;4733.597644200281;6081.93566125935;6096.420840020191;6103.11504831788;6108.205933228652;6127.509799215963;5795.449432303924;5874.882502350015;5876.882462350643;5909.3795151508475;5974.64152150855;5894.410558944071;5899.174115623902;5909.449723712632;5919.704014799329;5928.318243402064;5890.764369425347;5895.263092113486;5896.911546326723;5899.970500147472;5923.970380148072;5772.740226689725;5878.647281163144;5928.822135335947;5940.020186475159;5946.256717910262;5783.074708046693;5806.796762113475;5813.273340832396;5822.400303759982;5823.126531020381 05:37:40 INFO - PID 10624 | |5;yui.html;875.4090988582705;879.8020445399786;892.005413963431;894.5750768385018;896.551724137931;15679.216039198038;16148.596285092879;16595.419160329377;16600.50198494044;16621.501354959357;16965.236564354604;17106.914465427657;17352.47942561725;17366.739498907496;17368.913155434206;1004.7588578741122;1025.830737928241;1032.2206733915882;1032.592126110186;1033;992.846108853129;1016.5425558498669;1017.8524114003502;1023.3706270643538;1024.0629823711295;1077.6820837852852;1080.206048554312;1080.2708171983918;1080.6055789636766;1080.9783804323947;1069.1927594666056;1069.5294070608907;1070.812607793633;1071.2073065931195;1071.4000159910474;787.3347021766598;791.6516732637679;792.1167897793919;792.2473650032434;793.1592511937365;17448.214830332665;17664.735028974577;17867.73198402012;17965.191566379413;18137.63724725498;18806.62386752271;19185.712214316798;19344.032798360167;19388.612227755508;19506.80493195064;14775.113493190336;15027.699446011127;15175.772363414557;15209.315580798891;15294.464693735667;3363.075154332578;3445.2592692570965;3455.2398472336045;3481.0253129123885;3486.7210623150086;89895;90818.09181908163;92328.53835730845;92513;92919.53540232324;14467.204303763394;14768.483103091341;15085.773713394308;15314.770278445832;15602.609934751496;27380;27914.86042569774;27986.440271194868;28374.148775536767;28759.71240287612;8109.7161599343735;8339.332853371716;8372;8469.195426434479;8478.236958673626;4010.298197815429;4062.370332598452;4082.8775136745353;4087.509498860156;4093.672506199497;4442.555744425532;4482.305242687388;4498.685092043591;4560.612347950395;4610.76946152691;868.4224990381325;894.9731508054768;897.7396554999108;902.1294450854956;910.6949172027313;675.587891386254;707.7735124760027;710.6482291265856;714.6891102370486;719.4244604316526;11986.64040078799;13163.341832908316;13167.539136130381;13736.793948090786;13772.724545509034;724.8260417499868;736.988945165823;742.4988133010304;743.8475112601903;749.9775006749807;5795.94204057954;6052.485538729169;6352.745890164341;6368.808935731936;6528.575642583217;83068.58465707632;86685;86754.56622716846;89828;90858.54570727104;71472.64263678648;72962;74358;74544.62727686326;75791;67366;69452;69494.65252673705;69912;70236.6488167556;13147.53983610569;13609.387577559231;13743.793843092162;13791.724165516835;13867.583972480841;35055.071971041834;35189.12027199341;35803.82098089493;36096.81951590225;36126.63314573625;44162.55837441584;44178.77910610555;44679.776601116784;44848.32727509155;45485.317720233565;17429;17683.73474397911;17863.553411164823;17903;17903.283868645107;19018.52453688669;19258.7111193335;19496.805031949498;19868.503287417352;19871;18344.90827545907;18547.72178417298;18633.627327453647;18722.251109955992;19037.809621903605;17235.3967611133;17561;17687.204075816877;18096.72854907151;18348.256915592996;17750;18157.36449224271;18177.545561361072;18530.351437699617;18578.721319179953;12666.43001064936;12687.302198379179;12819.679508012001;13245.80131298012;13336.399862006427;13860.653483662989;14081.436742530594;14425.134491930517;14559.199244041256;14944.850551494346 05:37:40 INFO - PID 10624 | __end_tp_report 05:37:40 INFO - PID 10624 | __start_cc_report 05:37:40 INFO - PID 10624 | _x_x_mozilla_cycle_collect,1210 05:37:40 INFO - PID 10624 | __end_cc_report 05:37:40 INFO - PID 10624 | __startTimestamp1494247060653__endTimestamp 05:37:40 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | ------- Summary: start ------- 05:37:40 INFO - PID 10624 | Number of tests: 6 05:37:40 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | [#0] dojo.html Cycles:165 Average:5637.39 Median:5894.85 stddev:651.44 (11.1%) stddev-sans-first:627.82 05:37:40 INFO - PID 10624 | Values: 3331.6 3334.6 3338.7 3354.4 3392.4 5622.8 5630.1 5673.0 5692.8 5761.1 5618.4 5639.7 5676.1 5698.9 5732.8 4718.1 4971.0 5001.2 5002.4 5088.6 5080.5 5103.2 5125.2 5135.9 5139.3 4996.1 5049.0 5058.9 5063.3 5067.2 5094.1 5098.5 5100.1 5100.4 5105.0 5034.4 5055.5 5076.1 5090.5 5094.0 5664.9 5683.5 5686.6 5688.7 5693.0 6096.2 6096.4 6099.0 6099.5 6144.8 6084.5 6107.7 6162.0 6163.3 6165.8 5663.5 5674.1 5682.3 5718.6 5721.4 6135.3 6140.6 6141.5 6164.6 6165.6 5902.4 5939.6 5944.1 5977.2 5982.9 6109.6 6128.2 6132.4 6132.7 6133.0 5458.2 6084.1 6091.9 6098.7 6098.9 6097.3 6103.7 6114.2 6127.5 6136.1 4607.7 4624.0 4655.5 4669.3 4669.6 4112.5 4194.4 4194.5 4228.2 4234.8 5615.7 5707.4 5711.5 5713.1 5713.2 6018.9 6126.3 6128.3 6138.8 6142.5 5676.0 5678.1 5679.4 5680.2 5734.1 5208.6 5251.9 5254.7 5258.6 5303.3 6231.8 6269.6 6324.9 6324.9 6378.0 6118.0 6150.7 6166.4 6167.4 6180.3 6376.2 6379.0 6389.9 6390.0 6390.9 5875.9 5957.7 5974.6 6011.4 6034.5 6099.8 6104.3 6105.6 6114.4 6117.6 5927.4 5932.2 5935.7 5940.8 5993.5 5894.9 5914.0 5914.2 5916.0 6038.8 5861.7 5931.6 5952.8 5979.3 5986.9 5888.4 5948.7 5950.8 5954.7 5959.6 5724.9 5824.6 5831.0 5907.8 5912.4 05:37:40 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | [#1] ext.html Cycles:180 Average:37466.23 Median:33406.50 stddev:57515.09 (172.2%) stddev-sans-first:57610.28 05:37:40 INFO - PID 10624 | Values: 728.6 781.6 803.2 1108.6 1114.5 28472.1 33039.0 36022.0 36099.6 36103.6 36708.4 36946.0 36977.8 37015.8 37063.6 5542.9 7073.9 7124.6 7137.8 7149.5 5592.3 6963.5 7136.9 7144.3 7146.4 7200.5 7234.5 7252.5 7259.7 7265.6 5445.5 7178.1 7202.4 7229.3 7233.0 5548.9 6873.7 7022.1 7029.5 7039.6 34870.7 35231.6 35263.3 35389.5 35472.1 3516.4 3558.3 3564.2 3566.1 3568.4 26074.2 26086.0 26143.6 26156.9 26179.7 3722.5 3740.7 3766.5 3779.1 3791.4 187716.0 187920.0 187987.0 188398.0 188516.0 46225.3 46259.5 46306.3 46336.5 46360.8 48496.5 48560.3 48643.8 48651.5 48693.5 14820.3 14895.9 14903.1 14905.7 14927.6 10386.4 10662.7 12194.1 12212.7 12221.4 12404.9 12933.7 13036.3 13087.5 13212.4 5276.7 5463.0 5474.2 5484.8 5513.3 1067.3 1078.2 1096.2 1104.6 1118.6 25818.9 25933.6 25976.4 26101.7 26121.9 1178.7 1180.4 1205.1 1205.7 1215.7 13038.2 13472.9 13555.9 13667.4 13729.2 260325.0 260850.0 262767.0 263370.0 263508.0 50936.2 51400.7 51507.7 51534.7 51658.0 1472.7 1499.3 1506.0 1509.3 1511.2 23870.6 24568.7 24784.8 24834.4 24947.4 37844.6 37993.8 38009.6 38017.6 38026.8 204347.0 205481.0 205744.0 206508.0 207885.0 32986.8 33406.3 33406.7 33407.5 33414.0 35104.3 35394.5 39073.4 39817.2 39983.8 29486.6 30179.8 30183.2 30423.2 31598.5 30015.4 30218.2 30501.8 31833.4 31977.0 34959.3 35026.6 35105.6 35278.0 35389.8 28184.3 28213.9 28285.2 28837.3 29660.0 23278.0 24531.8 24542.6 24723.4 24866.5 05:37:40 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | [#2] jquery.html Cycles:180 Average:31985.54 Median:2222.73 stddev:89387.73 (4021.5%) stddev-sans-first:89607.09 05:37:40 INFO - PID 10624 | Values: 430.7 430.8 441.9 451.4 463.7 19841.3 20140.2 20722.2 21090.3 21328.7 21891.6 21950.8 22207.6 22715.2 22971.0 5211.9 5534.8 5704.2 5706.1 5709.4 5265.4 5572.7 5604.2 5605.3 5607.2 5346.2 5580.9 5585.9 5586.1 5591.3 5440.9 5535.3 5545.1 5548.8 5548.9 4994.5 5012.5 5052.3 5069.2 5071.4 24452.4 24604.6 24639.8 24681.8 24898.3 2215.0 2221.7 2221.8 2231.9 2250.8 16508.9 16640.4 16817.4 16994.6 17029.4 2160.5 2179.2 2256.5 2261.6 2266.9 103442.0 104469.0 104637.0 105118.5 106691.0 12056.2 12414.5 12456.5 12493.9 12629.4 17823.9 17849.9 17863.6 17869.4 17892.8 8658.5 8773.0 8813.2 8900.3 9000.3 7920.3 7922.4 8018.9 8159.1 8270.8 7793.6 7891.5 7909.7 7924.5 8084.8 2220.9 2223.7 2232.4 2249.7 2307.5 1044.0 1066.8 1072.8 1074.7 1080.9 20466.7 20591.2 20632.0 20680.7 20785.9 1095.1 1096.5 1096.6 1103.4 1114.1 10879.1 11192.2 11252.6 11299.3 11424.5 527739.0 531252.8 536411.0 552907.0 558022.0 88264.7 95026.5 96125.0 97368.5 99330.0 1169.8 1221.9 1242.9 1248.5 1251.5 16592.7 16894.9 17271.9 17686.5 17800.3 44927.6 45165.0 45296.3 45654.0 46104.5 54510.0 54713.7 56259.4 56462.2 57129.4 9434.5 9500.9 9658.8 9731.4 10023.5 14398.0 14668.2 14696.5 14700.9 14913.6 11189.3 11323.8 11861.6 12937.5 12970.3 11028.6 11137.4 11207.0 11255.5 11265.8 11749.8 11776.8 13274.6 13421.0 13499.7 9302.8 9715.1 9787.2 9951.2 10238.3 11974.9 12285.8 12301.1 12746.2 12747.6 05:37:40 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | [#3] mootools.html Cycles:180 Average:7147.21 Median:3759.01 stddev:4651.58 (123.7%) stddev-sans-first:4643.15 05:37:40 INFO - PID 10624 | Values: 1199.1 1252.3 1259.8 1273.1 1274.6 9593.6 11039.4 11375.4 11470.4 11494.7 11194.8 11392.7 11412.3 11415.3 11419.1 2015.5 2096.7 2375.5 2412.5 2413.3 2345.5 2383.8 2406.5 2414.3 2419.0 2278.6 2296.9 2309.4 2315.4 2319.7 2271.7 2281.2 2287.7 2288.1 2289.7 2213.3 2240.4 2241.0 2243.7 2250.8 10946.8 10993.5 11036.7 11086.9 11111.1 6354.1 6573.6 6609.4 6618.1 6624.3 3937.3 4003.6 4156.5 4235.9 4250.9 1355.6 1377.4 1389.4 1389.9 1430.9 17554.9 17555.4 17562.4 17684.0 17684.8 5600.7 5629.3 5758.6 5820.3 5906.9 14354.6 14377.4 14384.9 14424.1 14425.4 6730.9 6744.8 6751.9 6756.9 6765.0 6003.1 6050.3 6107.2 6118.6 6170.8 4453.6 4506.6 4577.3 4623.2 4678.5 1369.9 1395.1 1395.9 1411.3 1413.3 835.3 837.0 852.8 867.4 871.6 6188.8 6702.4 6719.6 6727.1 6755.6 615.6 620.8 623.5 632.0 634.7 3705.0 3748.3 3769.7 3834.7 3868.5 13860.9 14719.0 15134.8 15276.6 15381.2 14609.6 14748.8 14856.6 15154.0 15206.0 8928.7 8948.7 9106.7 9123.6 9126.1 6655.3 6683.6 6748.8 6789.8 6932.2 12890.9 12910.0 12936.5 12985.7 13070.7 13444.7 13478.7 13518.1 13639.0 13718.7 9478.0 9482.8 9537.0 9584.8 9644.3 10890.3 10996.9 11053.3 11055.3 11058.1 9229.5 9352.9 9439.9 9530.0 9611.7 8759.1 8768.9 8832.5 8902.6 8953.7 8013.6 8025.2 8114.5 8172.6 8242.8 5653.7 5759.8 5862.6 5938.3 5961.0 5639.1 5737.2 5746.8 5871.6 5895.3 05:37:40 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | [#4] prototype.html Cycles:180 Average:4953.90 Median:5669.45 stddev:1477.23 (26.1%) stddev-sans-first:1441.31 05:37:40 INFO - PID 10624 | Values: 401.7 405.5 407.6 417.1 422.6 5433.5 5559.8 5615.6 5625.3 5653.0 5405.2 5505.2 5515.7 5516.2 5523.7 4141.0 4215.8 4231.8 4238.7 4247.1 4234.7 4251.6 4256.2 4263.6 4263.8 4211.0 4222.6 4223.8 4226.4 4227.7 4120.3 4196.1 4213.2 4237.5 4239.7 3681.1 3689.7 3692.9 3705.7 3706.1 5440.9 5450.4 5457.9 5463.4 5466.8 4893.1 4916.6 4946.7 4947.1 4960.0 5878.2 5881.3 5894.6 5896.4 5902.7 4144.8 4153.3 4162.1 4165.7 4169.6 6024.8 6068.3 6092.5 6102.2 6166.1 4230.2 4242.6 4244.7 4247.0 4253.6 4296.3 4301.1 4306.9 4307.3 4308.2 4698.7 4848.2 4891.8 4973.4 4980.0 5908.2 5908.2 5918.6 5925.8 5956.4 1462.2 1474.9 1483.4 1483.9 1486.9 993.1 994.4 997.3 1000.9 1013.5 5675.3 5680.2 5689.8 5690.6 5713.3 6094.0 6115.6 6118.4 6119.8 6122.3 5522.6 5637.3 5669.1 5669.8 5686.8 3174.2 3195.5 3201.4 3201.4 3201.7 6101.8 6311.7 6345.0 6345.8 6399.8 5971.6 6278.4 6279.8 6286.2 6296.5 6192.7 6213.3 6314.5 6320.2 6350.7 5826.9 6071.7 6088.6 6090.8 6092.4 5654.8 5990.0 6000.6 6057.8 6070.5 6271.5 6303.9 6304.8 6327.8 6348.0 4573.8 4642.7 4702.0 4711.8 4733.6 6081.9 6096.4 6103.1 6108.2 6127.5 5795.4 5874.9 5876.9 5909.4 5974.6 5894.4 5899.2 5909.4 5919.7 5928.3 5890.8 5895.3 5896.9 5900.0 5924.0 5772.7 5878.6 5928.8 5940.0 5946.3 5783.1 5806.8 5813.3 5822.4 5823.1 05:37:40 INFO - PID 10624 | 05:37:40 INFO - PID 10624 | [#5] yui.html Cycles:180 Average:19786.34 Median:19501.80 stddev:23975.05 (122.9%) stddev-sans-first:24000.24 05:37:40 INFO - PID 10624 | Values: 875.4 879.8 892.0 894.6 896.6 15679.2 16148.6 16595.4 16600.5 16621.5 16965.2 17106.9 17352.5 17366.7 17368.9 1004.8 1025.8 1032.2 1032.6 1033.0 992.8 1016.5 1017.9 1023.4 1024.1 1077.7 1080.2 1080.3 1080.6 1081.0 1069.2 1069.5 1070.8 1071.2 1071.4 787.3 791.7 792.1 792.2 793.2 17448.2 17664.7 17867.7 17965.2 18137.6 18806.6 19185.7 19344.0 19388.6 19506.8 14775.1 15027.7 15175.8 15209.3 15294.5 3363.1 3445.3 3455.2 3481.0 3486.7 89895.0 90818.1 92328.5 92513.0 92919.5 14467.2 14768.5 15085.8 15314.8 15602.6 27380.0 27914.9 27986.4 28374.1 28759.7 8109.7 8339.3 8372.0 8469.2 8478.2 4010.3 4062.4 4082.9 4087.5 4093.7 4442.6 4482.3 4498.7 4560.6 4610.8 868.4 895.0 897.7 902.1 910.7 675.6 707.8 710.6 714.7 719.4 11986.6 13163.3 13167.5 13736.8 13772.7 724.8 737.0 742.5 743.8 750.0 5795.9 6052.5 6352.7 6368.8 6528.6 83068.6 86685.0 86754.6 89828.0 90858.5 71472.6 72962.0 74358.0 74544.6 75791.0 67366.0 69452.0 69494.7 69912.0 70236.6 13147.5 13609.4 13743.8 13791.7 13867.6 35055.1 35189.1 35803.8 36096.8 36126.6 44162.6 44178.8 44679.8 44848.3 45485.3 17429.0 17683.7 17863.6 17903.0 17903.3 19018.5 19258.7 19496.8 19868.5 19871.0 18344.9 18547.7 18633.6 18722.3 19037.8 17235.4 17561.0 17687.2 18096.7 18348.3 17750.0 18157.4 18177.5 18530.4 18578.7 12666.4 12687.3 12819.7 13245.8 13336.4 13860.7 14081.4 14425.1 14559.2 14944.9 05:37:40 INFO - PID 10624 | -------- Summary: end -------- 05:37:40 INFO - PID 10624 | 05:37:41 INFO - TEST-INFO | 10624: exit 0 05:37:41 INFO - TEST-OK | dromaeo_css | took 1115653ms 05:37:41 INFO - TEST-START | kraken 05:37:41 INFO - operating with platform_type : linux_ 05:37:41 INFO - Initialising browser for kraken test... 05:37:41 INFO - TEST-INFO | started process 10956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBwwJ8/profile http://localhost:49211/getInfo.html) 05:37:45 INFO - PID 10956 | __metrics Screen width/height:1600/1200 05:37:45 INFO - PID 10956 | colorDepth:24 05:37:45 INFO - PID 10956 | Browser inner width/height: 1024/695 05:37:45 INFO - PID 10956 | __metrics 05:37:46 INFO - PID 10956 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:37:46 INFO - PID 10956 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:37:47 INFO - TEST-INFO | 10956: exit 0 05:37:47 INFO - Browser initialized. 05:37:47 INFO - Running cycle 1/1 for kraken test... 05:37:47 INFO - TEST-INFO | started process 11052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBwwJ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:58 INFO - PID 11052 | RSS: Main: 149938176 05:37:58 INFO - PID 11052 | 05:38:01 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49211/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:02 INFO - PID 11052 | RSS: Main: 222826496 05:38:02 INFO - PID 11052 | 05:38:04 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49211/tests/kraken/driver.html?testName=audio-dft) 05:38:05 INFO - PID 11052 | RSS: Main: 182771712 05:38:05 INFO - PID 11052 | 05:38:08 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49211/tests/kraken/driver.html?testName=audio-fft) 05:38:09 INFO - PID 11052 | RSS: Main: 264212480 05:38:09 INFO - PID 11052 | 05:38:11 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49211/tests/kraken/driver.html?testName=audio-oscillator) 05:38:11 INFO - PID 11052 | RSS: Main: 176107520 05:38:11 INFO - PID 11052 | 05:38:13 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:14 INFO - PID 11052 | RSS: Main: 178163712 05:38:14 INFO - PID 11052 | 05:38:17 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49211/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:17 INFO - PID 11052 | RSS: Main: 240435200 05:38:17 INFO - PID 11052 | 05:38:21 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49211/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:21 INFO - PID 11052 | RSS: Main: 258347008 05:38:21 INFO - PID 11052 | 05:38:24 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49211/tests/kraken/driver.html?testName=json-parse-financial) 05:38:25 INFO - PID 11052 | RSS: Main: 272310272 05:38:25 INFO - PID 11052 | 05:38:26 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:27 INFO - PID 11052 | RSS: Main: 202969088 05:38:27 INFO - PID 11052 | 05:38:28 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49211/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:29 INFO - PID 11052 | RSS: Main: 208375808 05:38:29 INFO - PID 11052 | 05:38:31 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:32 INFO - PID 11052 | RSS: Main: 217665536 05:38:32 INFO - PID 11052 | 05:38:34 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:35 INFO - PID 11052 | RSS: Main: 226226176 05:38:35 INFO - PID 11052 | 05:38:38 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:38 INFO - PID 11052 | RSS: Main: 221990912 05:38:38 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | Cycle 1(1): loaded http://localhost:49211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49211/tests/kraken/driver.html?testName=ai-astar) 05:38:40 INFO - PID 11052 | RSS: Main: 272187392 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | __start_tp_report 05:38:40 INFO - PID 11052 | _x_x_mozilla_page_load 05:38:40 INFO - PID 11052 | _x_x_mozilla_page_load_details 05:38:40 INFO - PID 11052 | |i|pagename|runs| 05:38:40 INFO - PID 11052 | |0;ai-astar;106;110;111;109;112;110;110;111;108;113 05:38:40 INFO - PID 11052 | |1;audio-beat-detection;141;121;117;169;119;116;119;116;144;121 05:38:40 INFO - PID 11052 | |2;audio-dft;163;163;163;162;160;162;161;163;163;160 05:38:40 INFO - PID 11052 | |3;audio-fft;73;74;74;118;73;75;77;74;98;74 05:38:40 INFO - PID 11052 | |4;audio-oscillator;83;81;108;82;81;84;108;83;83;105 05:38:40 INFO - PID 11052 | |5;imaging-gaussian-blur;113;114;114;114;114;113;113;113;113;112 05:38:40 INFO - PID 11052 | |6;imaging-darkroom;147;146;148;146;146;147;148;147;146;147 05:38:40 INFO - PID 11052 | |7;imaging-desaturate;94;94;94;94;94;95;94;94;94;94 05:38:40 INFO - PID 11052 | |8;json-parse-financial;44;46;48;45;46;50;46;46;45;45 05:38:40 INFO - PID 11052 | |9;json-stringify-tinderbox;56;55;55;55;55;55;55;55;55;55 05:38:40 INFO - PID 11052 | |10;stanford-crypto-aes;82;82;82;81;82;81;81;81;81;81 05:38:40 INFO - PID 11052 | |11;stanford-crypto-ccm;135;125;133;125;131;123;123;121;170;140 05:38:40 INFO - PID 11052 | |12;stanford-crypto-pbkdf2;182;182;181;182;183;185;181;189;180;178 05:38:40 INFO - PID 11052 | |13;stanford-crypto-sha256-iterative;68;67;65;65;65;68;64;65;64;64 05:38:40 INFO - PID 11052 | __end_tp_report 05:38:40 INFO - PID 11052 | __start_cc_report 05:38:40 INFO - PID 11052 | _x_x_mozilla_cycle_collect,1724 05:38:40 INFO - PID 11052 | __end_cc_report 05:38:40 INFO - PID 11052 | __startTimestamp1494247120862__endTimestamp 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | ------- Summary: start ------- 05:38:40 INFO - PID 11052 | Number of tests: 14 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:2.00 (1.8%) stddev-sans-first:1.51 05:38:40 INFO - PID 11052 | Values: 106.0 110.0 111.0 109.0 112.0 110.0 110.0 111.0 108.0 113.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:121.00 stddev:17.56 (14.5%) stddev-sans-first:18.01 05:38:40 INFO - PID 11052 | Values: 141.0 121.0 117.0 169.0 119.0 116.0 119.0 116.0 144.0 121.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#2] audio-dft Cycles:10 Average:162.00 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 05:38:40 INFO - PID 11052 | Values: 163.0 163.0 163.0 162.0 160.0 162.0 161.0 163.0 163.0 160.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:15.03 (20.3%) stddev-sans-first:15.66 05:38:40 INFO - PID 11052 | Values: 73.0 74.0 74.0 118.0 73.0 75.0 77.0 74.0 98.0 74.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.50 stddev:11.93 (14.5%) stddev-sans-first:12.40 05:38:40 INFO - PID 11052 | Values: 83.0 81.0 108.0 82.0 81.0 84.0 108.0 83.0 83.0 105.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:38:40 INFO - PID 11052 | Values: 113.0 114.0 114.0 114.0 114.0 113.0 113.0 113.0 113.0 112.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:38:40 INFO - PID 11052 | Values: 147.0 146.0 148.0 146.0 146.0 147.0 148.0 147.0 146.0 147.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:38:40 INFO - PID 11052 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#8] json-parse-financial Cycles:10 Average:46.10 Median:46.00 stddev:1.73 (3.8%) stddev-sans-first:1.66 05:38:40 INFO - PID 11052 | Values: 44.0 46.0 48.0 45.0 46.0 50.0 46.0 46.0 45.0 45.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.32 (0.6%) stddev-sans-first:0.00 05:38:40 INFO - PID 11052 | Values: 56.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 05:38:40 INFO - PID 11052 | Values: 82.0 82.0 82.0 81.0 82.0 81.0 81.0 81.0 81.0 81.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.00 stddev:14.52 (11.0%) stddev-sans-first:15.37 05:38:40 INFO - PID 11052 | Values: 135.0 125.0 133.0 125.0 131.0 123.0 123.0 121.0 170.0 140.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:182.00 stddev:2.98 (1.6%) stddev-sans-first:3.16 05:38:40 INFO - PID 11052 | Values: 182.0 182.0 181.0 182.0 183.0 185.0 181.0 189.0 180.0 178.0 05:38:40 INFO - PID 11052 | 05:38:40 INFO - PID 11052 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:1.58 (2.4%) stddev-sans-first:1.39 05:38:40 INFO - PID 11052 | Values: 68.0 67.0 65.0 65.0 65.0 68.0 64.0 65.0 64.0 64.0 05:38:40 INFO - PID 11052 | -------- Summary: end -------- 05:38:40 INFO - PID 11052 | 05:38:42 INFO - TEST-INFO | 11052: exit 0 05:38:42 INFO - TEST-OK | kraken | took 60680ms 05:38:42 INFO - SUITE-END | took 1176s 05:38:42 INFO - Completed test suite (00:19:36) 05:38:42 INFO - javascript benchmark 05:38:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7576.0143095758485, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3331.583552055993, 3334.5998480182384, 3338.6828251316133, 3354.379439803638, 3392.440247359186, 5622.775088996445, 5630.071038278679, 5673.0, 5692.772289108436, 5761.078227483604, 5618.381977982429, 5639.661620302784, 5676.063449530822, 5698.886022279552, 5732.828015159542, 4718.110391369664, 4971.0, 5001.224810154432, 5002.374703162114, 5088.643794934337, 5080.517350851682, 5103.2090026045835, 5125.2312153176945, 5135.948640513584, 5139.306193663863, 4996.125678006352, 5049.040682270357, 5058.898822023539, 5063.316452278968, 5067.214581739836, 5094.108531007059, 5098.515641014098, 5100.107481190814, 5100.362454693163, 5105.0, 5034.421041580228, 5055.494450554915, 5076.060928728197, 5090.49095090488, 5094.0, 5664.915026274609, 5683.460071293221, 5686.601937864351, 5688.744006519675, 5692.971535142339, 6096.169680856328, 6096.381358664658, 6098.9768881920445, 6099.497746808812, 6144.815655530297, 6084.5436592255755, 6107.674343494563, 6161.9691901540655, 6163.2604087509335, 6165.84585385369, 5663.518600918968, 5674.0637794764225, 5682.318121825408, 5718.628289161191, 5721.370649228582, 6135.263768347738, 6140.570160088841, 6141.477974372139, 6164.599301045418, 6165.568410211332, 5902.38025007368, 5939.613925094855, 5944.078667806497, 5977.163197152402, 5982.910256346158, 6109.5645257506285, 6128.228138398591, 6132.4166970161305, 6132.703928623171, 6133.028644417026, 5458.181272809031, 6084.148219249309, 6091.908621370683, 6098.664573448503, 6098.908516372258, 6097.2524665300325, 6103.725332360054, 6114.174586430775, 6127.509799216052, 6136.140940268366, 4607.677462577654, 4623.982723800758, 4655.534446555385, 4669.322948172496, 4669.649776266793, 4112.527059388209, 4194.412782210493, 4194.538600753915, 4228.154369126187, 4234.78826058702, 5615.747291371898, 5707.429257074259, 5711.543076553866, 5713.143028545752, 5713.171590119493, 6018.939810601925, 6126.30393285589, 6128.295246046672, 6138.756267604181, 6142.508599312045, 5676.035074037341, 5678.119891416754, 5679.375268720438, 5680.204771332017, 5734.053881109654, 5208.557272631869, 5251.921221181686, 5254.65844720092, 5258.553022993012, 5303.28405665238, 6231.75072997075, 6269.592476489013, 6324.873502530016, 6324.905126423199, 6377.96811015942, 6117.96941015292, 6150.661713605795, 6166.414190651881, 6167.414095660905, 6180.258368995749, 6376.171097757262, 6378.968105159444, 6389.87220255583, 6390.0, 6390.936090639034, 5875.882482350244, 5957.672328021827, 5974.551908606785, 6011.428914253139, 6034.547408944259, 6099.75600975956, 6104.3075792339105, 6105.550726437353, 6114.449440885012, 6117.632942023492, 5927.436893495111, 5932.1694962706115, 5935.732892019783, 5940.762369505344, 5993.460588547052, 5894.852628684317, 5914.02418600926, 5914.2311499504785, 5916.023856063702, 6038.818835434944, 5861.706914654165, 5931.6441013539325, 5952.791652292149, 5979.312379076462, 5986.88026239464, 5888.411158884077, 5948.73230704628, 5950.7917222896995, 5954.702264886651, 5959.612625179349, 5724.885502290014, 5824.621399609012, 5830.970845145747, 5907.763689452546, 5912.438318359749], "value": 5593.58119868979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5992704012791, 781.5935713429017, 803.2048272210511, 1108.5676586131415, 1114.526326311318, 28472.145835624913, 33039.0, 36022.0, 36099.639003609955, 36103.638963610356, 36708.44937325942, 36946.0, 36977.81511092447, 37015.81492092536, 37063.625774262786, 5542.91685624716, 7073.938909163641, 7124.608146551937, 7137.8215544611285, 7149.463790215728, 5592.273004509429, 6963.512554121214, 7136.9286307137045, 7144.28557144284, 7146.428285737128, 7200.495965282433, 7234.529755565898, 7252.45606579506, 7259.74590889319, 7265.636718164097, 5445.482679145514, 7178.066851309349, 7202.351788339022, 7229.31321524457, 7233.0, 5548.889022219573, 6873.690683919235, 7022.087128673291, 7029.472789540754, 7039.612821294827, 34870.651293487, 35231.64768352309, 35263.29473410543, 35389.46915796265, 35472.113197170016, 3516.43737002081, 3558.3061303045915, 3564.180238545149, 3566.1084728817796, 3568.3933731265747, 26074.217773466826, 26086.0, 26143.60784588233, 26156.869215653798, 26179.738202617922, 3722.516072910504, 3740.7007439404783, 3766.4915236443003, 3779.130799916035, 3791.4312853071983, 187716.0, 187920.0, 187987.0, 188398.0, 188516.0, 46225.30662040072, 46259.53740462619, 46306.30540541895, 46336.5366346339, 46360.7681961588, 48496.51503484991, 48560.27159592609, 48643.75678121657, 48651.5134848647, 48693.5130648689, 14820.3330850112, 14895.851041489663, 14903.105813651217, 14905.70188596222, 14927.626809329853, 10386.376817390981, 10662.733431664115, 12194.085443591588, 12212.694682632828, 12221.388930553438, 12404.937975310066, 12933.741325173443, 13036.283004434847, 13087.541936032194, 13212.405441754952, 5276.683398996072, 5462.9726851365485, 5474.151506516497, 5484.808031718871, 5513.3108361454815, 1067.3275836223286, 1078.1751959750798, 1096.199774164864, 1104.5526561742506, 1118.6140781430393, 25818.870905645726, 25933.61099583508, 25976.350591235372, 26101.73898261031, 26121.869390652926, 1178.7112157521462, 1180.3769816502308, 1205.0540325844345, 1205.7106294489258, 1215.6960759810047, 13038.217706937614, 13472.932635336761, 13555.864441355658, 13667.384967676478, 13729.244891531062, 260325.0, 260850.0, 262767.0, 263370.0, 263508.0, 50936.23595646068, 51400.742996285524, 51507.74246128745, 51534.74232628888, 51658.0, 1472.7128209999162, 1499.2728526664778, 1506.0, 1509.2981763479816, 1511.1764088571754, 23870.641940370562, 24568.670103400236, 24784.752152478246, 24834.379140521633, 24947.39314936344, 37844.62155378411, 37993.810030949666, 38009.61990380061, 38017.61982380141, 38026.80986595049, 204347.0, 205481.0, 205744.0, 206508.0, 207885.0, 32986.83506582452, 33406.331873362884, 33406.66593334036, 33407.48998885119, 33414.0, 35104.29791404209, 35394.522383432915, 39073.413898790976, 39817.2036559273, 39983.80008099941, 29486.557701634923, 30179.849100754356, 30183.245418863826, 30423.239419014702, 31598.52602210923, 30015.399692006475, 30218.24454388658, 30501.84749076329, 31833.36333273368, 31977.0, 34959.30081398409, 35026.64973350234, 35105.64894351126, 35278.0, 35389.82305088458, 28184.295392614527, 28213.858930705213, 28285.151445456668, 28837.27906802347, 29660.0, 23278.0, 24531.754682452945, 24542.63186052175, 24723.381915452257, 24866.502669946138], "value": 16426.781321703485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.7157276197708, 430.7851857761114, 441.9116176764644, 451.4199253958663, 463.66384371330787, 19841.305554305603, 20140.19439222433, 20722.171113155473, 21090.261840835574, 21328.680069798964, 21891.562168756616, 21950.780492195074, 22207.555848883014, 22715.20496782613, 22971.0, 5211.905499845037, 5534.778608855641, 5704.172894930232, 5706.087026075828, 5709.371969083398, 5265.447128051538, 5572.749226284827, 5604.215409842625, 5605.299337582802, 5607.158926161068, 5346.171343441753, 5580.944190558103, 5585.888282234353, 5586.13414920688, 5591.30108736408, 5440.863978400552, 5535.280413546254, 5545.140503222007, 5548.833534993936, 5548.86127846803, 4994.525520075587, 5012.498750124958, 5052.267421223902, 5069.214271787842, 5071.416787069497, 24452.388690282885, 24604.630930536056, 24639.753602463927, 24681.753182468125, 24898.253052408458, 2214.9889250553806, 2221.733391992955, 2221.7889300516586, 2231.866088034723, 2250.763669814662, 16508.917455412648, 16640.417585384574, 16817.41139060127, 16994.575135621584, 17029.403970861084, 2160.546285280093, 2179.1936983316273, 2256.537409830981, 2261.570301642683, 2266.8639881607155, 103441.96558034398, 104469.0, 104637.0, 105118.47440762824, 106691.0, 12056.156069075081, 12414.503419863104, 12456.501739930301, 12493.93753031229, 12629.368531573384, 17823.910880445514, 17849.910750446423, 17863.553411164565, 17869.374571889923, 17892.821071789374, 8658.48049117055, 8772.956135219283, 8813.206811386877, 8900.332475064266, 9000.324975626854, 7920.2871741542385, 7922.445428819928, 8018.879716804253, 8159.143289954588, 8270.793230169294, 7793.610319484003, 7891.526508409399, 7909.6836126555445, 7924.48490848093, 8084.797880052928, 2220.9111635534723, 2223.6664500325082, 2232.3749350181974, 2249.718785151856, 2307.492351682627, 1043.968680939573, 1066.8186408310605, 1072.8466898084591, 1074.6561100447782, 1080.8756992945755, 20466.692999605017, 20591.176352945713, 20632.0, 20680.689789653166, 20785.89607051955, 1095.1293721491434, 1096.4956120184645, 1096.6435908329665, 1103.4096758234307, 1114.1365441782684, 10879.075278601249, 11192.216544841946, 11252.606158784403, 11299.265547739371, 11424.485898134604, 527739.0139549759, 531252.8435082984, 536411.0, 552907.0, 558022.0, 88264.67103585857, 95026.52486737522, 96125.0, 97368.53947190798, 99330.0, 1169.8362229287907, 1221.8594861590852, 1242.8881400673802, 1248.5255602871032, 1251.5056552661829, 16592.672586193316, 16894.915525422293, 17271.91364043222, 17686.469405917844, 17800.287988480315, 44927.550724493645, 45165.0, 45296.2996290638, 45654.0, 46104.538954611366, 54510.0, 54713.72643136759, 56259.43740562705, 56462.1530677032, 57129.42870571241, 9434.48110353937, 9500.904990950003, 9658.7585310365, 9731.41611503312, 10023.498825058572, 14398.0, 14668.193249371387, 14696.485623003144, 14700.926495367456, 14913.62715932067, 11189.328640281608, 11323.773524529628, 11861.644150675493, 12937.54718584845, 12970.286634235208, 11028.558857645925, 11137.443127843737, 11206.99137077667, 11255.549778009115, 11265.831012534654, 11749.76500470003, 11776.82334764962, 13274.601761947157, 13421.0, 13499.662508437368, 9302.813943721223, 9715.07706767856, 9787.217022638315, 9951.15415189717, 10238.33450825694, 11974.880251197725, 12285.754284914074, 12301.138920275494, 12746.171498852545, 12747.553835615709], "value": 10076.641464445367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.0946835139468, 1252.3174869696015, 1259.8425196850396, 1273.1024627637516, 1274.579388801695, 9593.616255349787, 11039.39283339416, 11375.374354410525, 11470.426478676074, 11494.655160345192, 11194.832077518824, 11392.658220253385, 11412.31526108434, 11415.31508109514, 11419.143564232674, 2015.475976246172, 2096.716943212662, 2375.4773949731116, 2412.5054363855456, 2413.300142958549, 2345.542619189259, 2383.797377222938, 2406.470576473182, 2414.311921102486, 2418.9758102419014, 2278.6354183330673, 2296.8621882687007, 2309.3649246457276, 2315.4327189838514, 2319.7100362454694, 2271.693321401606, 2281.2243837095384, 2287.6568514722676, 2288.096202000209, 2289.7023386959754, 2213.269621025074, 2240.417491452234, 2240.977590224093, 2243.6858839762444, 2250.774922507736, 10946.781064378747, 10993.505292261867, 11036.668899933014, 11086.889131108666, 11111.111111111173, 6354.110424540568, 6573.638449885254, 6609.372109649576, 6618.139641846529, 6624.3375662433855, 3937.330653788863, 4003.559608443069, 4156.459660244179, 4235.851745188904, 4250.936235956463, 1355.6475316417802, 1377.4008306386754, 1389.388668985653, 1389.94440222392, 1430.942762289507, 17554.91222543879, 17555.385561505285, 17562.38531651386, 17684.02737849418, 17684.823151768447, 5600.747966341524, 5629.296337957755, 5758.568107391879, 5820.330661973842, 5906.911396329058, 14354.641133971734, 14377.424903003763, 14384.928075359765, 14424.134551926709, 14425.422983080769, 6730.899036514456, 6744.763933262312, 6751.898721519181, 6756.898646520306, 6764.966175169093, 6003.129546215774, 6050.304215015241, 6107.206063211754, 6118.632882027093, 6170.845728856814, 4453.576910193527, 4506.616937560344, 4577.267637178035, 4623.214053610895, 4678.461976872703, 1369.8561651026698, 1395.1280449718927, 1395.9232242226774, 1411.3155119766905, 1413.3357322058616, 835.2733122183739, 836.9748907532784, 852.8336974290078, 867.3928250224868, 871.5772850167664, 6188.783392581238, 6702.396784289437, 6719.630420326831, 6727.091842601284, 6755.628440435823, 615.5906322295623, 620.8447888027993, 623.5261201486812, 631.9936800631934, 634.7016902056026, 3704.962950370462, 3748.3253014457114, 3769.6984241260634, 3834.6740527054953, 3868.516435445569, 13860.861391385957, 14719.0, 15134.848651513345, 15276.618084547754, 15381.230938453033, 14609.561713148623, 14748.778768318269, 14856.628584285263, 15154.0, 15206.0, 8928.73213803587, 8948.73153805387, 9106.681266155652, 9123.589438475285, 9126.133017363472, 6655.334466553306, 6683.598984060972, 6748.797536073926, 6789.762358317633, 6932.23745388017, 12890.935545322214, 12910.0, 12936.547220847226, 12985.740285194055, 13070.738585228431, 13444.731105378034, 13478.73042539124, 13518.05373623837, 13639.045266831623, 13718.725625487235, 9478.0, 9482.810343793224, 9536.952315238379, 9584.808303833745, 9644.324897257406, 10890.29213101146, 10996.890031099587, 11053.28153670009, 11055.281406708538, 11058.060064894575, 9229.538523073954, 9352.906470935204, 9439.858402124111, 9529.952350238205, 9611.663591774533, 8759.12408759119, 8768.868466972874, 8832.470051796912, 8902.59938302765, 8953.731388058368, 8013.559254240839, 8025.23760242776, 8114.472559283628, 8172.632231549714, 8242.793930151794, 5653.689047102449, 5759.769609215585, 5862.560307976833, 5938.346781853907, 5961.0, 5639.125935480007, 5737.196792448977, 5746.7701291949525, 5871.559633027455, 5895.263092113486], "value": 5302.830089890115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.6521158459674, 405.50933370621544, 407.6483538229401, 417.146934518909, 422.60908659489985, 5433.4566543345645, 5559.833205003852, 5615.578831587632, 5625.296837895263, 5652.971735141329, 5405.18922161676, 5505.174223866412, 5515.669059856412, 5516.227728118057, 5523.696196709179, 4140.958590414102, 4215.768132752697, 4231.788410579474, 4238.745675259479, 4247.065645557987, 4234.724742891717, 4251.6173544381, 4256.2338779019765, 4263.5736426357425, 4263.765492897889, 4210.957890421102, 4222.577742225783, 4223.831046758126, 4226.366045093245, 4227.746335219881, 4120.25835349637, 4196.118815048843, 4213.1573685262765, 4237.470316210489, 4239.703220774547, 3681.079730067483, 3689.6679298863232, 3692.9446058308877, 3705.6850167735774, 3706.0549559862334, 5440.863978400532, 5450.419378380265, 5457.918131227995, 5463.399026107125, 5466.835994920159, 4893.070316639827, 4916.631252656065, 4946.72792996385, 4947.109520286347, 4959.950400496021, 5878.177055212273, 5881.2942446906645, 5894.646321220741, 5896.439838215363, 5902.734376953047, 4144.834206631731, 4153.335466325373, 4162.146759914211, 4165.708400411972, 4169.624733773944, 6024.759009639609, 6068.33248342682, 6092.45167934888, 6102.206713127265, 6166.136740856239, 4230.2174097792, 4242.596953289432, 4244.660427165819, 4247.00195454068, 4253.617174454252, 4296.312589985588, 4301.096769678403, 4306.913861722811, 4307.267764480046, 4308.1814455254025, 4698.718076915396, 4848.200046992207, 4891.755412229374, 4973.403191617029, 4979.983106841735, 5908.172855800191, 5908.20239267702, 5918.615290006136, 5925.762969481172, 5956.362000449911, 1462.2104063805639, 1474.9262536873114, 1483.4437086092714, 1483.8812894968376, 1486.9033512821632, 993.0516356879164, 994.3536701144315, 997.3168379659957, 1000.8698869146964, 1013.4881884648205, 5675.347335056439, 5680.176374425685, 5689.800856969986, 5690.573207009491, 5713.314402271671, 6093.96953015241, 6115.571909966348, 6118.357572454828, 6119.755209791648, 6122.265328160649, 5522.564133325364, 5637.3235211774845, 5669.121286200645, 5669.773209071674, 5686.834198989197, 3174.174714574181, 3195.4887218045, 3201.3597280543986, 3201.4077395681875, 3201.695838895301, 6101.84745381369, 6311.684415779285, 6344.968275158594, 6345.809625711236, 6399.8080057598345, 5971.611845230046, 6278.4035516625845, 6279.780207692709, 6286.245650521967, 6296.527760417987, 6192.690365481708, 6213.285472170668, 6314.526410519229, 6320.209973753281, 6350.650714210763, 5826.883462330645, 6071.726772295346, 6088.6042407243385, 6090.847728806815, 6092.421219984094, 5654.830355089354, 5989.970050149721, 6000.5799594028, 6057.848553786014, 6070.514358851369, 6271.529635277281, 6303.936960630518, 6304.779332723516, 6327.778527751507, 6347.96826015867, 4573.794179261875, 4642.651801114997, 4701.952980470288, 4711.8350857719815, 4733.597644200281, 6081.93566125935, 6096.420840020191, 6103.11504831788, 6108.205933228652, 6127.509799215963, 5795.449432303924, 5874.882502350015, 5876.882462350643, 5909.3795151508475, 5974.64152150855, 5894.410558944071, 5899.174115623902, 5909.449723712632, 5919.704014799329, 5928.318243402064, 5890.764369425347, 5895.263092113486, 5896.911546326723, 5899.970500147472, 5923.970380148072, 5772.740226689725, 5878.647281163144, 5928.822135335947, 5940.020186475159, 5946.256717910262, 5783.074708046693, 5806.796762113475, 5813.273340832396, 5822.400303759982, 5823.126531020381], "value": 4499.219603764454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.4090988582705, 879.8020445399786, 892.005413963431, 894.5750768385018, 896.551724137931, 15679.216039198038, 16148.596285092879, 16595.419160329377, 16600.50198494044, 16621.501354959357, 16965.236564354604, 17106.914465427657, 17352.47942561725, 17366.739498907496, 17368.913155434206, 1004.7588578741122, 1025.830737928241, 1032.2206733915882, 1032.592126110186, 1033.0, 992.846108853129, 1016.5425558498669, 1017.8524114003502, 1023.3706270643538, 1024.0629823711295, 1077.6820837852852, 1080.206048554312, 1080.2708171983918, 1080.6055789636766, 1080.9783804323947, 1069.1927594666056, 1069.5294070608907, 1070.812607793633, 1071.2073065931195, 1071.4000159910474, 787.3347021766598, 791.6516732637679, 792.1167897793919, 792.2473650032434, 793.1592511937365, 17448.214830332665, 17664.735028974577, 17867.73198402012, 17965.191566379413, 18137.63724725498, 18806.62386752271, 19185.712214316798, 19344.032798360167, 19388.612227755508, 19506.80493195064, 14775.113493190336, 15027.699446011127, 15175.772363414557, 15209.315580798891, 15294.464693735667, 3363.075154332578, 3445.2592692570965, 3455.2398472336045, 3481.0253129123885, 3486.7210623150086, 89895.0, 90818.09181908163, 92328.53835730845, 92513.0, 92919.53540232324, 14467.204303763394, 14768.483103091341, 15085.773713394308, 15314.770278445832, 15602.609934751496, 27380.0, 27914.86042569774, 27986.440271194868, 28374.148775536767, 28759.71240287612, 8109.7161599343735, 8339.332853371716, 8372.0, 8469.195426434479, 8478.236958673626, 4010.298197815429, 4062.370332598452, 4082.8775136745353, 4087.509498860156, 4093.672506199497, 4442.555744425532, 4482.305242687388, 4498.685092043591, 4560.612347950395, 4610.76946152691, 868.4224990381325, 894.9731508054768, 897.7396554999108, 902.1294450854956, 910.6949172027313, 675.587891386254, 707.7735124760027, 710.6482291265856, 714.6891102370486, 719.4244604316526, 11986.64040078799, 13163.341832908316, 13167.539136130381, 13736.793948090786, 13772.724545509034, 724.8260417499868, 736.988945165823, 742.4988133010304, 743.8475112601903, 749.9775006749807, 5795.94204057954, 6052.485538729169, 6352.745890164341, 6368.808935731936, 6528.575642583217, 83068.58465707632, 86685.0, 86754.56622716846, 89828.0, 90858.54570727104, 71472.64263678648, 72962.0, 74358.0, 74544.62727686326, 75791.0, 67366.0, 69452.0, 69494.65252673705, 69912.0, 70236.6488167556, 13147.53983610569, 13609.387577559231, 13743.793843092162, 13791.724165516835, 13867.583972480841, 35055.071971041834, 35189.12027199341, 35803.82098089493, 36096.81951590225, 36126.63314573625, 44162.55837441584, 44178.77910610555, 44679.776601116784, 44848.32727509155, 45485.317720233565, 17429.0, 17683.73474397911, 17863.553411164823, 17903.0, 17903.283868645107, 19018.52453688669, 19258.7111193335, 19496.805031949498, 19868.503287417352, 19871.0, 18344.90827545907, 18547.72178417298, 18633.627327453647, 18722.251109955992, 19037.809621903605, 17235.3967611133, 17561.0, 17687.204075816877, 18096.72854907151, 18348.256915592996, 17750.0, 18157.36449224271, 18177.545561361072, 18530.351437699617, 18578.721319179953, 12666.43001064936, 12687.302198379179, 12819.679508012001, 13245.80131298012, 13336.399862006427, 13860.653483662989, 14081.436742530594, 14425.134491930517, 14559.199244041256, 14944.850551494346], "value": 8558.7274536328, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 111.0, 109.0, 112.0, 110.0, 110.0, 111.0, 108.0, 113.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 121.0, 117.0, 169.0, 119.0, 116.0, 119.0, 116.0, 144.0, 121.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 160.0, 162.0, 161.0, 163.0, 163.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 118.0, 73.0, 75.0, 77.0, 74.0, 98.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 108.0, 82.0, 81.0, 84.0, 108.0, 83.0, 83.0, 105.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 46.0, 48.0, 45.0, 46.0, 50.0, 46.0, 46.0, 45.0, 45.0], "value": 46.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 81.0, 82.0, 81.0, 81.0, 81.0, 81.0, 81.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 125.0, 133.0, 125.0, 131.0, 123.0, 123.0, 121.0, 170.0, 140.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 181.0, 182.0, 183.0, 185.0, 181.0, 189.0, 180.0, 178.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 65.0, 65.0, 68.0, 64.0, 65.0, 64.0, 64.0], "value": 65.5, "unit": "score"}]}]} 05:38:42 INFO - Return code: 0 05:38:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:38:42 INFO - # TBPL SUCCESS # 05:38:42 INFO - Running post-action listener: _resource_record_post_action 05:38:42 INFO - [mozharness: 2017-05-08 12:38:42.664542Z] Finished run-tests step (success) 05:38:42 INFO - Running post-run listener: _resource_record_post_run 05:38:42 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 364351488; Read time: 0; Write time: 351544 05:38:42 INFO - TinderboxPrint: CPU usage
12.9% 05:38:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:38:42 INFO - TinderboxPrint: I/O write bytes / time
364,351,488 / 351,544 05:38:42 INFO - TinderboxPrint: CPU idle
8,301.1 (87.1%) 05:38:42 INFO - TinderboxPrint: CPU user
1,184.4 (12.4%) 05:38:42 INFO - TinderboxPrint: Swap in / out
0 / 0 05:38:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 103346176; Read time: 0; Write time: 145680 05:38:42 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 260505600; Read time: 0; Write time: 205740 05:38:43 INFO - Running post-run listener: _upload_blobber_files 05:38:43 INFO - Blob upload gear active. 05:38:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:38:43 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:44 INFO - (blobuploader) - INFO - Done attempting. 05:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:38:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:48 INFO - (blobuploader) - INFO - Done attempting. 05:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:38:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:49 INFO - (blobuploader) - INFO - Done attempting. 05:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:50 INFO - (blobuploader) - INFO - Done attempting. 05:38:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:50 INFO - Return code: 0 05:38:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f66228c3d5649c8bcd8a777d355cc99aa656a823268f8701a1bf30aac798f920e664ab02969ed24ee60173243326d33e93667b96479cea1847c712ffafc2aa5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e1a2f03462fdd8d2afc1cf05671a1469265f946fa7734a77227a6f44ce2a109d17d86f2e3061d0b6a7c16112aa00cb011a29f937eef786f14aff56d3eb1625b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56e655d578694fe8943a2cba55bf0f40f9861e29216408ff3878f4610586926b80d9c71800cd13fbdfadc355dc94af09bd1841106d86de1508a3f17f9e8dd2e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1933f07828ee781de3496524be4b4b8b83852b8fa6dc5d2259dcfcb2dd680b6a987100c225926be457094ebe46ea388bb43c848756794ea71af8455486b4d57a"} 05:38:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:50 INFO - Contents: 05:38:50 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f66228c3d5649c8bcd8a777d355cc99aa656a823268f8701a1bf30aac798f920e664ab02969ed24ee60173243326d33e93667b96479cea1847c712ffafc2aa5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e1a2f03462fdd8d2afc1cf05671a1469265f946fa7734a77227a6f44ce2a109d17d86f2e3061d0b6a7c16112aa00cb011a29f937eef786f14aff56d3eb1625b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56e655d578694fe8943a2cba55bf0f40f9861e29216408ff3878f4610586926b80d9c71800cd13fbdfadc355dc94af09bd1841106d86de1508a3f17f9e8dd2e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1933f07828ee781de3496524be4b4b8b83852b8fa6dc5d2259dcfcb2dd680b6a987100c225926be457094ebe46ea388bb43c848756794ea71af8455486b4d57a"} 05:38:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:50 INFO - Copying logs to upload dir... 05:38:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.021117 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-08 05:38:48.906282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 05:38:48.909609) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1494243217.520519-1649372740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f66228c3d5649c8bcd8a777d355cc99aa656a823268f8701a1bf30aac798f920e664ab02969ed24ee60173243326d33e93667b96479cea1847c712ffafc2aa5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e1a2f03462fdd8d2afc1cf05671a1469265f946fa7734a77227a6f44ce2a109d17d86f2e3061d0b6a7c16112aa00cb011a29f937eef786f14aff56d3eb1625b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56e655d578694fe8943a2cba55bf0f40f9861e29216408ff3878f4610586926b80d9c71800cd13fbdfadc355dc94af09bd1841106d86de1508a3f17f9e8dd2e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1933f07828ee781de3496524be4b4b8b83852b8fa6dc5d2259dcfcb2dd680b6a987100c225926be457094ebe46ea388bb43c848756794ea71af8455486b4d57a"} build_url:https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/Ux01QjPkRBa95o8xlSG6LQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f66228c3d5649c8bcd8a777d355cc99aa656a823268f8701a1bf30aac798f920e664ab02969ed24ee60173243326d33e93667b96479cea1847c712ffafc2aa5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e1a2f03462fdd8d2afc1cf05671a1469265f946fa7734a77227a6f44ce2a109d17d86f2e3061d0b6a7c16112aa00cb011a29f937eef786f14aff56d3eb1625b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56e655d578694fe8943a2cba55bf0f40f9861e29216408ff3878f4610586926b80d9c71800cd13fbdfadc355dc94af09bd1841106d86de1508a3f17f9e8dd2e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1933f07828ee781de3496524be4b4b8b83852b8fa6dc5d2259dcfcb2dd680b6a987100c225926be457094ebe46ea388bb43c848756794ea71af8455486b4d57a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 05:38:48.935548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:38:48.935891) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1494243217.520519-1649372740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:38:49.021108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 05:38:49.021422) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 05:38:49.021736) ========= ========= Total master_lag: 0.16 =========