builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-076 starttime: 1491235742.86 results: success (0) revision: 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:02.858180) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:02.858643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:02.858948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:02.873744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:02.874074) ========= 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=9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-03 09:09:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.2M=0s 2017-04-03 09:09:03 (80.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117334 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.005750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.006101) ========= 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=9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018651 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.055869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.056216) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b --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 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b --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=9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-03 09:09:03,393 truncating revision to first 12 chars 2017-04-03 09:09:03,393 Setting DEBUG logging. 2017-04-03 09:09:03,393 attempt 1/10 2017-04-03 09:09:03,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9aacfa8081b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 09:09:03,697 unpacking tar archive at: mozilla-central-9aacfa8081b3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607040 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.676680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.677009) ========= script_repo_revision: 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.677393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.677666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 09:09:03.686916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-04-03 09:09:03.687188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:09:04 INFO - MultiFileLogger online at 20170403 09:09:04 in /builds/slave/test 09:09:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:09:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:09:04 INFO - {'append_to_log': False, 09:09:04 INFO - 'base_work_dir': '/builds/slave/test', 09:09:04 INFO - 'blob_upload_branch': 'Firefox', 09:09:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:09:04 INFO - 'branch': 'Firefox', 09:09:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:09:04 INFO - 'config_files': ('talos/linux_config.py',), 09:09:04 INFO - 'default_actions': ('clobber', 09:09:04 INFO - 'read-buildbot-config', 09:09:04 INFO - 'download-and-extract', 09:09:04 INFO - 'populate-webroot', 09:09:04 INFO - 'create-virtualenv', 09:09:04 INFO - 'install', 09:09:04 INFO - 'run-tests'), 09:09:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:09:04 INFO - 'download_minidump_stackwalk': True, 09:09:04 INFO - 'download_symbols': 'ondemand', 09:09:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:09:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:09:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:09:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:09:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:09:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:09:04 INFO - 'gecko_profile': False, 09:09:04 INFO - 'gecko_profile_interval': 0, 09:09:04 INFO - 'installer_path': 'installer.exe', 09:09:04 INFO - 'log_level': 'info', 09:09:04 INFO - 'log_name': 'talos', 09:09:04 INFO - 'log_to_console': True, 09:09:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:09:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:09:04 INFO - 'opt_config_files': (), 09:09:04 INFO - 'pip_index': False, 09:09:04 INFO - 'suite': 'dromaeojs', 09:09:04 INFO - 'system_bits': '32', 09:09:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:09:04 INFO - 'title': 'talos-linux64-ix-076', 09:09:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:09:04 INFO - 'use_talos_json': True, 09:09:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:09:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:09:04 INFO - 'work_dir': 'build'} 09:09:04 INFO - [mozharness: 2017-04-03 16:09:04.127553Z] Running clobber step. 09:09:04 INFO - Running pre-action listener: _resource_record_pre_action 09:09:04 INFO - Running main action method: clobber 09:09:04 INFO - rmtree: /builds/slave/test/build 09:09:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:09:05 INFO - Running post-action listener: _resource_record_post_action 09:09:05 INFO - [mozharness: 2017-04-03 16:09:05.106728Z] Finished clobber step (success) 09:09:05 INFO - [mozharness: 2017-04-03 16:09:05.107164Z] Running read-buildbot-config step. 09:09:05 INFO - Running pre-action listener: _resource_record_pre_action 09:09:05 INFO - Running main action method: read_buildbot_config 09:09:05 INFO - Using buildbot properties: 09:09:05 INFO - { 09:09:05 INFO - "project": "", 09:09:05 INFO - "product": "firefox", 09:09:05 INFO - "who": "ffxbld@noreply.mozilla.org", 09:09:05 INFO - "installer_path": "public/build/target.tar.bz2", 09:09:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:09:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:09:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:09:05 INFO - "stage_platform": "linux64-pgo", 09:09:05 INFO - "basedir": "/builds/slave/test", 09:09:05 INFO - "buildnumber": 109, 09:09:05 INFO - "platform": "ubuntu64_hw", 09:09:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:09:05 INFO - "slavebuilddir": "test", 09:09:05 INFO - "taskId": "ZoyWL0DURaGCQ5XirQK4Kg", 09:09:05 INFO - "branch": "mozilla-central", 09:09:05 INFO - "script_repo_revision": "production", 09:09:05 INFO - "revision": "9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b", 09:09:05 INFO - "slavename": "talos-linux64-ix-076", 09:09:05 INFO - "repo_path": "mozilla-central" 09:09:05 INFO - } 09:09:05 INFO - Finding installer, test and symbols from parent task. 09:09:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZoyWL0DURaGCQ5XirQK4Kg'}, attempt #1 09:09:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZoyWL0DURaGCQ5XirQK4Kg'}, attempt #1 09:09:06 INFO - Task dependencies: NMpKVKhXThOBMrJOGrpsTA 09:09:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA'}, attempt #1 09:09:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.tar.bz2 09:09:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/test_packages.json 09:09:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.crashreporter-symbols.zip 09:09:06 INFO - Running post-action listener: _resource_record_post_action 09:09:06 INFO - [mozharness: 2017-04-03 16:09:06.515480Z] Finished read-buildbot-config step (success) 09:09:06 INFO - [mozharness: 2017-04-03 16:09:06.515699Z] Running download-and-extract step. 09:09:06 INFO - Running pre-action listener: _resource_record_pre_action 09:09:06 INFO - Running main action method: download_and_extract 09:09:06 INFO - mkdir: /builds/slave/test/build/tests 09:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:06 INFO - trying https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.test_packages.json 09:09:06 INFO - Downloading https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:09:07 INFO - Downloaded 986 bytes. 09:09:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:09:07 INFO - Using the following test package requirements: 09:09:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:09:07 INFO - u'common': [u'target.common.tests.zip'], 09:09:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:09:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:09:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:09:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:09:07 INFO - u'mozbase': [u'target.common.tests.zip'], 09:09:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:09:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:09:07 INFO - u'web-platform': [u'target.common.tests.zip', 09:09:07 INFO - u'target.web-platform.tests.zip'], 09:09:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:09:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:09:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.common.tests.zip 09:09:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:09:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.common.tests.zip into memory 09:09:08 INFO - Expected file size: 60356276 09:09:08 INFO - Obtained file size: 60356276 09:09:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:09:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.common.tests.zip 09:09:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:09:18 INFO - Fetch https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.common.tests.zip into memory 09:09:19 INFO - Expected file size: 60356276 09:09:19 INFO - Obtained file size: 60356276 09:09:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.talos.tests.zip 09:09:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:09:30 INFO - Fetch https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.talos.tests.zip into memory 09:09:30 INFO - Expected file size: 14404152 09:09:30 INFO - Obtained file size: 14404152 09:09:31 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')]} 09:09:31 INFO - trying https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.tar.bz2 09:09:31 INFO - Downloading https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:09:32 INFO - Downloaded 67931526 bytes. 09:09:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.tar.bz2 09:09:32 INFO - mkdir: /builds/slave/test/properties 09:09:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:09:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:09:32 INFO - Contents: 09:09:32 INFO - build_url:https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.tar.bz2 09:09:32 INFO - Running post-action listener: _resource_record_post_action 09:09:32 INFO - Running post-action listener: set_extra_try_arguments 09:09:32 INFO - [mozharness: 2017-04-03 16:09:32.343393Z] Finished download-and-extract step (success) 09:09:32 INFO - [mozharness: 2017-04-03 16:09:32.343490Z] Running populate-webroot step. 09:09:32 INFO - Running pre-action listener: _resource_record_pre_action 09:09:32 INFO - Running main action method: populate_webroot 09:09:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:09:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:09:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:09:32 INFO - '--tppagecycles', 09:09:32 INFO - '7'], 09:09:32 INFO - 'tests': ['tsvgm']}}, 09:09:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:09:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:09:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:09:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:09:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:09:32 INFO - 'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:09:32 INFO - 'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['damp', 'tps']}, 09:09:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:09:32 INFO - 'tests': ['damp', 'tps']}, 09:09:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['dromaeo_dom']}, 09:09:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:09:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['basic_compositor_video']}, 09:09:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:09:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore', 09:09:32 INFO - 'tabpaint']}, 09:09:32 INFO - 'other-e10s': {'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore', 09:09:32 INFO - 'tabpaint']}, 09:09:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore', 09:09:32 INFO - 'tabpaint']}, 09:09:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore', 09:09:32 INFO - 'tabpaint']}, 09:09:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore', 09:09:32 INFO - 'tabpaint']}, 09:09:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore', 09:09:32 INFO - 'tabpaint']}, 09:09:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['tsvgx', 09:09:32 INFO - 'tsvgr_opacity', 09:09:32 INFO - 'tart', 09:09:32 INFO - 'tscrollx', 09:09:32 INFO - 'cart', 09:09:32 INFO - 'tsvg_static']}, 09:09:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:09:32 INFO - 'tsvgr_opacity', 09:09:32 INFO - 'tart', 09:09:32 INFO - 'tscrollx', 09:09:32 INFO - 'cart', 09:09:32 INFO - 'tsvg_static']}, 09:09:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:09:32 INFO - 'talos_options': ['--disable-e10s'], 09:09:32 INFO - 'tests': ['tp5o']}, 09:09:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:09:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:09:32 INFO - 'talos_options': ['--disable-e10s', 09:09:32 INFO - '--xperf_path', 09:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:32 INFO - 'tests': ['tp5n']}, 09:09:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:09:32 INFO - 'talos_options': ['--xperf_path', 09:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:32 INFO - 'tests': ['tp5n']}}, 09:09:32 INFO - 'talos.zip': {'path': '', 09:09:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:09:32 INFO - Running post-action listener: _resource_record_post_action 09:09:32 INFO - [mozharness: 2017-04-03 16:09:32.356768Z] Finished populate-webroot step (success) 09:09:32 INFO - [mozharness: 2017-04-03 16:09:32.356859Z] Running create-virtualenv step. 09:09:32 INFO - Running pre-action listener: _resource_record_pre_action 09:09:32 INFO - Running main action method: create_virtualenv 09:09:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:09:32 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 09:09:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:09:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:09:32 INFO - Using real prefix '/usr' 09:09:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:09:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:09:34 INFO - Installing pip.................done. 09:09:34 INFO - Return code: 0 09:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:09:35 INFO - Reading from file tmpfile_stdout 09:09:35 INFO - Output received: 09:09:35 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) 09:09:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09: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', 'pip>=1.5'] in /builds/slave/test/build 09:09: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 pip>=1.5 09:09:35 INFO - Using env: {'DISPLAY': ':0', 09:09:35 INFO - 'HOME': '/home/cltbld', 09:09:35 INFO - 'LANG': 'en_US.UTF-8', 09:09:35 INFO - 'LANGUAGE': 'en_US:en', 09:09:35 INFO - 'LOGNAME': 'cltbld', 09:09:35 INFO - 'MAIL': '/var/mail/cltbld', 09:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:35 INFO - 'MOZ_NO_REMOTE': '1', 09:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:35 INFO - 'NO_EM_RESTART': '1', 09:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:35 INFO - 'PWD': '/builds/slave/test', 09:09:35 INFO - 'SHELL': '/bin/bash', 09:09:35 INFO - 'SHLVL': '1', 09:09:35 INFO - 'TERM': 'linux', 09:09:35 INFO - 'TMOUT': '86400', 09:09:35 INFO - 'USER': 'cltbld', 09:09:35 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:35 INFO - '_': '/tools/buildbot/bin/python'} 09:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:35 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 09:09:35 INFO - Cleaning up... 09:09:35 INFO - Return code: 0 09:09:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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', '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 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:09: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 psutil>=3.1.1 09:09:35 INFO - Using env: {'DISPLAY': ':0', 09:09:35 INFO - 'HOME': '/home/cltbld', 09:09:35 INFO - 'LANG': 'en_US.UTF-8', 09:09:35 INFO - 'LANGUAGE': 'en_US:en', 09:09:35 INFO - 'LOGNAME': 'cltbld', 09:09:35 INFO - 'MAIL': '/var/mail/cltbld', 09:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:35 INFO - 'MOZ_NO_REMOTE': '1', 09:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:35 INFO - 'NO_EM_RESTART': '1', 09:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:35 INFO - 'PWD': '/builds/slave/test', 09:09:35 INFO - 'SHELL': '/bin/bash', 09:09:35 INFO - 'SHLVL': '1', 09:09:35 INFO - 'TERM': 'linux', 09:09:35 INFO - 'TMOUT': '86400', 09:09:35 INFO - 'USER': 'cltbld', 09:09:35 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:35 INFO - '_': '/tools/buildbot/bin/python'} 09:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:35 INFO - Downloading/unpacking psutil>=3.1.1 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:09:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:37 INFO - Installing collected packages: psutil 09:09:37 INFO - Running setup.py install for psutil 09:09:37 INFO - building 'psutil._psutil_linux' extension 09:09:37 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 09:09:37 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 09:09:37 INFO - building 'psutil._psutil_posix' extension 09:09:37 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 09:09:38 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 09:09:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:38 INFO - Successfully installed psutil 09:09:38 INFO - Cleaning up... 09:09:38 INFO - Return code: 0 09:09:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:09: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 mozsystemmonitor==0.3 09:09:38 INFO - Using env: {'DISPLAY': ':0', 09:09:38 INFO - 'HOME': '/home/cltbld', 09:09:38 INFO - 'LANG': 'en_US.UTF-8', 09:09:38 INFO - 'LANGUAGE': 'en_US:en', 09:09:38 INFO - 'LOGNAME': 'cltbld', 09:09:38 INFO - 'MAIL': '/var/mail/cltbld', 09:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:38 INFO - 'MOZ_NO_REMOTE': '1', 09:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:38 INFO - 'NO_EM_RESTART': '1', 09:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:38 INFO - 'PWD': '/builds/slave/test', 09:09:38 INFO - 'SHELL': '/bin/bash', 09:09:38 INFO - 'SHLVL': '1', 09:09:38 INFO - 'TERM': 'linux', 09:09:38 INFO - 'TMOUT': '86400', 09:09:38 INFO - 'USER': 'cltbld', 09:09:38 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:38 INFO - '_': '/tools/buildbot/bin/python'} 09:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:09:40 INFO - Installing collected packages: mozsystemmonitor 09:09:40 INFO - Running setup.py install for mozsystemmonitor 09:09:40 INFO - Successfully installed mozsystemmonitor 09:09:40 INFO - Cleaning up... 09:09:40 INFO - Return code: 0 09:09:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:09:40 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')]} 09:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:40 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')]} 09:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:40 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 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09:40 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 09:09:40 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 09:09:40 INFO - Using env: {'DISPLAY': ':0', 09:09:40 INFO - 'HOME': '/home/cltbld', 09:09:40 INFO - 'LANG': 'en_US.UTF-8', 09:09:40 INFO - 'LANGUAGE': 'en_US:en', 09:09:40 INFO - 'LOGNAME': 'cltbld', 09:09:40 INFO - 'MAIL': '/var/mail/cltbld', 09:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:40 INFO - 'MOZ_NO_REMOTE': '1', 09:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:40 INFO - 'NO_EM_RESTART': '1', 09:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:40 INFO - 'PWD': '/builds/slave/test', 09:09:40 INFO - 'SHELL': '/bin/bash', 09:09:40 INFO - 'SHLVL': '1', 09:09:40 INFO - 'TERM': 'linux', 09:09:40 INFO - 'TMOUT': '86400', 09:09:40 INFO - 'USER': 'cltbld', 09:09:40 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:40 INFO - '_': '/tools/buildbot/bin/python'} 09:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:09:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:09:42 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 09:09:42 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 09:09:42 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 09:09:42 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 09:09:42 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 09:09:42 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 09:09:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:09:43 INFO - warning: no files found matching '*.txt' 09:09:43 INFO - no previously-included directories found matching 'build' 09:09:43 INFO - no previously-included directories found matching 'dist' 09:09:43 INFO - no previously-included directories found matching '.git*' 09:09:43 INFO - Installing collected packages: jsonschema, functools32 09:09:43 INFO - Running setup.py install for functools32 09:09:43 INFO - warning: no files found matching '*.txt' 09:09:43 INFO - no previously-included directories found matching 'build' 09:09:43 INFO - no previously-included directories found matching 'dist' 09:09:43 INFO - no previously-included directories found matching '.git*' 09:09:43 INFO - Successfully installed jsonschema functools32 09:09:43 INFO - Cleaning up... 09:09:43 INFO - Return code: 0 09:09:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:09:43 INFO - Using env: {'DISPLAY': ':0', 09:09:43 INFO - 'HOME': '/home/cltbld', 09:09:43 INFO - 'LANG': 'en_US.UTF-8', 09:09:43 INFO - 'LANGUAGE': 'en_US:en', 09:09:43 INFO - 'LOGNAME': 'cltbld', 09:09:43 INFO - 'MAIL': '/var/mail/cltbld', 09:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:43 INFO - 'MOZ_NO_REMOTE': '1', 09:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:43 INFO - 'NO_EM_RESTART': '1', 09:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:43 INFO - 'PWD': '/builds/slave/test', 09:09:43 INFO - 'SHELL': '/bin/bash', 09:09:43 INFO - 'SHLVL': '1', 09:09:43 INFO - 'TERM': 'linux', 09:09:43 INFO - 'TMOUT': '86400', 09:09:43 INFO - 'USER': 'cltbld', 09:09:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:43 INFO - '_': '/tools/buildbot/bin/python'} 09:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:09:43 INFO - Cleaning up... 09:09:43 INFO - Return code: 0 09:09:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:09:43 INFO - Using env: {'DISPLAY': ':0', 09:09:43 INFO - 'HOME': '/home/cltbld', 09:09:43 INFO - 'LANG': 'en_US.UTF-8', 09:09:43 INFO - 'LANGUAGE': 'en_US:en', 09:09:43 INFO - 'LOGNAME': 'cltbld', 09:09:43 INFO - 'MAIL': '/var/mail/cltbld', 09:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:43 INFO - 'MOZ_NO_REMOTE': '1', 09:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:43 INFO - 'NO_EM_RESTART': '1', 09:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:43 INFO - 'PWD': '/builds/slave/test', 09:09:43 INFO - 'SHELL': '/bin/bash', 09:09:43 INFO - 'SHLVL': '1', 09:09:43 INFO - 'TERM': 'linux', 09:09:43 INFO - 'TMOUT': '86400', 09:09:43 INFO - 'USER': 'cltbld', 09:09:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:43 INFO - '_': '/tools/buildbot/bin/python'} 09:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:46 INFO - Downloading docopt-0.6.1.tar.gz 09:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:46 INFO - Running setup.py install for blobuploader 09:09:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:46 INFO - Running setup.py install for requests 09:09:47 INFO - Running setup.py install for docopt 09:09:47 INFO - Successfully installed blobuploader requests docopt 09:09:47 INFO - Cleaning up... 09:09:47 INFO - Return code: 0 09:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:47 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 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09:47 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 09:09:47 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 09:09:47 INFO - Using env: {'DISPLAY': ':0', 09:09:47 INFO - 'HOME': '/home/cltbld', 09:09:47 INFO - 'LANG': 'en_US.UTF-8', 09:09:47 INFO - 'LANGUAGE': 'en_US:en', 09:09:47 INFO - 'LOGNAME': 'cltbld', 09:09:47 INFO - 'MAIL': '/var/mail/cltbld', 09:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:47 INFO - 'MOZ_NO_REMOTE': '1', 09:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:47 INFO - 'NO_EM_RESTART': '1', 09:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:47 INFO - 'PWD': '/builds/slave/test', 09:09:47 INFO - 'SHELL': '/bin/bash', 09:09:47 INFO - 'SHLVL': '1', 09:09:47 INFO - 'TERM': 'linux', 09:09:47 INFO - 'TMOUT': '86400', 09:09:47 INFO - 'USER': 'cltbld', 09:09:47 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:47 INFO - '_': '/tools/buildbot/bin/python'} 09:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:47 INFO - Running setup.py (path:/tmp/pip-VVZYNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:47 INFO - Running setup.py (path:/tmp/pip-lQtLia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:47 INFO - Running setup.py (path:/tmp/pip-FUEk1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:47 INFO - Running setup.py (path:/tmp/pip-IIA1Rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:47 INFO - Running setup.py (path:/tmp/pip-d2wrGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:48 INFO - Running setup.py (path:/tmp/pip-vO18FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:48 INFO - Running setup.py (path:/tmp/pip-YXVFSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:48 INFO - Running setup.py (path:/tmp/pip-ogmo_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:48 INFO - Running setup.py (path:/tmp/pip-K7m_3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:48 INFO - Running setup.py (path:/tmp/pip-BrkeWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:48 INFO - Running setup.py (path:/tmp/pip-AvaNdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:48 INFO - Running setup.py (path:/tmp/pip-o518LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:48 INFO - Running setup.py (path:/tmp/pip-0Qx7tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:48 INFO - Running setup.py (path:/tmp/pip-5cUahT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:48 INFO - Running setup.py (path:/tmp/pip-NFcqvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:48 INFO - Running setup.py (path:/tmp/pip-f944hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:48 INFO - Running setup.py (path:/tmp/pip-e8Cz3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:48 INFO - Running setup.py install for manifestparser 09:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Running setup.py install for mozcrash 09:09:49 INFO - Running setup.py install for mozdebug 09:09:49 INFO - Running setup.py install for mozdevice 09:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Running setup.py install for mozfile 09:09:49 INFO - Running setup.py install for mozhttpd 09:09:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Running setup.py install for mozinfo 09:09:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Running setup.py install for mozInstall 09:09:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Running setup.py install for mozleak 09:09:49 INFO - Running setup.py install for mozlog 09:09:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Running setup.py install for moznetwork 09:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:50 INFO - Running setup.py install for mozprocess 09:09:50 INFO - Running setup.py install for mozprofile 09:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:50 INFO - Running setup.py install for mozrunner 09:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:50 INFO - Running setup.py install for mozscreenshot 09:09:50 INFO - Running setup.py install for moztest 09:09:50 INFO - Running setup.py install for mozversion 09:09:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:50 INFO - Cleaning up... 09:09:50 INFO - Return code: 0 09:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:50 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 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09:50 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 09:09:50 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 09:09:50 INFO - Using env: {'DISPLAY': ':0', 09:09:50 INFO - 'HOME': '/home/cltbld', 09:09:50 INFO - 'LANG': 'en_US.UTF-8', 09:09:50 INFO - 'LANGUAGE': 'en_US:en', 09:09:50 INFO - 'LOGNAME': 'cltbld', 09:09:50 INFO - 'MAIL': '/var/mail/cltbld', 09:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:50 INFO - 'MOZ_NO_REMOTE': '1', 09:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:50 INFO - 'NO_EM_RESTART': '1', 09:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:50 INFO - 'PWD': '/builds/slave/test', 09:09:50 INFO - 'SHELL': '/bin/bash', 09:09:50 INFO - 'SHLVL': '1', 09:09:50 INFO - 'TERM': 'linux', 09:09:50 INFO - 'TMOUT': '86400', 09:09:50 INFO - 'USER': 'cltbld', 09:09:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:50 INFO - '_': '/tools/buildbot/bin/python'} 09:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:50 INFO - Running setup.py (path:/tmp/pip-QOCJUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:50 INFO - Running setup.py (path:/tmp/pip-qOdTDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:51 INFO - Running setup.py (path:/tmp/pip-1gI6FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:51 INFO - Running setup.py (path:/tmp/pip-lqWHIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:51 INFO - Running setup.py (path:/tmp/pip-gWqPdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:51 INFO - Running setup.py (path:/tmp/pip-Dvtu6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:51 INFO - Running setup.py (path:/tmp/pip-IEvXqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:51 INFO - Running setup.py (path:/tmp/pip-ko2jpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:51 INFO - Running setup.py (path:/tmp/pip-NEl4WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:51 INFO - Running setup.py (path:/tmp/pip-gQ3ARz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:51 INFO - Running setup.py (path:/tmp/pip-BrmdP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:51 INFO - Running setup.py (path:/tmp/pip-NjhipS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:51 INFO - Running setup.py (path:/tmp/pip-hywCBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:51 INFO - Running setup.py (path:/tmp/pip-yGqWW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:51 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)) 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:51 INFO - Running setup.py (path:/tmp/pip-xCdguS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:52 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)) 09:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:52 INFO - Running setup.py (path:/tmp/pip-iDbCma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:52 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)) 09:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:52 INFO - Running setup.py (path:/tmp/pip-zkIM9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:52 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 09:09:52 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 09:09:52 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 09:09:52 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 09:09:52 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 09:09:52 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 09:09:54 INFO - Downloading blessings-1.6.tar.gz 09:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:54 INFO - Installing collected packages: blessings 09:09:54 INFO - Running setup.py install for blessings 09:09:54 INFO - Successfully installed blessings 09:09:54 INFO - Cleaning up... 09:09:54 INFO - Return code: 0 09:09:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:54 INFO - Reading from file tmpfile_stdout 09:09:54 INFO - Current package versions: 09:09:54 INFO - argparse == 1.2.1 09:09:54 INFO - blessings == 1.6 09:09:54 INFO - blobuploader == 1.2.4 09:09:54 INFO - docopt == 0.6.1 09:09:54 INFO - functools32 == 3.2.3-2 09:09:54 INFO - jsonschema == 2.5.1 09:09:54 INFO - manifestparser == 1.1 09:09:54 INFO - mozInstall == 1.12 09:09:54 INFO - mozcrash == 1.0 09:09:54 INFO - mozdebug == 0.1 09:09:54 INFO - mozdevice == 0.49 09:09:54 INFO - mozfile == 1.2 09:09:54 INFO - mozhttpd == 0.7 09:09:54 INFO - mozinfo == 0.9 09:09:54 INFO - mozleak == 0.1 09:09:54 INFO - mozlog == 3.4 09:09:54 INFO - moznetwork == 0.27 09:09:54 INFO - mozprocess == 0.25 09:09:54 INFO - mozprofile == 0.28 09:09:54 INFO - mozrunner == 6.13 09:09:54 INFO - mozscreenshot == 0.1 09:09:54 INFO - mozsystemmonitor == 0.3 09:09:54 INFO - moztest == 0.8 09:09:54 INFO - mozversion == 1.4 09:09:54 INFO - psutil == 3.1.1 09:09:54 INFO - requests == 1.2.3 09:09:54 INFO - wsgiref == 0.1.2 09:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:54 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 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09:54 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 09:09:54 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 09:09:54 INFO - Using env: {'DISPLAY': ':0', 09:09:54 INFO - 'HOME': '/home/cltbld', 09:09:54 INFO - 'LANG': 'en_US.UTF-8', 09:09:54 INFO - 'LANGUAGE': 'en_US:en', 09:09:54 INFO - 'LOGNAME': 'cltbld', 09:09:54 INFO - 'MAIL': '/var/mail/cltbld', 09:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:54 INFO - 'MOZ_NO_REMOTE': '1', 09:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:54 INFO - 'NO_EM_RESTART': '1', 09:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:54 INFO - 'PWD': '/builds/slave/test', 09:09:54 INFO - 'SHELL': '/bin/bash', 09:09:54 INFO - 'SHLVL': '1', 09:09:54 INFO - 'TERM': 'linux', 09:09:54 INFO - 'TMOUT': '86400', 09:09:54 INFO - 'USER': 'cltbld', 09:09:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:54 INFO - '_': '/tools/buildbot/bin/python'} 09:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 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)) 09:09:54 INFO - Cleaning up... 09:09:54 INFO - Return code: 0 09:09:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:54 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 0xe3d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, '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': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', '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 09:09:54 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 09:09:54 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 09:09:54 INFO - Using env: {'DISPLAY': ':0', 09:09:54 INFO - 'HOME': '/home/cltbld', 09:09:54 INFO - 'LANG': 'en_US.UTF-8', 09:09:54 INFO - 'LANGUAGE': 'en_US:en', 09:09:54 INFO - 'LOGNAME': 'cltbld', 09:09:54 INFO - 'MAIL': '/var/mail/cltbld', 09:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:54 INFO - 'MOZ_NO_REMOTE': '1', 09:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:54 INFO - 'NO_EM_RESTART': '1', 09:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:54 INFO - 'PWD': '/builds/slave/test', 09:09:54 INFO - 'SHELL': '/bin/bash', 09:09:54 INFO - 'SHLVL': '1', 09:09:54 INFO - 'TERM': 'linux', 09:09:54 INFO - 'TMOUT': '86400', 09:09:54 INFO - 'USER': 'cltbld', 09:09:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:54 INFO - '_': '/tools/buildbot/bin/python'} 09:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:09:55 INFO - Cleaning up... 09:09:55 INFO - Return code: 0 09:09:55 INFO - Running post-action listener: _resource_record_post_action 09:09:55 INFO - Running post-action listener: _start_resource_monitoring 09:09:55 INFO - Starting resource monitoring. 09:09:55 INFO - [mozharness: 2017-04-03 16:09:55.134630Z] Finished create-virtualenv step (success) 09:09:55 INFO - [mozharness: 2017-04-03 16:09:55.135200Z] Running install step. 09:09:55 INFO - Running pre-action listener: _resource_record_pre_action 09:09:55 INFO - Running main action method: install 09:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:55 INFO - Reading from file tmpfile_stdout 09:09:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:55 INFO - Reading from file tmpfile_stdout 09:09:55 INFO - Output received: 09:09:55 INFO - Usage: mozinstall [options] installer 09:09:55 INFO - Options: 09:09:55 INFO - -h, --help show this help message and exit 09:09:55 INFO - -d DEST, --destination=DEST 09:09:55 INFO - Directory to install application into. [default: 09:09:55 INFO - "/builds/slave/test"] 09:09:55 INFO - --app=APP Application being installed. [default: firefox] 09:09:55 INFO - mkdir: /builds/slave/test/build/application 09:09:55 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'] 09:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:10:12 INFO - Reading from file tmpfile_stdout 09:10:12 INFO - Output received: 09:10:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:10:12 INFO - Running post-action listener: _resource_record_post_action 09:10:12 INFO - [mozharness: 2017-04-03 16:10:12.335754Z] Finished install step (success) 09:10:12 INFO - [mozharness: 2017-04-03 16:10:12.336028Z] Running run-tests step. 09:10:12 INFO - Running pre-action listener: _resource_record_pre_action 09:10:12 INFO - Running main action method: run_tests 09:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:12 INFO - Python 2.7.3 09:10:12 INFO - Return code: 0 09:10:12 INFO - grabbing minidump binary from tooltool 09:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:12 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 0x10d8400>, '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 0x10d93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:12 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 09:10:12 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 09:10:12 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 09:10:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:12 INFO - Return code: 0 09:10:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:10:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:12 INFO - ENV: RUST_BACKTRACE is now 1 09:10:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:10:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 09:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 09:10:12 INFO - Using env: {'DISPLAY': ':0', 09:10:12 INFO - 'HOME': '/home/cltbld', 09:10:12 INFO - 'LANG': 'en_US.UTF-8', 09:10:12 INFO - 'LANGUAGE': 'en_US:en', 09:10:12 INFO - 'LOGNAME': 'cltbld', 09:10:12 INFO - 'MAIL': '/var/mail/cltbld', 09:10:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:12 INFO - 'MOZ_NO_REMOTE': '1', 09:10:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:12 INFO - 'NO_EM_RESTART': '1', 09:10:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:12 INFO - 'PWD': '/builds/slave/test', 09:10:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:12 INFO - 'RUST_BACKTRACE': '1', 09:10:12 INFO - 'SHELL': '/bin/bash', 09:10:12 INFO - 'SHLVL': '1', 09:10:12 INFO - 'TERM': 'linux', 09:10:12 INFO - 'TMOUT': '86400', 09:10:12 INFO - 'USER': 'cltbld', 09:10:12 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675', 09:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:12 INFO - '_': '/tools/buildbot/bin/python'} 09:10:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 09:10:12 INFO - mozversion application_buildid: 20170403150728 09:10:12 INFO - mozversion application_changeset: 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b 09:10:12 INFO - mozversion application_display_name: Nightly 09:10:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:12 INFO - mozversion application_name: Firefox 09:10:12 INFO - mozversion application_remotingname: firefox 09:10:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:10:12 INFO - mozversion application_vendor: Mozilla 09:10:12 INFO - mozversion application_version: 55.0a1 09:10:12 INFO - mozversion platform_buildid: 20170403150728 09:10:12 INFO - mozversion platform_changeset: 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b 09:10:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:10:12 INFO - mozversion platform_version: 55.0a1 09:10:12 INFO - using testdate: 1491235812 09:10:12 INFO - actual date: 1491235812 09:10:12 INFO - starting webserver on 'localhost:40886' 09:10:12 INFO - SUITE-START | Running 2 tests 09:10:12 INFO - TEST-START | dromaeo_css 09:10:12 INFO - operating with platform_type : linux_ 09:10:12 INFO - Initialising browser for dromaeo_css test... 09:10:12 INFO - TEST-INFO | started process 31146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPlSbzR/profile http://localhost:40886/getInfo.html) 09:10:16 INFO - PID 31146 | __metrics Screen width/height:1600/1200 09:10:16 INFO - PID 31146 | colorDepth:24 09:10:16 INFO - PID 31146 | Browser inner width/height: 1024/697 09:10:16 INFO - PID 31146 | __metrics 09:10:17 INFO - PID 31146 | 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" 09:10:17 INFO - PID 31146 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:18 INFO - TEST-INFO | 31146: exit 0 09:10:18 INFO - Browser initialized. 09:10:18 INFO - Running cycle 1/1 for dromaeo_css test... 09:10:18 INFO - TEST-INFO | started process 31234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPlSbzR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:30 INFO - PID 31234 | RSS: Main: 144560128 09:10:30 INFO - PID 31234 | 09:13:33 INFO - PID 31234 | Cycle 1(1): loaded http://localhost:40886/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40886/tests/dromaeo/cssquery-ext.html) 09:13:35 INFO - PID 31234 | RSS: Main: 267296768 09:13:35 INFO - PID 31234 | 09:15:20 INFO - PID 31234 | ************************* 09:15:20 INFO - PID 31234 | A coding exception was thrown and uncaught in a Task. 09:15:20 INFO - PID 31234 | 09:15:20 ERROR - PID 31234 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:15:20 INFO - PID 31234 | Full stack: 09:15:20 INFO - PID 31234 | ************************* 09:15:20 INFO - PID 31234 | ************************* 09:15:20 INFO - PID 31234 | A coding exception was thrown and uncaught in a Task. 09:15:20 INFO - PID 31234 | 09:15:20 ERROR - PID 31234 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:15:20 INFO - PID 31234 | Full stack: 09:15:20 INFO - PID 31234 | ************************* 09:15:20 INFO - PID 31234 | ************************* 09:15:20 INFO - PID 31234 | A coding exception was thrown and uncaught in a Task. 09:15:20 INFO - PID 31234 | 09:15:20 ERROR - PID 31234 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:15:20 INFO - PID 31234 | Full stack: 09:15:20 INFO - PID 31234 | ************************* 09:15:20 INFO - PID 31234 | ************************* 09:15:20 INFO - PID 31234 | A coding exception was thrown and uncaught in a Task. 09:15:20 INFO - PID 31234 | 09:15:20 ERROR - PID 31234 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:15:20 INFO - PID 31234 | Full stack: 09:15:20 INFO - PID 31234 | ************************* 09:16:37 INFO - PID 31234 | Cycle 1(1): loaded http://localhost:40886/tests/dromaeo/cssquery-ext.html (next: http://localhost:40886/tests/dromaeo/cssquery-jquery.html) 09:16:38 INFO - PID 31234 | RSS: Main: 237330432 09:16:38 INFO - PID 31234 | 09:19:40 INFO - PID 31234 | Cycle 1(1): loaded http://localhost:40886/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40886/tests/dromaeo/cssquery-mootools.html) 09:19:40 INFO - PID 31234 | RSS: Main: 181223424 09:19:40 INFO - PID 31234 | 09:22:42 INFO - PID 31234 | Cycle 1(1): loaded http://localhost:40886/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40886/tests/dromaeo/cssquery-prototype.html) 09:22:43 INFO - PID 31234 | RSS: Main: 179052544 09:22:43 INFO - PID 31234 | 09:25:45 INFO - PID 31234 | Cycle 1(1): loaded http://localhost:40886/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40886/tests/dromaeo/cssquery-yui.html) 09:25:46 INFO - PID 31234 | RSS: Main: 184623104 09:25:46 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | Cycle 1(1): loaded http://localhost:40886/tests/dromaeo/cssquery-yui.html (next: http://localhost:40886/tests/dromaeo/cssquery-dojo.html) 09:28:49 INFO - PID 31234 | RSS: Main: 279678976 09:28:49 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | __start_tp_report 09:28:49 INFO - PID 31234 | _x_x_mozilla_page_load 09:28:49 INFO - PID 31234 | _x_x_mozilla_page_load_details 09:28:49 INFO - PID 31234 | |i|pagename|runs| 09:28:49 INFO - PID 31234 | |0;dojo.html;3178.3325501644654;3279.622843373011;3312.1719570107475;3330.550375699281;3334.233126380933;5895;5895.705214739257;5901.734421951011;5928.644281343117;5929.792457263997;5928.466438020578;5950.761969521214;6014.669193194372;6064.666443345614;6075.392460753934;5146.253793199984;5242.239875218091;5264.815731449409;5322.8137015204475;5408.810691625794;5307.177387504943;5327.840164795062;5380.381256155553;5385.569154467653;5389;5159.406668233145;5238.083335416306;5239.13554263546;5250.947490525123;5254.31693879797;5268.367795864521;5287.762050707727;5292.497212764782;5294.444083371268;5303.628745987782;5205.583553315763;5249.737513124329;5259.526642602146;5261.394939581959;5266.683998960075;5905;5912.4974377178;5913.586048976574;5916.378780228057;5921.378255283219;6312.936870631281;6316.810495685137;6318.4629306509005;6321.4942804575985;6326.177596912418;6323.494120470351;6367.777127800505;6380.042993551005;6380.170577824853;6388.904166437507;5922.911156332659;5931.139984702238;5953.642781433041;5958.702064896781;5964.314103878066;6463.06285588587;6515.185601799775;6526.28210896801;6536.0522724205675;6542.051402546604;6140.385961403913;6157.692115394302;6163.414475624809;6324.3043265240785;6325.462335701517;6259.18630578031;6280.528960327993;6296.307406185316;6299;6300.842478938063;6312.305646378894;6321.65230912295;6323.747050118036;6333.683315834282;6375.075614035939;6356.237251529846;6367.331430199855;6368.840778980562;6371.904421433682;6388.297287298394;4749.4775574686755;4777.474477807438;4825.396825396825;4827.662063655511;4838.346823178897;4252.532221455637;4283.550227226158;4312.159128969821;4319.049809042006;4320.287152619782;6006;6007.12896629995;6010.308814486302;6015.85698717251;6016;6164.6917654117115;6414.839629009312;6474.902876456857;6475.449586785082;6476.481881449473;5978.04351303798;5981.910271345933;5981.940180598225;5986.431289027535;5987.760489580455;5395.271638328853;5402.35171779389;5403.7838486460105;5404.351477822608;5473.06957817172;6655.600663960178;6662.267150613526;6677.031830384567;6681.5656982296;6685.799426017227;6392.744290228525;6450.451711604566;6450.677466126581;6454.19322584677;6466.7736629219635;6406.90389644165;6495.967520162369;6515.804525864231;6678.131842860397;6684.63234522106;6176.474999625082;6189.288231853395;6192.628442293477;6196.380361963767;6209.720562574605;6264.436200741773;6292.874142517216;6319.494440444845;6322.968385158045;6326.841828954129;6137.40427488865;6144.2319710036245;6149.108379285068;6176;6196.318404975359;6103.328633850184;6168.537359698131;6173.629582224901;6263.749450021948;6264.185655864891;6112.625067133501;6146.907796382969;6149.754009839557;6247.375262473716;6253.405926436982;6234.2830574484515;6278.340774218641;6308.495320374267;6322.525810564134;6331.588446750947;6134.631922084689;6140.692965351804;6145.10895920098;6149.200603921461;6150.077488376779 09:28:49 INFO - PID 31234 | |1;ext.html;714.6748229555553;771.8996530451041;789.7907054630521;1075.3977772447436;1091.3124731419205;31139.221519462026;39720.81535515549;40827.38758918618;40862.38706419399;40869.795651021705;41987;42172.156556868846;42356;42399.57600423995;42414.15171696564;5933.376995415462;6050.6369617823075;7859.921400786005;8028.518288902685;8032.759017229463;8033;8244.793880153014;8256.669733210665;8281.29608983237;8287.58562071897;8295;8436.114208008163;8438.493690378566;8442.788930276762;8460.57697115145;8346.791330216733;8372.288355489729;8400.537970411626;8412.873806892901;8420.789480263013;8146.592670366458;8212.712555060603;8214.178582141738;8214.753557393287;8216.917830821734;41182;41405.37891931624;41418.79290603558;41441.58558414407;41489.1702165958;2904.997775767357;2928.4143171365813;2937.2069541223964;2940.0885725425187;2994.625671791026;28669.42661146786;28677.713222867922;28910.277243069093;29000.70999290001;29092.563611545633;3596.6403359664087;3611.487857758064;3648.452732090181;3654.196076863086;3700.962990370089;189443;189573;190199;190404;190549;48412.27381589279;48524;48535.51464485381;48603.513964860605;48640.75679621579;50627;50636.240456393185;50700.74649626728;50719.49280507147;50749.49250507521;15324.080555166725;15572.532824015298;15600.29798659063;15621.60945976337;15644.374225031099;10245;10276.280660353854;11980.76038479243;12494.250344979331;12507.56223532172;14794.260286985824;14871.776923346159;14896.404143834343;14909.552713418614;15018.69962600742;5574.063622242299;5784.479396854304;5874.618149820248;5883.764649413975;5891.793787217427;1038.1798379280435;1038.3302769713493;1042.4214560918763;1063.9148868090533;1075.4730182210817;25617.231483055537;26178.73821261763;26237.868810655826;26269.21192364232;26273.73726262751;1133.4276190523733;1142.7600203957263;1143.279733767721;1149.2816989381636;1153.2849633227286;13135.934320328337;13471.461141554228;13528.797068043987;13599;13695.520656776966;321920;323553;324284;324574;324817;55570.44429555733;55890.72054639701;55978.72010639921;56052.15921761177;56059.43940560624;1426.6362077670128;1472.8821694264648;1504.353128154904;1513.6669932614807;1517.2792923361314;24035.75964240335;30413.391732165674;30444.84777576098;30701;31130.221744455663;55389;56148;56153.71923140358;56267;56507.15239271496;320511;322395;322512;322941;323662;28671.13986580406;28979.275518112216;34474.31051378908;34790.47814282838;35863.82068089643;44832;45284.773576131905;45441.31838022366;45553.54446455493;45818.770906145255;31660;32412.83793581017;32939.67060329366;33497.33005339928;33935.83032084923;33103;33159.668403315656;33355.33289334151;33710.325793483506;33753.32493350168;39013;39685.404718928665;39995;40467.79766101151;40509.59490405058;31438;31847.36305273835;32090.35819283648;32304.515432268065;33249.833750831094;24910.87544562338;26352;26408.603870941566;26446.338841529116;26786.732132679204 09:28:49 INFO - PID 31234 | |2;jquery.html;409.9241640296547;419.10789890091087;429.7636300034981;438.1849759447429;438.24184161400774;20254.189832406686;21162.57674846502;21846.781532184672;22066;22123.557528849415;21445.785542144575;22533;22612.43468913278;22826.65760013601;23072;5739.311282646078;5987.880242395149;5997.280326360821;5998.220231369915;6000.579959402844;5613.747381367828;5799.623024503415;5811.157382179582;5838.795642152526;5845.707714614252;5800.738966746486;5811.825645230629;5818.738156782955;5821.243238379005;5821.446962538552;5782;5922.970385148068;5970.283565972068;5974.253218347728;5975.731092100866;5242.6330156889035;5243.86890327741;5339;5342.973285133588;5343.893122137535;26174.8590169179;26284.86857565719;26701.599476007876;27059.864700676568;27495.587566186525;1987.6720341143694;2043.3257025181654;2065.4423305707373;2079.8856062916534;2088.9477763056043;15451.922740386226;16589.336426542923;16617.667646646998;16966.915165424092;17142.40001599938;2073.3261689950677;2073.5645514441985;2076.646970015101;2116.174691870172;2116.5978464091927;111019.44490277497;111051;111658;114968;115118.99999999916;11728.76542469163;12084.879151208552;12121.45453454579;12195.14633975631;12360.196587221802;17017.91491042537;17023;17056.744148837777;17065;17076;7873.960630196812;8131.674733010732;8212.917870821335;8273.875891861628;8332.6666933322;7388.630568471555;7447.292507211806;7663.348615367645;7676;7715.267049630276;7719.845603088019;7732.974910394198;7860.3318717909615;7890.723824666109;7956.2441568050945;1910.1977169588806;1930.5559721264187;1941.951451213731;1982.8017198280056;2193.473566344098;1001.8747656542932;1006.7281833904805;1012.9037741414554;1028.747956750601;1031.9690409287734;20485.38543843687;20962.685559716618;20994.160233590792;21004.159833606485;21139.154433822474;1022.7238645565805;1030.8041472120424;1036.491904279287;1051.8527406163143;1062.946852657364;10560.505289247212;11414;11453.312801231952;11472;11475.54097836094;568196;571989;573685;599677;600769;109201.45399272953;111999;112494.43752781184;116247;118353.40823295829;1137.2891942535914;1152.915843902539;1191.6544202181444;1199.6401079676061;1202.22456515547;20551.020102085415;20776.584468310248;21137.788622114196;21452.678209826554;21521.569568608855;48980;49365.75317123391;51138;51271.48728512816;52193.21710174427;66691.66654166892;66986;67459.27785054999;67576.32423675897;68327.3167268321;8991.14584114508;9036.45781253127;9298.767530811783;9425.717228483156;9648.517574121126;14408;14675.779863301845;15019.624509387353;15392.230388480308;16142.757858632365;13369;13395.12931659439;13664.180149190683;13930.860691393362;14080.718385632024;11952.880471195525;12100.818487722867;12124.393780311126;12158.331291778682;12519.186252893533;12717.491300347883;13476.865231347561;13665.931670341584;13749.175049497062;13844.861551384358;9481.66814161501;9485.193758530326;9507.191888689538;9695.418274903528;9822.508874556386;12737.745245095231;13105.606831795061;13134.73730525365;13235.139715918434;13687.726245475234 09:28:49 INFO - PID 31234 | |3;mootools.html;1215.7629262293856;1327.8738519840615;1374.7800351943686;1411.513028005338;1413.477013505003;8959.641614335427;10877.619283325084;11246.55013799449;11258.943705281463;11277.154213434005;10990.065844403216;11077.723056923582;11079.667609971693;11109.277896936694;11118.888811111887;1980.43557586088;2042.3158241988951;2308.734495533014;2345.5660702769956;2350.6826578411865;2250.6736523204127;2329.173143534038;2337.3689103941924;2337.5091230841545;2337.824663150262;2247.8426510144295;2259.288324177887;2281;2284.668723035159;2290.1869836208157;2216.7007453993665;2227.298401003695;2233.4974630708043;2244.3827947314458;2244.6969659095976;2133.5412886229537;2171.7285339332584;2172.1094351315883;2193.868367897915;2199.483121466454;11008.504617292241;11020.50407731654;11121.22151449399;11129.054030407426;11138.665840024812;5791;5914.970425147847;5976;5982.910256346115;5987.191729116557;3418.572678415198;3461.1174150591437;3738.2897249522775;3758.6241375862196;3760.417135344026;1293.72831705342;1315.7302752935625;1321.511040914858;1353.7495563320817;1873.7564116664882;16427.671446571003;16638.667226655398;16642.084685342303;16668.083255420825;16669.33322667092;4957.231629097496;5071.949280507148;5072.416672082684;5199.272101905736;5216.478352164753;12116.81824772629;12282.14025018258;12284.201526900722;12289.508419663292;12309.692257693629;5945.64326140433;5960.850978725566;5962.40375962409;5965.671888046112;5973.342932277446;5399.217113518518;5476.726163691799;5575;5625.521830644359;5626.887462250732;3783.2622638585212;3880.4373365861793;3901.4147877818555;3912.217556488714;3956.208758248362;1094.6223552874405;1095.7151140703475;1100.2463312630873;1104.7127746785893;1113.1762495753085;784.1883650421786;805.4965646470955;807.7294106474396;814.1573471457132;815.5473712089729;5812.331581868055;5876.44173803488;5904.261967254093;5933.169356290123;6112.541559383064;564.4609398024876;572.3532408378505;575.7466714645626;584.885947240284;597.5996082624652;4222.218889505451;4320.870373888788;4369.497507786582;4386.912261754747;4413.58070983256;14029.85970140306;14096.154230746188;14534.636634084232;14585.343659535347;14671.55985320442;13954.302284885714;14132.222727750073;14215.64460888486;14234.2171180584;14243.074200176956;9867.210623149987;9896.406215627085;10055.899441005642;10080.09279164864;10095.990400959845;6519.576227545194;6534.509911756542;6619.3380661933425;6691.263960964193;6915.101036865175;12412.193207441487;12592.74814503723;12603.432845522157;12737;13077.803832942323;10944.726381840199;13376.866231337952;13486.393112309774;13606.93196534011;13756.312184390941;9093.40892841963;9169.954150229207;9181.081891810765;9274.026227246042;9321.254299656146;10002.499875006366;10098.798024039625;10324.380537167493;10327.690169294932;10330.793384132425;8452.492850428995;8561.871571926551;8616.526091064801;8616.913830861862;8800.251978581893;8368.707095251637;8374.83250335002;8420.5789710513;8567.443116197428;8734.519601421729;7690.154083050748;7797.688092476237;7798.883016754867;7811.726589569338;7813.726519571787;5802.912956305574;5881.441263080001;5933.199018132669;5955.285365756137;6114.57197996136;5927.229460170151;5989.700514974146;6025.427584379477;6206.503479721521;6273.1844860167885 09:28:49 INFO - PID 31234 | |4;prototype.html;405.52940828227213;410.36188726530236;413.904801895564;416.8895242760667;418.2909967604911;5848.1812546243455;5849.327327357355;5857.121431785235;5862.618929769567;5890.823275301737;5534.972325138368;5574.693391863446;5766.654000759957;5784.421557844224;5827.41725827417;4547.272436410175;4561.361409402686;4565.338025986238;4568.885777855547;4581.312803079548;4567.451905771312;4570.885727856797;4577.519360467153;4581.587657110859;4590.954090459103;4209.663226941852;4358.673099517533;4369.453818272716;4370.038591509863;4395.120975804836;4333.783310834478;4352.216601011816;4360.7819609019425;4363.410939523155;4363.585459381369;3872.4965754452023;3874.535055793323;3886.805659717031;3889.183271512986;3895.7272990890647;5466.961277357329;5584.162375643646;5606.103023516218;5622.409646987048;5646.40712725162;5141.434442211354;5144.6913185209005;5145.6398052136365;5147.992283009629;5148.742562871879;5971.223740913697;5984.431479009487;6055.212822333113;6084.60450070744;6086.786962456337;4285.678574106954;4320.697551171419;4328.091100868822;4342.34864770287;4355;6083.6349819011;6256.371304643341;6272.65500397478;6381.553291269613;6393.93606063938;4334.349847522833;4394.12117576486;4444.31113177458;4445.355423463579;4445.59989600931;4481.641468682497;4496.595306422372;4502.077074199781;4504.729716217037;4514.322851572225;4966.304717339575;5101.132807422747;5122.769475373617;5145.716985565755;5146.974265128651;6082.9695851520455;6090.421409966135;6104.725287362079;6104.969475152596;6109.572329936862;1505.8795296376263;1521.9010764300285;1525.3898440623839;1527.7402841516746;1530.7627317765764;979.1921664626569;1006.9748256293504;1028.92797504174;1034.877158283271;1041.3595638682307;5811.506021988093;5826.252124362674;5840.517779943507;5848.210491583667;5867.970660146757;6266.530010249249;6278.717457714322;6296.874062518724;6317.273513546001;6331.3352098029045;5642.6614403135945;5793.391693872167;5800.651960882276;5873.530117590582;5916.467517923407;3325.553384277847;3350.9832450838076;3358.328334333143;3366.3267346530793;3380.138064793462;6323.652199129;6495.1556297681;6505.121808555879;6575.506836987245;6586.407223349922;6456.12842266288;6459.61242325462;6488;6504.804855854332;6554.868902621921;6422.389872962061;6522.902156467751;6576.76981305652;6596.80209593713;6600.537962342686;6280.371962803683;6297.590656607306;6301.96849015752;6331.810045698637;6335.239771227482;6234;6253.0620406937505;6271.310155882758;6287.937120628918;6302.432781049728;6083.513318934563;6109.938900610937;6415.1981002374705;6485.319041500763;6504.447121994684;4348.0869017506675;4367.58507941745;4375.47494300686;4381.649468042485;4388.802503887269;6225.273272434362;6288.213973253343;6307.810765677037;6327.133495618896;6335.271443784024;6055.515558755201;6066.787662431793;6111.388861113853;6117.785877494266;6147.877042459037;6037.366076561898;6116.235470566179;6118.418750218722;6124.724387402489;6155.47678447337;5895.9115613266695;6102.877942441215;6111.786087486917;6132;6134.78528251509;6168.938310616836;6195.986304450981;6198.194234749454;6203.2556093269095;6214.533909956681;5894.115882617471;5931.881362372815;5974.581779275582;6030.30651475086;6063.787767428119 09:28:49 INFO - PID 31234 | |5;yui.html;765.8698021336372;767.7850201943456;769.6844293839526;770.5299767142044;778.3500776851329;15281.083135011879;15293.770593441093;15355.385784568633;15420.61448463789;15428.305726242317;14972.475963341285;15109.92445037776;15131.243437828092;15131.31909064092;15186.924065379657;918.5407296351824;920.3327587499076;931.7204838548442;933.1974501928336;937.3298091864316;941.8775559177332;952.2477242978039;953.4327075390166;953.7377221264138;954.8472244440891;992.9056739609725;993.5826952679855;993.746594618375;993.8360170571847;994.7811481474064;976.8632391465201;985.2069084387066;985.6550207427415;985.9063388978036;986.6250824686609;722.1190148019408;722.5484072454716;723.2261480216171;723.2550473012806;723.8262816923954;15229.314680839389;15407.152606606633;15461.613459663598;15998.44005459815;16203.270852811651;15250.618734531614;15812.920935395365;15863.20683965797;16105.355785768556;16774;12197.756044879052;12297.508099676003;12380.566680166152;12746.80879786804;13399.263040532767;3174.3809957058384;3250.089974807058;3297.55483009793;3369.511420843964;3372.089535825338;90801.54599227027;92633.37848848567;93257.533712331;94606.05393946041;96777;12413.301097855927;12445.439955201857;12579.559715409916;12773.744525109445;13193.60419187426;24544.877275613508;25425.745742542338;25524.361890952874;26217.868910655325;26283.60574591383;7952.3638108951145;8128.187181281943;8146.75559733209;8171.305439037629;8307.08622051574;4143.81352839123;4238.682098842537;4239.51245606753;4246.936295955563;4248.065425606362;4189.455370801777;4257.936130958038;4266.06146647737;4278.978605107017;4282.571742825755;699.1226011355716;716.5414134953634;724.7535837815062;727.7125535413588;733.0726630812027;570.1504757910683;573.9339975902741;586.9090291004901;595.3778301674761;599.9520038397005;9011.188992990663;9734.464604446823;9789.21686265097;9877.357971731815;10436.269461137648;568.3549171690079;578.2812252023468;602.6655206360512;604.0938592111833;611.1016805296207;4521.140983213245;4737.905241895142;4745.240761478216;4745.762711864393;4756.357891684647;79977;80599.59700201462;81108.59445702734;81432.18567814365;81878.49004914242;71415.2858471419;71714.2828571718;72407;73135;74728.62635686896;65772;66134.166235626;66170;68538.65730671414;68594;9351.53242337894;9590.616375344907;9689.321747477608;9737.221022318055;9778.462184579916;35163.47254791129;35375.64624353724;35600.64399355973;35858;36664.63335366612;42649;43166.56833431625;43725.72057095794;43962.56037439585;44581.33128003018;12133;12164.08769342285;12202.633920982385;12311.384430778604;12500.499980000699;12710.428030738454;12722.499838723386;12806.935965320114;13090.869091308965;13359.933200333937;11972.221805582609;12163.635090947286;12347.75304493923;12962.935185324013;13029;12488.625341239778;12656.746865062463;12735.617931462071;12982;13305.46778128864;11848.28910265387;12057.698557536132;12191.634250972485;12308.938455307667;12848.743025139258;10223.341931097819;10524.842127368249;10590.364578125336;10731.195160362848;11097.278676885977;10674.62638807638;11357.886421135683;11435.885641143483;11564.94217528907;11942.223755455867 09:28:49 INFO - PID 31234 | __end_tp_report 09:28:49 INFO - PID 31234 | __start_cc_report 09:28:49 INFO - PID 31234 | _x_x_mozilla_cycle_collect,1263 09:28:49 INFO - PID 31234 | __end_cc_report 09:28:49 INFO - PID 31234 | __startTimestamp1491236929608__endTimestamp 09:28:49 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | ------- Summary: start ------- 09:28:49 INFO - PID 31234 | Number of tests: 6 09:28:49 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | [#0] dojo.html Cycles:165 Average:5877.00 Median:6145.11 stddev:710.46 (11.6%) stddev-sans-first:680.37 09:28:49 INFO - PID 31234 | Values: 3178.3 3279.6 3312.2 3330.6 3334.2 5895.0 5895.7 5901.7 5928.6 5929.8 5928.5 5950.8 6014.7 6064.7 6075.4 5146.3 5242.2 5264.8 5322.8 5408.8 5307.2 5327.8 5380.4 5385.6 5389.0 5159.4 5238.1 5239.1 5250.9 5254.3 5268.4 5287.8 5292.5 5294.4 5303.6 5205.6 5249.7 5259.5 5261.4 5266.7 5905.0 5912.5 5913.6 5916.4 5921.4 6312.9 6316.8 6318.5 6321.5 6326.2 6323.5 6367.8 6380.0 6380.2 6388.9 5922.9 5931.1 5953.6 5958.7 5964.3 6463.1 6515.2 6526.3 6536.1 6542.1 6140.4 6157.7 6163.4 6324.3 6325.5 6259.2 6280.5 6296.3 6299.0 6300.8 6312.3 6321.7 6323.7 6333.7 6375.1 6356.2 6367.3 6368.8 6371.9 6388.3 4749.5 4777.5 4825.4 4827.7 4838.3 4252.5 4283.6 4312.2 4319.0 4320.3 6006.0 6007.1 6010.3 6015.9 6016.0 6164.7 6414.8 6474.9 6475.4 6476.5 5978.0 5981.9 5981.9 5986.4 5987.8 5395.3 5402.4 5403.8 5404.4 5473.1 6655.6 6662.3 6677.0 6681.6 6685.8 6392.7 6450.5 6450.7 6454.2 6466.8 6406.9 6496.0 6515.8 6678.1 6684.6 6176.5 6189.3 6192.6 6196.4 6209.7 6264.4 6292.9 6319.5 6323.0 6326.8 6137.4 6144.2 6149.1 6176.0 6196.3 6103.3 6168.5 6173.6 6263.7 6264.2 6112.6 6146.9 6149.8 6247.4 6253.4 6234.3 6278.3 6308.5 6322.5 6331.6 6134.6 6140.7 6145.1 6149.2 6150.1 09:28:49 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | [#1] ext.html Cycles:180 Average:44708.86 Median:33426.33 stddev:74999.45 (224.4%) stddev-sans-first:75137.10 09:28:49 INFO - PID 31234 | Values: 714.7 771.9 789.8 1075.4 1091.3 31139.2 39720.8 40827.4 40862.4 40869.8 41987.0 42172.2 42356.0 42399.6 42414.2 5933.4 6050.6 7859.9 8028.5 8032.8 8033.0 8244.8 8256.7 8281.3 8287.6 8295.0 8436.1 8438.5 8442.8 8460.6 8346.8 8372.3 8400.5 8412.9 8420.8 8146.6 8212.7 8214.2 8214.8 8216.9 41182.0 41405.4 41418.8 41441.6 41489.2 2905.0 2928.4 2937.2 2940.1 2994.6 28669.4 28677.7 28910.3 29000.7 29092.6 3596.6 3611.5 3648.5 3654.2 3701.0 189443.0 189573.0 190199.0 190404.0 190549.0 48412.3 48524.0 48535.5 48603.5 48640.8 50627.0 50636.2 50700.7 50719.5 50749.5 15324.1 15572.5 15600.3 15621.6 15644.4 10245.0 10276.3 11980.8 12494.3 12507.6 14794.3 14871.8 14896.4 14909.6 15018.7 5574.1 5784.5 5874.6 5883.8 5891.8 1038.2 1038.3 1042.4 1063.9 1075.5 25617.2 26178.7 26237.9 26269.2 26273.7 1133.4 1142.8 1143.3 1149.3 1153.3 13135.9 13471.5 13528.8 13599.0 13695.5 321920.0 323553.0 324284.0 324574.0 324817.0 55570.4 55890.7 55978.7 56052.2 56059.4 1426.6 1472.9 1504.4 1513.7 1517.3 24035.8 30413.4 30444.8 30701.0 31130.2 55389.0 56148.0 56153.7 56267.0 56507.2 320511.0 322395.0 322512.0 322941.0 323662.0 28671.1 28979.3 34474.3 34790.5 35863.8 44832.0 45284.8 45441.3 45553.5 45818.8 31660.0 32412.8 32939.7 33497.3 33935.8 33103.0 33159.7 33355.3 33710.3 33753.3 39013.0 39685.4 39995.0 40467.8 40509.6 31438.0 31847.4 32090.4 32304.5 33249.8 24910.9 26352.0 26408.6 26446.3 26786.7 09:28:49 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | [#2] jquery.html Cycles:180 Average:34602.01 Median:11627.66 stddev:96655.80 (831.3%) stddev-sans-first:96892.85 09:28:49 INFO - PID 31234 | Values: 409.9 419.1 429.8 438.2 438.2 20254.2 21162.6 21846.8 22066.0 22123.6 21445.8 22533.0 22612.4 22826.7 23072.0 5739.3 5987.9 5997.3 5998.2 6000.6 5613.7 5799.6 5811.2 5838.8 5845.7 5800.7 5811.8 5818.7 5821.2 5821.4 5782.0 5923.0 5970.3 5974.3 5975.7 5242.6 5243.9 5339.0 5343.0 5343.9 26174.9 26284.9 26701.6 27059.9 27495.6 1987.7 2043.3 2065.4 2079.9 2088.9 15451.9 16589.3 16617.7 16966.9 17142.4 2073.3 2073.6 2076.6 2116.2 2116.6 111019.4 111051.0 111658.0 114968.0 115119.0 11728.8 12084.9 12121.5 12195.1 12360.2 17017.9 17023.0 17056.7 17065.0 17076.0 7874.0 8131.7 8212.9 8273.9 8332.7 7388.6 7447.3 7663.3 7676.0 7715.3 7719.8 7733.0 7860.3 7890.7 7956.2 1910.2 1930.6 1942.0 1982.8 2193.5 1001.9 1006.7 1012.9 1028.7 1032.0 20485.4 20962.7 20994.2 21004.2 21139.2 1022.7 1030.8 1036.5 1051.9 1062.9 10560.5 11414.0 11453.3 11472.0 11475.5 568196.0 571989.0 573685.0 599677.0 600769.0 109201.5 111999.0 112494.4 116247.0 118353.4 1137.3 1152.9 1191.7 1199.6 1202.2 20551.0 20776.6 21137.8 21452.7 21521.6 48980.0 49365.8 51138.0 51271.5 52193.2 66691.7 66986.0 67459.3 67576.3 68327.3 8991.1 9036.5 9298.8 9425.7 9648.5 14408.0 14675.8 15019.6 15392.2 16142.8 13369.0 13395.1 13664.2 13930.9 14080.7 11952.9 12100.8 12124.4 12158.3 12519.2 12717.5 13476.9 13665.9 13749.2 13844.9 9481.7 9485.2 9507.2 9695.4 9822.5 12737.7 13105.6 13134.7 13235.1 13687.7 09:28:49 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | [#3] mootools.html Cycles:180 Average:6827.36 Median:2348.12 stddev:4429.39 (188.6%) stddev-sans-first:4421.75 09:28:49 INFO - PID 31234 | Values: 1215.8 1327.9 1374.8 1411.5 1413.5 8959.6 10877.6 11246.6 11258.9 11277.2 10990.1 11077.7 11079.7 11109.3 11118.9 1980.4 2042.3 2308.7 2345.6 2350.7 2250.7 2329.2 2337.4 2337.5 2337.8 2247.8 2259.3 2281.0 2284.7 2290.2 2216.7 2227.3 2233.5 2244.4 2244.7 2133.5 2171.7 2172.1 2193.9 2199.5 11008.5 11020.5 11121.2 11129.1 11138.7 5791.0 5915.0 5976.0 5982.9 5987.2 3418.6 3461.1 3738.3 3758.6 3760.4 1293.7 1315.7 1321.5 1353.7 1873.8 16427.7 16638.7 16642.1 16668.1 16669.3 4957.2 5071.9 5072.4 5199.3 5216.5 12116.8 12282.1 12284.2 12289.5 12309.7 5945.6 5960.9 5962.4 5965.7 5973.3 5399.2 5476.7 5575.0 5625.5 5626.9 3783.3 3880.4 3901.4 3912.2 3956.2 1094.6 1095.7 1100.2 1104.7 1113.2 784.2 805.5 807.7 814.2 815.5 5812.3 5876.4 5904.3 5933.2 6112.5 564.5 572.4 575.7 584.9 597.6 4222.2 4320.9 4369.5 4386.9 4413.6 14029.9 14096.2 14534.6 14585.3 14671.6 13954.3 14132.2 14215.6 14234.2 14243.1 9867.2 9896.4 10055.9 10080.1 10096.0 6519.6 6534.5 6619.3 6691.3 6915.1 12412.2 12592.7 12603.4 12737.0 13077.8 10944.7 13376.9 13486.4 13606.9 13756.3 9093.4 9170.0 9181.1 9274.0 9321.3 10002.5 10098.8 10324.4 10327.7 10330.8 8452.5 8561.9 8616.5 8616.9 8800.3 8368.7 8374.8 8420.6 8567.4 8734.5 7690.2 7797.7 7798.9 7811.7 7813.7 5802.9 5881.4 5933.2 5955.3 6114.6 5927.2 5989.7 6025.4 6206.5 6273.2 09:28:49 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | [#4] prototype.html Cycles:180 Average:5127.08 Median:5848.20 stddev:1525.24 (26.1%) stddev-sans-first:1487.78 09:28:49 INFO - PID 31234 | Values: 405.5 410.4 413.9 416.9 418.3 5848.2 5849.3 5857.1 5862.6 5890.8 5535.0 5574.7 5766.7 5784.4 5827.4 4547.3 4561.4 4565.3 4568.9 4581.3 4567.5 4570.9 4577.5 4581.6 4591.0 4209.7 4358.7 4369.5 4370.0 4395.1 4333.8 4352.2 4360.8 4363.4 4363.6 3872.5 3874.5 3886.8 3889.2 3895.7 5467.0 5584.2 5606.1 5622.4 5646.4 5141.4 5144.7 5145.6 5148.0 5148.7 5971.2 5984.4 6055.2 6084.6 6086.8 4285.7 4320.7 4328.1 4342.3 4355.0 6083.6 6256.4 6272.7 6381.6 6393.9 4334.3 4394.1 4444.3 4445.4 4445.6 4481.6 4496.6 4502.1 4504.7 4514.3 4966.3 5101.1 5122.8 5145.7 5147.0 6083.0 6090.4 6104.7 6105.0 6109.6 1505.9 1521.9 1525.4 1527.7 1530.8 979.2 1007.0 1028.9 1034.9 1041.4 5811.5 5826.3 5840.5 5848.2 5868.0 6266.5 6278.7 6296.9 6317.3 6331.3 5642.7 5793.4 5800.7 5873.5 5916.5 3325.6 3351.0 3358.3 3366.3 3380.1 6323.7 6495.2 6505.1 6575.5 6586.4 6456.1 6459.6 6488.0 6504.8 6554.9 6422.4 6522.9 6576.8 6596.8 6600.5 6280.4 6297.6 6302.0 6331.8 6335.2 6234.0 6253.1 6271.3 6287.9 6302.4 6083.5 6109.9 6415.2 6485.3 6504.4 4348.1 4367.6 4375.5 4381.6 4388.8 6225.3 6288.2 6307.8 6327.1 6335.3 6055.5 6066.8 6111.4 6117.8 6147.9 6037.4 6116.2 6118.4 6124.7 6155.5 5895.9 6102.9 6111.8 6132.0 6134.8 6168.9 6196.0 6198.2 6203.3 6214.5 5894.1 5931.9 5974.6 6030.3 6063.8 09:28:49 INFO - PID 31234 | 09:28:49 INFO - PID 31234 | [#5] yui.html Cycles:180 Average:17853.46 Median:4280.78 stddev:23704.53 (553.7%) stddev-sans-first:23736.30 09:28:49 INFO - PID 31234 | Values: 765.9 767.8 769.7 770.5 778.4 15281.1 15293.8 15355.4 15420.6 15428.3 14972.5 15109.9 15131.2 15131.3 15186.9 918.5 920.3 931.7 933.2 937.3 941.9 952.2 953.4 953.7 954.8 992.9 993.6 993.7 993.8 994.8 976.9 985.2 985.7 985.9 986.6 722.1 722.5 723.2 723.3 723.8 15229.3 15407.2 15461.6 15998.4 16203.3 15250.6 15812.9 15863.2 16105.4 16774.0 12197.8 12297.5 12380.6 12746.8 13399.3 3174.4 3250.1 3297.6 3369.5 3372.1 90801.5 92633.4 93257.5 94606.1 96777.0 12413.3 12445.4 12579.6 12773.7 13193.6 24544.9 25425.7 25524.4 26217.9 26283.6 7952.4 8128.2 8146.8 8171.3 8307.1 4143.8 4238.7 4239.5 4246.9 4248.1 4189.5 4257.9 4266.1 4279.0 4282.6 699.1 716.5 724.8 727.7 733.1 570.2 573.9 586.9 595.4 600.0 9011.2 9734.5 9789.2 9877.4 10436.3 568.4 578.3 602.7 604.1 611.1 4521.1 4737.9 4745.2 4745.8 4756.4 79977.0 80599.6 81108.6 81432.2 81878.5 71415.3 71714.3 72407.0 73135.0 74728.6 65772.0 66134.2 66170.0 68538.7 68594.0 9351.5 9590.6 9689.3 9737.2 9778.5 35163.5 35375.6 35600.6 35858.0 36664.6 42649.0 43166.6 43725.7 43962.6 44581.3 12133.0 12164.1 12202.6 12311.4 12500.5 12710.4 12722.5 12806.9 13090.9 13359.9 11972.2 12163.6 12347.8 12962.9 13029.0 12488.6 12656.7 12735.6 12982.0 13305.5 11848.3 12057.7 12191.6 12308.9 12848.7 10223.3 10524.8 10590.4 10731.2 11097.3 10674.6 11357.9 11435.9 11564.9 11942.2 09:28:49 INFO - PID 31234 | -------- Summary: end -------- 09:28:49 INFO - PID 31234 | 09:28:50 INFO - TEST-INFO | 31234: exit 0 09:28:50 INFO - TEST-OK | dromaeo_css | took 1117863ms 09:28:50 INFO - TEST-START | kraken 09:28:50 INFO - operating with platform_type : linux_ 09:28:50 INFO - Initialising browser for kraken test... 09:28:50 INFO - TEST-INFO | started process 31558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXrzML/profile http://localhost:40886/getInfo.html) 09:28:54 INFO - PID 31558 | __metrics Screen width/height:1600/1200 09:28:54 INFO - PID 31558 | colorDepth:24 09:28:54 INFO - PID 31558 | Browser inner width/height: 1024/697 09:28:54 INFO - PID 31558 | __metrics 09:28:55 INFO - PID 31558 | 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" 09:28:55 INFO - PID 31558 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:28:56 INFO - TEST-INFO | 31558: exit 0 09:28:56 INFO - Browser initialized. 09:28:56 INFO - Running cycle 1/1 for kraken test... 09:28:56 INFO - TEST-INFO | started process 31654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXrzML/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:08 INFO - PID 31654 | RSS: Main: 144670720 09:29:08 INFO - PID 31654 | 09:29:10 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40886/tests/kraken/driver.html?testName=audio-beat-detection) 09:29:11 INFO - PID 31654 | RSS: Main: 198909952 09:29:11 INFO - PID 31654 | 09:29:14 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40886/tests/kraken/driver.html?testName=audio-dft) 09:29:14 INFO - PID 31654 | RSS: Main: 178958336 09:29:14 INFO - PID 31654 | 09:29:17 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40886/tests/kraken/driver.html?testName=audio-fft) 09:29:18 INFO - PID 31654 | RSS: Main: 261156864 09:29:18 INFO - PID 31654 | 09:29:20 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40886/tests/kraken/driver.html?testName=audio-oscillator) 09:29:20 INFO - PID 31654 | RSS: Main: 172507136 09:29:20 INFO - PID 31654 | 09:29:23 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40886/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:23 INFO - PID 31654 | RSS: Main: 176885760 09:29:23 INFO - PID 31654 | 09:29:26 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40886/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:27 INFO - PID 31654 | RSS: Main: 214908928 09:29:27 INFO - PID 31654 | 09:29:30 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40886/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:31 INFO - PID 31654 | RSS: Main: 228999168 09:29:31 INFO - PID 31654 | 09:29:34 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40886/tests/kraken/driver.html?testName=json-parse-financial) 09:29:34 INFO - PID 31654 | RSS: Main: 240574464 09:29:34 INFO - PID 31654 | 09:29:36 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40886/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:29:36 INFO - PID 31654 | RSS: Main: 177053696 09:29:36 INFO - PID 31654 | 09:29:38 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40886/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:29:39 INFO - PID 31654 | RSS: Main: 184168448 09:29:39 INFO - PID 31654 | 09:29:41 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40886/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:29:41 INFO - PID 31654 | RSS: Main: 193626112 09:29:41 INFO - PID 31654 | 09:29:44 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:29:45 INFO - PID 31654 | RSS: Main: 202629120 09:29:45 INFO - PID 31654 | 09:29:48 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:29:48 INFO - PID 31654 | RSS: Main: 199233536 09:29:48 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | Cycle 1(1): loaded http://localhost:40886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40886/tests/kraken/driver.html?testName=ai-astar) 09:29:50 INFO - PID 31654 | RSS: Main: 267911168 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | __start_tp_report 09:29:50 INFO - PID 31654 | _x_x_mozilla_page_load 09:29:50 INFO - PID 31654 | _x_x_mozilla_page_load_details 09:29:50 INFO - PID 31654 | |i|pagename|runs| 09:29:50 INFO - PID 31654 | |0;ai-astar;103;111;111;110;111;110;109;109;110;109 09:29:50 INFO - PID 31654 | |1;audio-beat-detection;149;117;121;171;121;126;125;124;142;125 09:29:50 INFO - PID 31654 | |2;audio-dft;164;163;165;166;164;166;166;166;165;164 09:29:50 INFO - PID 31654 | |3;audio-fft;75;74;76;111;74;75;78;76;95;74 09:29:50 INFO - PID 31654 | |4;audio-oscillator;83;83;103;84;88;83;97;92;82;100 09:29:50 INFO - PID 31654 | |5;imaging-gaussian-blur;113;114;114;113;114;114;114;115;114;114 09:29:50 INFO - PID 31654 | |6;imaging-darkroom;148;149;147;149;147;148;148;147;148;147 09:29:50 INFO - PID 31654 | |7;imaging-desaturate;95;95;95;94;96;95;95;95;94;95 09:29:50 INFO - PID 31654 | |8;json-parse-financial;46;46;46;46;48;47;48;47;47;46 09:29:50 INFO - PID 31654 | |9;json-stringify-tinderbox;57;56;57;56;57;57;58;56;56;56 09:29:50 INFO - PID 31654 | |10;stanford-crypto-aes;81;80;81;81;81;82;83;81;81;82 09:29:50 INFO - PID 31654 | |11;stanford-crypto-ccm;129;128;128;136;135;129;127;142;173;127 09:29:50 INFO - PID 31654 | |12;stanford-crypto-pbkdf2;189;188;185;192;186;185;199;183;184;186 09:29:50 INFO - PID 31654 | |13;stanford-crypto-sha256-iterative;68;66;70;67;69;66;65;65;67;68 09:29:50 INFO - PID 31654 | __end_tp_report 09:29:50 INFO - PID 31654 | __start_cc_report 09:29:50 INFO - PID 31654 | _x_x_mozilla_cycle_collect,1715 09:29:50 INFO - PID 31654 | __end_cc_report 09:29:50 INFO - PID 31654 | __startTimestamp1491236990605__endTimestamp 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | ------- Summary: start ------- 09:29:50 INFO - PID 31654 | Number of tests: 14 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.36 (2.1%) stddev-sans-first:0.87 09:29:50 INFO - PID 31654 | Values: 103.0 111.0 111.0 110.0 111.0 110.0 109.0 109.0 110.0 109.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:125.50 stddev:16.91 (13.5%) stddev-sans-first:16.80 09:29:50 INFO - PID 31654 | Values: 149.0 117.0 121.0 171.0 121.0 126.0 125.0 124.0 142.0 125.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 09:29:50 INFO - PID 31654 | Values: 164.0 163.0 165.0 166.0 164.0 166.0 166.0 166.0 165.0 164.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:12.35 (16.4%) stddev-sans-first:12.92 09:29:50 INFO - PID 31654 | Values: 75.0 74.0 76.0 111.0 74.0 75.0 78.0 76.0 95.0 74.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:83.50 stddev:7.96 (9.5%) stddev-sans-first:8.09 09:29:50 INFO - PID 31654 | Values: 83.0 83.0 103.0 84.0 88.0 83.0 97.0 92.0 82.0 100.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 09:29:50 INFO - PID 31654 | Values: 113.0 114.0 114.0 113.0 114.0 114.0 114.0 115.0 114.0 114.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:29:50 INFO - PID 31654 | Values: 148.0 149.0 147.0 149.0 147.0 148.0 148.0 147.0 148.0 147.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:29:50 INFO - PID 31654 | Values: 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 94.0 95.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:47.00 stddev:0.82 (1.8%) stddev-sans-first:0.83 09:29:50 INFO - PID 31654 | Values: 46.0 46.0 46.0 46.0 48.0 47.0 48.0 47.0 47.0 46.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:57.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 09:29:50 INFO - PID 31654 | Values: 57.0 56.0 57.0 56.0 57.0 57.0 58.0 56.0 56.0 56.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 09:29:50 INFO - PID 31654 | Values: 81.0 80.0 81.0 81.0 81.0 82.0 83.0 81.0 81.0 82.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:132.00 stddev:14.10 (10.7%) stddev-sans-first:14.77 09:29:50 INFO - PID 31654 | Values: 129.0 128.0 128.0 136.0 135.0 129.0 127.0 142.0 173.0 127.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.70 Median:187.00 stddev:4.76 (2.5%) stddev-sans-first:5.03 09:29:50 INFO - PID 31654 | Values: 189.0 188.0 185.0 192.0 186.0 185.0 199.0 183.0 184.0 186.0 09:29:50 INFO - PID 31654 | 09:29:50 INFO - PID 31654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.66 (2.5%) stddev-sans-first:1.73 09:29:50 INFO - PID 31654 | Values: 68.0 66.0 70.0 67.0 69.0 66.0 65.0 65.0 67.0 68.0 09:29:50 INFO - PID 31654 | -------- Summary: end -------- 09:29:50 INFO - PID 31654 | 09:29:51 INFO - TEST-INFO | 31654: exit 0 09:29:51 INFO - TEST-OK | kraken | took 61212ms 09:29:51 INFO - SUITE-END | took 1179s 09:29:51 INFO - Completed test suite (00:19:39) 09:29:51 INFO - javascript benchmark 09:29:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7560.461054038342, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3178.3325501644654, 3279.622843373011, 3312.1719570107475, 3330.550375699281, 3334.233126380933, 5895.0, 5895.705214739257, 5901.734421951011, 5928.644281343117, 5929.792457263997, 5928.466438020578, 5950.761969521214, 6014.669193194372, 6064.666443345614, 6075.392460753934, 5146.253793199984, 5242.239875218091, 5264.815731449409, 5322.8137015204475, 5408.810691625794, 5307.177387504943, 5327.840164795062, 5380.381256155553, 5385.569154467653, 5389.0, 5159.406668233145, 5238.083335416306, 5239.13554263546, 5250.947490525123, 5254.31693879797, 5268.367795864521, 5287.762050707727, 5292.497212764782, 5294.444083371268, 5303.628745987782, 5205.583553315763, 5249.737513124329, 5259.526642602146, 5261.394939581959, 5266.683998960075, 5905.0, 5912.4974377178, 5913.586048976574, 5916.378780228057, 5921.378255283219, 6312.936870631281, 6316.810495685137, 6318.4629306509005, 6321.4942804575985, 6326.177596912418, 6323.494120470351, 6367.777127800505, 6380.042993551005, 6380.170577824853, 6388.904166437507, 5922.911156332659, 5931.139984702238, 5953.642781433041, 5958.702064896781, 5964.314103878066, 6463.06285588587, 6515.185601799775, 6526.28210896801, 6536.0522724205675, 6542.051402546604, 6140.385961403913, 6157.692115394302, 6163.414475624809, 6324.3043265240785, 6325.462335701517, 6259.18630578031, 6280.528960327993, 6296.307406185316, 6299.0, 6300.842478938063, 6312.305646378894, 6321.65230912295, 6323.747050118036, 6333.683315834282, 6375.075614035939, 6356.237251529846, 6367.331430199855, 6368.840778980562, 6371.904421433682, 6388.297287298394, 4749.4775574686755, 4777.474477807438, 4825.396825396825, 4827.662063655511, 4838.346823178897, 4252.532221455637, 4283.550227226158, 4312.159128969821, 4319.049809042006, 4320.287152619782, 6006.0, 6007.12896629995, 6010.308814486302, 6015.85698717251, 6016.0, 6164.6917654117115, 6414.839629009312, 6474.902876456857, 6475.449586785082, 6476.481881449473, 5978.04351303798, 5981.910271345933, 5981.940180598225, 5986.431289027535, 5987.760489580455, 5395.271638328853, 5402.35171779389, 5403.7838486460105, 5404.351477822608, 5473.06957817172, 6655.600663960178, 6662.267150613526, 6677.031830384567, 6681.5656982296, 6685.799426017227, 6392.744290228525, 6450.451711604566, 6450.677466126581, 6454.19322584677, 6466.7736629219635, 6406.90389644165, 6495.967520162369, 6515.804525864231, 6678.131842860397, 6684.63234522106, 6176.474999625082, 6189.288231853395, 6192.628442293477, 6196.380361963767, 6209.720562574605, 6264.436200741773, 6292.874142517216, 6319.494440444845, 6322.968385158045, 6326.841828954129, 6137.40427488865, 6144.2319710036245, 6149.108379285068, 6176.0, 6196.318404975359, 6103.328633850184, 6168.537359698131, 6173.629582224901, 6263.749450021948, 6264.185655864891, 6112.625067133501, 6146.907796382969, 6149.754009839557, 6247.375262473716, 6253.405926436982, 6234.2830574484515, 6278.340774218641, 6308.495320374267, 6322.525810564134, 6331.588446750947, 6134.631922084689, 6140.692965351804, 6145.10895920098, 6149.200603921461, 6150.077488376779], "value": 5825.384402409962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.6748229555553, 771.8996530451041, 789.7907054630521, 1075.3977772447436, 1091.3124731419205, 31139.221519462026, 39720.81535515549, 40827.38758918618, 40862.38706419399, 40869.795651021705, 41987.0, 42172.156556868846, 42356.0, 42399.57600423995, 42414.15171696564, 5933.376995415462, 6050.6369617823075, 7859.921400786005, 8028.518288902685, 8032.759017229463, 8033.0, 8244.793880153014, 8256.669733210665, 8281.29608983237, 8287.58562071897, 8295.0, 8436.114208008163, 8438.493690378566, 8442.788930276762, 8460.57697115145, 8346.791330216733, 8372.288355489729, 8400.537970411626, 8412.873806892901, 8420.789480263013, 8146.592670366458, 8212.712555060603, 8214.178582141738, 8214.753557393287, 8216.917830821734, 41182.0, 41405.37891931624, 41418.79290603558, 41441.58558414407, 41489.1702165958, 2904.997775767357, 2928.4143171365813, 2937.2069541223964, 2940.0885725425187, 2994.625671791026, 28669.42661146786, 28677.713222867922, 28910.277243069093, 29000.70999290001, 29092.563611545633, 3596.6403359664087, 3611.487857758064, 3648.452732090181, 3654.196076863086, 3700.962990370089, 189443.0, 189573.0, 190199.0, 190404.0, 190549.0, 48412.27381589279, 48524.0, 48535.51464485381, 48603.513964860605, 48640.75679621579, 50627.0, 50636.240456393185, 50700.74649626728, 50719.49280507147, 50749.49250507521, 15324.080555166725, 15572.532824015298, 15600.29798659063, 15621.60945976337, 15644.374225031099, 10245.0, 10276.280660353854, 11980.76038479243, 12494.250344979331, 12507.56223532172, 14794.260286985824, 14871.776923346159, 14896.404143834343, 14909.552713418614, 15018.69962600742, 5574.063622242299, 5784.479396854304, 5874.618149820248, 5883.764649413975, 5891.793787217427, 1038.1798379280435, 1038.3302769713493, 1042.4214560918763, 1063.9148868090533, 1075.4730182210817, 25617.231483055537, 26178.73821261763, 26237.868810655826, 26269.21192364232, 26273.73726262751, 1133.4276190523733, 1142.7600203957263, 1143.279733767721, 1149.2816989381636, 1153.2849633227286, 13135.934320328337, 13471.461141554228, 13528.797068043987, 13599.0, 13695.520656776966, 321920.0, 323553.0, 324284.0, 324574.0, 324817.0, 55570.44429555733, 55890.72054639701, 55978.72010639921, 56052.15921761177, 56059.43940560624, 1426.6362077670128, 1472.8821694264648, 1504.353128154904, 1513.6669932614807, 1517.2792923361314, 24035.75964240335, 30413.391732165674, 30444.84777576098, 30701.0, 31130.221744455663, 55389.0, 56148.0, 56153.71923140358, 56267.0, 56507.15239271496, 320511.0, 322395.0, 322512.0, 322941.0, 323662.0, 28671.13986580406, 28979.275518112216, 34474.31051378908, 34790.47814282838, 35863.82068089643, 44832.0, 45284.773576131905, 45441.31838022366, 45553.54446455493, 45818.770906145255, 31660.0, 32412.83793581017, 32939.67060329366, 33497.33005339928, 33935.83032084923, 33103.0, 33159.668403315656, 33355.33289334151, 33710.325793483506, 33753.32493350168, 39013.0, 39685.404718928665, 39995.0, 40467.79766101151, 40509.59490405058, 31438.0, 31847.36305273835, 32090.35819283648, 32304.515432268065, 33249.833750831094, 24910.87544562338, 26352.0, 26408.603870941566, 26446.338841529116, 26786.732132679204], "value": 17992.968389742888, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.9241640296547, 419.10789890091087, 429.7636300034981, 438.1849759447429, 438.24184161400774, 20254.189832406686, 21162.57674846502, 21846.781532184672, 22066.0, 22123.557528849415, 21445.785542144575, 22533.0, 22612.43468913278, 22826.65760013601, 23072.0, 5739.311282646078, 5987.880242395149, 5997.280326360821, 5998.220231369915, 6000.579959402844, 5613.747381367828, 5799.623024503415, 5811.157382179582, 5838.795642152526, 5845.707714614252, 5800.738966746486, 5811.825645230629, 5818.738156782955, 5821.243238379005, 5821.446962538552, 5782.0, 5922.970385148068, 5970.283565972068, 5974.253218347728, 5975.731092100866, 5242.6330156889035, 5243.86890327741, 5339.0, 5342.973285133588, 5343.893122137535, 26174.8590169179, 26284.86857565719, 26701.599476007876, 27059.864700676568, 27495.587566186525, 1987.6720341143694, 2043.3257025181654, 2065.4423305707373, 2079.8856062916534, 2088.9477763056043, 15451.922740386226, 16589.336426542923, 16617.667646646998, 16966.915165424092, 17142.40001599938, 2073.3261689950677, 2073.5645514441985, 2076.646970015101, 2116.174691870172, 2116.5978464091927, 111019.44490277497, 111051.0, 111658.0, 114968.0, 115118.99999999916, 11728.76542469163, 12084.879151208552, 12121.45453454579, 12195.14633975631, 12360.196587221802, 17017.91491042537, 17023.0, 17056.744148837777, 17065.0, 17076.0, 7873.960630196812, 8131.674733010732, 8212.917870821335, 8273.875891861628, 8332.6666933322, 7388.630568471555, 7447.292507211806, 7663.348615367645, 7676.0, 7715.267049630276, 7719.845603088019, 7732.974910394198, 7860.3318717909615, 7890.723824666109, 7956.2441568050945, 1910.1977169588806, 1930.5559721264187, 1941.951451213731, 1982.8017198280056, 2193.473566344098, 1001.8747656542932, 1006.7281833904805, 1012.9037741414554, 1028.747956750601, 1031.9690409287734, 20485.38543843687, 20962.685559716618, 20994.160233590792, 21004.159833606485, 21139.154433822474, 1022.7238645565805, 1030.8041472120424, 1036.491904279287, 1051.8527406163143, 1062.946852657364, 10560.505289247212, 11414.0, 11453.312801231952, 11472.0, 11475.54097836094, 568196.0, 571989.0, 573685.0, 599677.0, 600769.0, 109201.45399272953, 111999.0, 112494.43752781184, 116247.0, 118353.40823295829, 1137.2891942535914, 1152.915843902539, 1191.6544202181444, 1199.6401079676061, 1202.22456515547, 20551.020102085415, 20776.584468310248, 21137.788622114196, 21452.678209826554, 21521.569568608855, 48980.0, 49365.75317123391, 51138.0, 51271.48728512816, 52193.21710174427, 66691.66654166892, 66986.0, 67459.27785054999, 67576.32423675897, 68327.3167268321, 8991.14584114508, 9036.45781253127, 9298.767530811783, 9425.717228483156, 9648.517574121126, 14408.0, 14675.779863301845, 15019.624509387353, 15392.230388480308, 16142.757858632365, 13369.0, 13395.12931659439, 13664.180149190683, 13930.860691393362, 14080.718385632024, 11952.880471195525, 12100.818487722867, 12124.393780311126, 12158.331291778682, 12519.186252893533, 12717.491300347883, 13476.865231347561, 13665.931670341584, 13749.175049497062, 13844.861551384358, 9481.66814161501, 9485.193758530326, 9507.191888689538, 9695.418274903528, 9822.508874556386, 12737.745245095231, 13105.606831795061, 13134.73730525365, 13235.139715918434, 13687.726245475234], "value": 10319.83488762701, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1215.7629262293856, 1327.8738519840615, 1374.7800351943686, 1411.513028005338, 1413.477013505003, 8959.641614335427, 10877.619283325084, 11246.55013799449, 11258.943705281463, 11277.154213434005, 10990.065844403216, 11077.723056923582, 11079.667609971693, 11109.277896936694, 11118.888811111887, 1980.43557586088, 2042.3158241988951, 2308.734495533014, 2345.5660702769956, 2350.6826578411865, 2250.6736523204127, 2329.173143534038, 2337.3689103941924, 2337.5091230841545, 2337.824663150262, 2247.8426510144295, 2259.288324177887, 2281.0, 2284.668723035159, 2290.1869836208157, 2216.7007453993665, 2227.298401003695, 2233.4974630708043, 2244.3827947314458, 2244.6969659095976, 2133.5412886229537, 2171.7285339332584, 2172.1094351315883, 2193.868367897915, 2199.483121466454, 11008.504617292241, 11020.50407731654, 11121.22151449399, 11129.054030407426, 11138.665840024812, 5791.0, 5914.970425147847, 5976.0, 5982.910256346115, 5987.191729116557, 3418.572678415198, 3461.1174150591437, 3738.2897249522775, 3758.6241375862196, 3760.417135344026, 1293.72831705342, 1315.7302752935625, 1321.511040914858, 1353.7495563320817, 1873.7564116664882, 16427.671446571003, 16638.667226655398, 16642.084685342303, 16668.083255420825, 16669.33322667092, 4957.231629097496, 5071.949280507148, 5072.416672082684, 5199.272101905736, 5216.478352164753, 12116.81824772629, 12282.14025018258, 12284.201526900722, 12289.508419663292, 12309.692257693629, 5945.64326140433, 5960.850978725566, 5962.40375962409, 5965.671888046112, 5973.342932277446, 5399.217113518518, 5476.726163691799, 5575.0, 5625.521830644359, 5626.887462250732, 3783.2622638585212, 3880.4373365861793, 3901.4147877818555, 3912.217556488714, 3956.208758248362, 1094.6223552874405, 1095.7151140703475, 1100.2463312630873, 1104.7127746785893, 1113.1762495753085, 784.1883650421786, 805.4965646470955, 807.7294106474396, 814.1573471457132, 815.5473712089729, 5812.331581868055, 5876.44173803488, 5904.261967254093, 5933.169356290123, 6112.541559383064, 564.4609398024876, 572.3532408378505, 575.7466714645626, 584.885947240284, 597.5996082624652, 4222.218889505451, 4320.870373888788, 4369.497507786582, 4386.912261754747, 4413.58070983256, 14029.85970140306, 14096.154230746188, 14534.636634084232, 14585.343659535347, 14671.55985320442, 13954.302284885714, 14132.222727750073, 14215.64460888486, 14234.2171180584, 14243.074200176956, 9867.210623149987, 9896.406215627085, 10055.899441005642, 10080.09279164864, 10095.990400959845, 6519.576227545194, 6534.509911756542, 6619.3380661933425, 6691.263960964193, 6915.101036865175, 12412.193207441487, 12592.74814503723, 12603.432845522157, 12737.0, 13077.803832942323, 10944.726381840199, 13376.866231337952, 13486.393112309774, 13606.93196534011, 13756.312184390941, 9093.40892841963, 9169.954150229207, 9181.081891810765, 9274.026227246042, 9321.254299656146, 10002.499875006366, 10098.798024039625, 10324.380537167493, 10327.690169294932, 10330.793384132425, 8452.492850428995, 8561.871571926551, 8616.526091064801, 8616.913830861862, 8800.251978581893, 8368.707095251637, 8374.83250335002, 8420.5789710513, 8567.443116197428, 8734.519601421729, 7690.154083050748, 7797.688092476237, 7798.883016754867, 7811.726589569338, 7813.726519571787, 5802.912956305574, 5881.441263080001, 5933.199018132669, 5955.285365756137, 6114.57197996136, 5927.229460170151, 5989.700514974146, 6025.427584379477, 6206.503479721521, 6273.1844860167885], "value": 5068.070270003508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.52940828227213, 410.36188726530236, 413.904801895564, 416.8895242760667, 418.2909967604911, 5848.1812546243455, 5849.327327357355, 5857.121431785235, 5862.618929769567, 5890.823275301737, 5534.972325138368, 5574.693391863446, 5766.654000759957, 5784.421557844224, 5827.41725827417, 4547.272436410175, 4561.361409402686, 4565.338025986238, 4568.885777855547, 4581.312803079548, 4567.451905771312, 4570.885727856797, 4577.519360467153, 4581.587657110859, 4590.954090459103, 4209.663226941852, 4358.673099517533, 4369.453818272716, 4370.038591509863, 4395.120975804836, 4333.783310834478, 4352.216601011816, 4360.7819609019425, 4363.410939523155, 4363.585459381369, 3872.4965754452023, 3874.535055793323, 3886.805659717031, 3889.183271512986, 3895.7272990890647, 5466.961277357329, 5584.162375643646, 5606.103023516218, 5622.409646987048, 5646.40712725162, 5141.434442211354, 5144.6913185209005, 5145.6398052136365, 5147.992283009629, 5148.742562871879, 5971.223740913697, 5984.431479009487, 6055.212822333113, 6084.60450070744, 6086.786962456337, 4285.678574106954, 4320.697551171419, 4328.091100868822, 4342.34864770287, 4355.0, 6083.6349819011, 6256.371304643341, 6272.65500397478, 6381.553291269613, 6393.93606063938, 4334.349847522833, 4394.12117576486, 4444.31113177458, 4445.355423463579, 4445.59989600931, 4481.641468682497, 4496.595306422372, 4502.077074199781, 4504.729716217037, 4514.322851572225, 4966.304717339575, 5101.132807422747, 5122.769475373617, 5145.716985565755, 5146.974265128651, 6082.9695851520455, 6090.421409966135, 6104.725287362079, 6104.969475152596, 6109.572329936862, 1505.8795296376263, 1521.9010764300285, 1525.3898440623839, 1527.7402841516746, 1530.7627317765764, 979.1921664626569, 1006.9748256293504, 1028.92797504174, 1034.877158283271, 1041.3595638682307, 5811.506021988093, 5826.252124362674, 5840.517779943507, 5848.210491583667, 5867.970660146757, 6266.530010249249, 6278.717457714322, 6296.874062518724, 6317.273513546001, 6331.3352098029045, 5642.6614403135945, 5793.391693872167, 5800.651960882276, 5873.530117590582, 5916.467517923407, 3325.553384277847, 3350.9832450838076, 3358.328334333143, 3366.3267346530793, 3380.138064793462, 6323.652199129, 6495.1556297681, 6505.121808555879, 6575.506836987245, 6586.407223349922, 6456.12842266288, 6459.61242325462, 6488.0, 6504.804855854332, 6554.868902621921, 6422.389872962061, 6522.902156467751, 6576.76981305652, 6596.80209593713, 6600.537962342686, 6280.371962803683, 6297.590656607306, 6301.96849015752, 6331.810045698637, 6335.239771227482, 6234.0, 6253.0620406937505, 6271.310155882758, 6287.937120628918, 6302.432781049728, 6083.513318934563, 6109.938900610937, 6415.1981002374705, 6485.319041500763, 6504.447121994684, 4348.0869017506675, 4367.58507941745, 4375.47494300686, 4381.649468042485, 4388.802503887269, 6225.273272434362, 6288.213973253343, 6307.810765677037, 6327.133495618896, 6335.271443784024, 6055.515558755201, 6066.787662431793, 6111.388861113853, 6117.785877494266, 6147.877042459037, 6037.366076561898, 6116.235470566179, 6118.418750218722, 6124.724387402489, 6155.47678447337, 5895.9115613266695, 6102.877942441215, 6111.786087486917, 6132.0, 6134.78528251509, 6168.938310616836, 6195.986304450981, 6198.194234749454, 6203.2556093269095, 6214.533909956681, 5894.115882617471, 5931.881362372815, 5974.581779275582, 6030.30651475086, 6063.787767428119], "value": 4652.955819900288, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.8698021336372, 767.7850201943456, 769.6844293839526, 770.5299767142044, 778.3500776851329, 15281.083135011879, 15293.770593441093, 15355.385784568633, 15420.61448463789, 15428.305726242317, 14972.475963341285, 15109.92445037776, 15131.243437828092, 15131.31909064092, 15186.924065379657, 918.5407296351824, 920.3327587499076, 931.7204838548442, 933.1974501928336, 937.3298091864316, 941.8775559177332, 952.2477242978039, 953.4327075390166, 953.7377221264138, 954.8472244440891, 992.9056739609725, 993.5826952679855, 993.746594618375, 993.8360170571847, 994.7811481474064, 976.8632391465201, 985.2069084387066, 985.6550207427415, 985.9063388978036, 986.6250824686609, 722.1190148019408, 722.5484072454716, 723.2261480216171, 723.2550473012806, 723.8262816923954, 15229.314680839389, 15407.152606606633, 15461.613459663598, 15998.44005459815, 16203.270852811651, 15250.618734531614, 15812.920935395365, 15863.20683965797, 16105.355785768556, 16774.0, 12197.756044879052, 12297.508099676003, 12380.566680166152, 12746.80879786804, 13399.263040532767, 3174.3809957058384, 3250.089974807058, 3297.55483009793, 3369.511420843964, 3372.089535825338, 90801.54599227027, 92633.37848848567, 93257.533712331, 94606.05393946041, 96777.0, 12413.301097855927, 12445.439955201857, 12579.559715409916, 12773.744525109445, 13193.60419187426, 24544.877275613508, 25425.745742542338, 25524.361890952874, 26217.868910655325, 26283.60574591383, 7952.3638108951145, 8128.187181281943, 8146.75559733209, 8171.305439037629, 8307.08622051574, 4143.81352839123, 4238.682098842537, 4239.51245606753, 4246.936295955563, 4248.065425606362, 4189.455370801777, 4257.936130958038, 4266.06146647737, 4278.978605107017, 4282.571742825755, 699.1226011355716, 716.5414134953634, 724.7535837815062, 727.7125535413588, 733.0726630812027, 570.1504757910683, 573.9339975902741, 586.9090291004901, 595.3778301674761, 599.9520038397005, 9011.188992990663, 9734.464604446823, 9789.21686265097, 9877.357971731815, 10436.269461137648, 568.3549171690079, 578.2812252023468, 602.6655206360512, 604.0938592111833, 611.1016805296207, 4521.140983213245, 4737.905241895142, 4745.240761478216, 4745.762711864393, 4756.357891684647, 79977.0, 80599.59700201462, 81108.59445702734, 81432.18567814365, 81878.49004914242, 71415.2858471419, 71714.2828571718, 72407.0, 73135.0, 74728.62635686896, 65772.0, 66134.166235626, 66170.0, 68538.65730671414, 68594.0, 9351.53242337894, 9590.616375344907, 9689.321747477608, 9737.221022318055, 9778.462184579916, 35163.47254791129, 35375.64624353724, 35600.64399355973, 35858.0, 36664.63335366612, 42649.0, 43166.56833431625, 43725.72057095794, 43962.56037439585, 44581.33128003018, 12133.0, 12164.08769342285, 12202.633920982385, 12311.384430778604, 12500.499980000699, 12710.428030738454, 12722.499838723386, 12806.935965320114, 13090.869091308965, 13359.933200333937, 11972.221805582609, 12163.635090947286, 12347.75304493923, 12962.935185324013, 13029.0, 12488.625341239778, 12656.746865062463, 12735.617931462071, 12982.0, 13305.46778128864, 11848.28910265387, 12057.698557536132, 12191.634250972485, 12308.938455307667, 12848.743025139258, 10223.341931097819, 10524.842127368249, 10590.364578125336, 10731.195160362848, 11097.278676885977, 10674.62638807638, 11357.886421135683, 11435.885641143483, 11564.94217528907, 11942.223755455867], "value": 7321.2209902835475, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 110.0, 111.0, 110.0, 109.0, 109.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 121.0, 171.0, 121.0, 126.0, 125.0, 124.0, 142.0, 125.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 166.0, 164.0, 166.0, 166.0, 166.0, 165.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 111.0, 74.0, 75.0, 78.0, 76.0, 95.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 103.0, 84.0, 88.0, 83.0, 97.0, 92.0, 82.0, 100.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 149.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 46.0, 46.0, 48.0, 47.0, 48.0, 47.0, 47.0, 46.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 56.0, 57.0, 57.0, 58.0, 56.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 81.0, 81.0, 82.0, 83.0, 81.0, 81.0, 82.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 128.0, 136.0, 135.0, 129.0, 127.0, 142.0, 173.0, 127.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 188.0, 185.0, 192.0, 186.0, 185.0, 199.0, 183.0, 184.0, 186.0], "value": 187.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 67.0, 69.0, 66.0, 65.0, 65.0, 67.0, 68.0], "value": 67.1, "unit": "score"}]}]} 09:29:51 INFO - Return code: 0 09:29:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:29:51 ERROR - # TBPL SUCCESS # 09:29:51 INFO - Running post-action listener: _resource_record_post_action 09:29:51 INFO - [mozharness: 2017-04-03 16:29:51.930119Z] Finished run-tests step (success) 09:29:51 INFO - Running post-run listener: _resource_record_post_run 09:29:52 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 371486720; Read time: 24; Write time: 219680 09:29:52 INFO - TinderboxPrint: CPU usage
13.0% 09:29:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 09:29:52 INFO - TinderboxPrint: I/O write bytes / time
371,486,720 / 219,680 09:29:52 INFO - TinderboxPrint: CPU idle
8,307.2 (87.0%) 09:29:52 INFO - TinderboxPrint: CPU user
1,191.8 (12.5%) 09:29:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:29:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111792128; Read time: 0; Write time: 90712 09:29:52 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 259301376; Read time: 16; Write time: 128968 09:29:52 INFO - Running post-run listener: _upload_blobber_files 09:29:52 INFO - Blob upload gear active. 09:29:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:29:52 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 09:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:29:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:53 INFO - (blobuploader) - INFO - Done attempting. 09:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:57 INFO - (blobuploader) - INFO - Done attempting. 09:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:57 INFO - (blobuploader) - INFO - Done attempting. 09:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:58 INFO - (blobuploader) - INFO - Done attempting. 09:29:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:29:58 INFO - Return code: 0 09:29:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:29:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:29:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/175d83945e434f5593ce0a52e73b16ae7f34005666b8998954d1d3cabb85f11c9fb4ee7663ddfd3a7f9a1a985c0eadd04902959fd70c034d52748b9c0729efb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff4bb944ce4b220e698cf5539d3a1c2c9c1b7e3e66e414c82892f554fab0b034b450b21735c1b4c3aad844e0cfd2f553084a40290189312f91a7627cf7842867", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada70e7ebf6e917c0a3a746951d5a66b55fcca681fac9fcb98bde5032aca8514f2909d5d646e945cd54699c5279b94f1d5bdeedf30885073cc5cd4bedaf39dec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e95076d98555643fe92d085b0c8c1bc24b5e6d5fe0f618b650905ec4e1db8c19930fb2d141db6b3f0e335fb7229470d6b3e9f209a360423c5edd7a9615ee21f"} 09:29:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:29:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:29:58 INFO - Contents: 09:29:58 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/175d83945e434f5593ce0a52e73b16ae7f34005666b8998954d1d3cabb85f11c9fb4ee7663ddfd3a7f9a1a985c0eadd04902959fd70c034d52748b9c0729efb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff4bb944ce4b220e698cf5539d3a1c2c9c1b7e3e66e414c82892f554fab0b034b450b21735c1b4c3aad844e0cfd2f553084a40290189312f91a7627cf7842867", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada70e7ebf6e917c0a3a746951d5a66b55fcca681fac9fcb98bde5032aca8514f2909d5d646e945cd54699c5279b94f1d5bdeedf30885073cc5cd4bedaf39dec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e95076d98555643fe92d085b0c8c1bc24b5e6d5fe0f618b650905ec4e1db8c19930fb2d141db6b3f0e335fb7229470d6b3e9f209a360423c5edd7a9615ee21f"} 09:29:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:29:58 INFO - Copying logs to upload dir... 09:29:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:29:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.003543 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-04-03 09:29:58.689276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 09:29:58.693234) ========= 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=9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/175d83945e434f5593ce0a52e73b16ae7f34005666b8998954d1d3cabb85f11c9fb4ee7663ddfd3a7f9a1a985c0eadd04902959fd70c034d52748b9c0729efb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff4bb944ce4b220e698cf5539d3a1c2c9c1b7e3e66e414c82892f554fab0b034b450b21735c1b4c3aad844e0cfd2f553084a40290189312f91a7627cf7842867", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada70e7ebf6e917c0a3a746951d5a66b55fcca681fac9fcb98bde5032aca8514f2909d5d646e945cd54699c5279b94f1d5bdeedf30885073cc5cd4bedaf39dec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e95076d98555643fe92d085b0c8c1bc24b5e6d5fe0f618b650905ec4e1db8c19930fb2d141db6b3f0e335fb7229470d6b3e9f209a360423c5edd7a9615ee21f"} build_url:https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/NMpKVKhXThOBMrJOGrpsTA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/175d83945e434f5593ce0a52e73b16ae7f34005666b8998954d1d3cabb85f11c9fb4ee7663ddfd3a7f9a1a985c0eadd04902959fd70c034d52748b9c0729efb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff4bb944ce4b220e698cf5539d3a1c2c9c1b7e3e66e414c82892f554fab0b034b450b21735c1b4c3aad844e0cfd2f553084a40290189312f91a7627cf7842867", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada70e7ebf6e917c0a3a746951d5a66b55fcca681fac9fcb98bde5032aca8514f2909d5d646e945cd54699c5279b94f1d5bdeedf30885073cc5cd4bedaf39dec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e95076d98555643fe92d085b0c8c1bc24b5e6d5fe0f618b650905ec4e1db8c19930fb2d141db6b3f0e335fb7229470d6b3e9f209a360423c5edd7a9615ee21f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 09:29:58.718369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:29:58.718667) ========= 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=9bfb7e13875ed353a705960e000001c0-1491235742.223746-2114243675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:29:58.802169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 09:29:58.802622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 09:29:58.803083) ========= ========= Total master_lag: 0.15 =========