builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1491235533.1 results: success (0) revision: 8dccb2103beea5cae59114efb151a9f6d185a75a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.099702) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.100627) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.101354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.117223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.117575) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-03 09:05:33-- 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% 40.8M=0s 2017-04-03 09:05:33 (40.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.253614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.254071) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016480 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.303967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:33.304451) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8dccb2103beea5cae59114efb151a9f6d185a75a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8dccb2103beea5cae59114efb151a9f6d185a75a --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=e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-03 09:05:33,546 truncating revision to first 12 chars 2017-04-03 09:05:33,546 Setting DEBUG logging. 2017-04-03 09:05:33,546 attempt 1/10 2017-04-03 09:05:33,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8dccb2103bee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 09:05:33,984 unpacking tar archive at: mozilla-aurora-8dccb2103bee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:34.089787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:34.090191) ========= script_repo_revision: 8dccb2103beea5cae59114efb151a9f6d185a75a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:34.090624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:34.090949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 09:05:34.100188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-04-03 09:05:34.100490) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:34 INFO - MultiFileLogger online at 20170403 09:05:34 in /builds/slave/test 09:05:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:34 INFO - {'append_to_log': False, 09:05:34 INFO - 'base_work_dir': '/builds/slave/test', 09:05:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:34 INFO - 'branch': 'Mozilla-Aurora', 09:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:34 INFO - 'config_files': ('talos/linux_config.py',), 09:05:34 INFO - 'default_actions': ('clobber', 09:05:34 INFO - 'read-buildbot-config', 09:05:34 INFO - 'download-and-extract', 09:05:34 INFO - 'populate-webroot', 09:05:34 INFO - 'create-virtualenv', 09:05:34 INFO - 'install', 09:05:34 INFO - 'run-tests'), 09:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:34 INFO - 'download_minidump_stackwalk': True, 09:05:34 INFO - 'download_symbols': 'ondemand', 09:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:34 INFO - 'gecko_profile': False, 09:05:34 INFO - 'gecko_profile_interval': 0, 09:05:34 INFO - 'installer_path': 'installer.exe', 09:05:34 INFO - 'log_level': 'info', 09:05:34 INFO - 'log_name': 'talos', 09:05:34 INFO - 'log_to_console': True, 09:05:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:34 INFO - 'opt_config_files': (), 09:05:34 INFO - 'pip_index': False, 09:05:34 INFO - 'suite': 'dromaeojs', 09:05:34 INFO - 'system_bits': '32', 09:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:34 INFO - 'title': 'talos-linux64-ix-067', 09:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:34 INFO - 'use_talos_json': True, 09:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:34 INFO - 'work_dir': 'build'} 09:05:34 INFO - [mozharness: 2017-04-03 16:05:34.439138Z] Running clobber step. 09:05:34 INFO - Running pre-action listener: _resource_record_pre_action 09:05:34 INFO - Running main action method: clobber 09:05:34 INFO - rmtree: /builds/slave/test/build 09:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:35 INFO - Running post-action listener: _resource_record_post_action 09:05:35 INFO - [mozharness: 2017-04-03 16:05:35.378572Z] Finished clobber step (success) 09:05:35 INFO - [mozharness: 2017-04-03 16:05:35.378671Z] Running read-buildbot-config step. 09:05:35 INFO - Running pre-action listener: _resource_record_pre_action 09:05:35 INFO - Running main action method: read_buildbot_config 09:05:35 INFO - Using buildbot properties: 09:05:35 INFO - { 09:05:35 INFO - "project": "", 09:05:35 INFO - "product": "firefox", 09:05:35 INFO - "who": "ffxbld@noreply.mozilla.org", 09:05:35 INFO - "installer_path": "public/build/target.tar.bz2", 09:05:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:05:35 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:05:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:05:35 INFO - "stage_platform": "linux64-pgo", 09:05:35 INFO - "basedir": "/builds/slave/test", 09:05:35 INFO - "buildnumber": 822, 09:05:35 INFO - "platform": "ubuntu64_hw", 09:05:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:05:35 INFO - "slavebuilddir": "test", 09:05:35 INFO - "taskId": "M5-nuLPDRP-j1eckeD0qzw", 09:05:35 INFO - "branch": "mozilla-aurora", 09:05:35 INFO - "script_repo_revision": "production", 09:05:35 INFO - "revision": "8dccb2103beea5cae59114efb151a9f6d185a75a", 09:05:35 INFO - "slavename": "talos-linux64-ix-067", 09:05:35 INFO - "repo_path": "releases/mozilla-aurora" 09:05:35 INFO - } 09:05:35 INFO - Finding installer, test and symbols from parent task. 09:05:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M5-nuLPDRP-j1eckeD0qzw'}, attempt #1 09:05:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M5-nuLPDRP-j1eckeD0qzw'}, attempt #1 09:05:36 INFO - Task dependencies: XCqniTduSp-UaPwEl1T3rA 09:05:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA'}, attempt #1 09:05:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.tar.bz2 09:05:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/test_packages.json 09:05:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.crashreporter-symbols.zip 09:05:36 INFO - Running post-action listener: _resource_record_post_action 09:05:36 INFO - [mozharness: 2017-04-03 16:05:36.827689Z] Finished read-buildbot-config step (success) 09:05:36 INFO - [mozharness: 2017-04-03 16:05:36.827907Z] Running download-and-extract step. 09:05:36 INFO - Running pre-action listener: _resource_record_pre_action 09:05:36 INFO - Running main action method: download_and_extract 09:05:36 INFO - mkdir: /builds/slave/test/build/tests 09:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:36 INFO - trying https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.test_packages.json 09:05:36 INFO - Downloading https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:05:37 INFO - Downloaded 896 bytes. 09:05:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:05:37 INFO - Using the following test package requirements: 09:05:37 INFO - {u'common': [u'target.common.tests.zip'], 09:05:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:05:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:05:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:05:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:05:37 INFO - u'mozbase': [u'target.common.tests.zip'], 09:05:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:05:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:05:37 INFO - u'web-platform': [u'target.common.tests.zip', 09:05:37 INFO - u'target.web-platform.tests.zip'], 09:05:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:05:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:05:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.common.tests.zip 09:05:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:05:37 INFO - Fetch https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.common.tests.zip into memory 09:05:38 INFO - Expected file size: 59542389 09:05:38 INFO - Obtained file size: 59542389 09:05:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:05:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.common.tests.zip 09:05:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:05:48 INFO - Fetch https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.common.tests.zip into memory 09:05:49 INFO - Expected file size: 59542389 09:05:49 INFO - Obtained file size: 59542389 09:05:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.talos.tests.zip 09:05:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:05:59 INFO - Fetch https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.talos.tests.zip into memory 09:06:00 INFO - Expected file size: 14404438 09:06:00 INFO - Obtained file size: 14404438 09:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:00 INFO - trying https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.tar.bz2 09:06:00 INFO - Downloading https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:06:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:06:02 INFO - Downloaded 66598061 bytes. 09:06:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.tar.bz2 09:06:02 INFO - mkdir: /builds/slave/test/properties 09:06:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:02 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:02 INFO - Contents: 09:06:02 INFO - build_url:https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.tar.bz2 09:06:02 INFO - Running post-action listener: _resource_record_post_action 09:06:02 INFO - Running post-action listener: set_extra_try_arguments 09:06:02 INFO - [mozharness: 2017-04-03 16:06:02.071595Z] Finished download-and-extract step (success) 09:06:02 INFO - [mozharness: 2017-04-03 16:06:02.071692Z] Running populate-webroot step. 09:06:02 INFO - Running pre-action listener: _resource_record_pre_action 09:06:02 INFO - Running main action method: populate_webroot 09:06:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:02 INFO - '--tppagecycles', 09:06:02 INFO - '7'], 09:06:02 INFO - 'tests': ['tsvgm']}}, 09:06:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:06:02 INFO - 'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:06:02 INFO - 'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['damp', 'tps']}, 09:06:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:06:02 INFO - 'tests': ['damp', 'tps']}, 09:06:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['dromaeo_dom']}, 09:06:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['basic_compositor_video']}, 09:06:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['a11yr', 09:06:02 INFO - 'ts_paint', 09:06:02 INFO - 'tpaint', 09:06:02 INFO - 'sessionrestore', 09:06:02 INFO - 'sessionrestore_no_auto_restore', 09:06:02 INFO - 'tabpaint']}, 09:06:02 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:02 INFO - 'ts_paint', 09:06:02 INFO - 'tpaint', 09:06:02 INFO - 'sessionrestore', 09:06:02 INFO - 'sessionrestore_no_auto_restore', 09:06:02 INFO - 'tabpaint']}, 09:06:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:02 INFO - 'ts_paint', 09:06:02 INFO - 'tpaint', 09:06:02 INFO - 'sessionrestore', 09:06:02 INFO - 'sessionrestore_no_auto_restore', 09:06:02 INFO - 'tabpaint']}, 09:06:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:02 INFO - 'ts_paint', 09:06:02 INFO - 'tpaint', 09:06:02 INFO - 'sessionrestore', 09:06:02 INFO - 'sessionrestore_no_auto_restore', 09:06:02 INFO - 'tabpaint']}, 09:06:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['a11yr', 09:06:02 INFO - 'ts_paint', 09:06:02 INFO - 'tpaint', 09:06:02 INFO - 'sessionrestore', 09:06:02 INFO - 'sessionrestore_no_auto_restore', 09:06:02 INFO - 'tabpaint']}, 09:06:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['a11yr', 09:06:02 INFO - 'ts_paint', 09:06:02 INFO - 'tpaint', 09:06:02 INFO - 'sessionrestore', 09:06:02 INFO - 'sessionrestore_no_auto_restore', 09:06:02 INFO - 'tabpaint']}, 09:06:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['tsvgx', 09:06:02 INFO - 'tsvgr_opacity', 09:06:02 INFO - 'tart', 09:06:02 INFO - 'tscrollx', 09:06:02 INFO - 'cart', 09:06:02 INFO - 'tsvg_static']}, 09:06:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:02 INFO - 'tsvgr_opacity', 09:06:02 INFO - 'tart', 09:06:02 INFO - 'tscrollx', 09:06:02 INFO - 'cart', 09:06:02 INFO - 'tsvg_static']}, 09:06:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:06:02 INFO - 'talos_options': ['--disable-e10s'], 09:06:02 INFO - 'tests': ['tp5o']}, 09:06:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:06:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:06:02 INFO - 'talos_options': ['--disable-e10s', 09:06:02 INFO - '--xperf_path', 09:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:02 INFO - 'tests': ['tp5n']}, 09:06:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:06:02 INFO - 'talos_options': ['--xperf_path', 09:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:02 INFO - 'tests': ['tp5n']}}, 09:06:02 INFO - 'talos.zip': {'path': '', 09:06:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:02 INFO - Running post-action listener: _resource_record_post_action 09:06:02 INFO - [mozharness: 2017-04-03 16:06:02.084726Z] Finished populate-webroot step (success) 09:06:02 INFO - [mozharness: 2017-04-03 16:06:02.084816Z] Running create-virtualenv step. 09:06:02 INFO - Running pre-action listener: _resource_record_pre_action 09:06:02 INFO - Running main action method: create_virtualenv 09:06:02 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:02 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:06:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:02 INFO - Using real prefix '/usr' 09:06:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:04 INFO - Installing pip.................done. 09:06:04 INFO - Return code: 0 09:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:06:04 INFO - Reading from file tmpfile_stdout 09:06:04 INFO - Output received: 09:06:04 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:06:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:06:04 INFO - Using env: {'DISPLAY': ':0', 09:06:04 INFO - 'HOME': '/home/cltbld', 09:06:04 INFO - 'LANG': 'en_US.UTF-8', 09:06:04 INFO - 'LANGUAGE': 'en_US:en', 09:06:04 INFO - 'LOGNAME': 'cltbld', 09:06:04 INFO - 'MAIL': '/var/mail/cltbld', 09:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:04 INFO - 'MOZ_NO_REMOTE': '1', 09:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:04 INFO - 'NO_EM_RESTART': '1', 09:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:04 INFO - 'PWD': '/builds/slave/test', 09:06:04 INFO - 'SHELL': '/bin/bash', 09:06:04 INFO - 'SHLVL': '1', 09:06:04 INFO - 'TERM': 'linux', 09:06:04 INFO - 'TMOUT': '86400', 09:06:04 INFO - 'USER': 'cltbld', 09:06:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:04 INFO - '_': '/tools/buildbot/bin/python'} 09:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:05 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:06:05 INFO - Cleaning up... 09:06:05 INFO - Return code: 0 09:06:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:05 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:05 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:06:05 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:06:05 INFO - Using env: {'DISPLAY': ':0', 09:06:05 INFO - 'HOME': '/home/cltbld', 09:06:05 INFO - 'LANG': 'en_US.UTF-8', 09:06:05 INFO - 'LANGUAGE': 'en_US:en', 09:06:05 INFO - 'LOGNAME': 'cltbld', 09:06:05 INFO - 'MAIL': '/var/mail/cltbld', 09:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:05 INFO - 'MOZ_NO_REMOTE': '1', 09:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:05 INFO - 'NO_EM_RESTART': '1', 09:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:05 INFO - 'PWD': '/builds/slave/test', 09:06:05 INFO - 'SHELL': '/bin/bash', 09:06:05 INFO - 'SHLVL': '1', 09:06:05 INFO - 'TERM': 'linux', 09:06:05 INFO - 'TMOUT': '86400', 09:06:05 INFO - 'USER': 'cltbld', 09:06:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:05 INFO - '_': '/tools/buildbot/bin/python'} 09:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:05 INFO - Downloading/unpacking psutil>=3.1.1 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:07 INFO - Installing collected packages: psutil 09:06:07 INFO - Running setup.py install for psutil 09:06:07 INFO - building 'psutil._psutil_linux' extension 09:06:07 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:06:07 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:06:07 INFO - building 'psutil._psutil_posix' extension 09:06:07 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:06:07 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:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:07 INFO - Successfully installed psutil 09:06:07 INFO - Cleaning up... 09:06:08 INFO - Return code: 0 09:06:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:08 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:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:08 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:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:08 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:08 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:06:08 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:06:08 INFO - Using env: {'DISPLAY': ':0', 09:06:08 INFO - 'HOME': '/home/cltbld', 09:06:08 INFO - 'LANG': 'en_US.UTF-8', 09:06:08 INFO - 'LANGUAGE': 'en_US:en', 09:06:08 INFO - 'LOGNAME': 'cltbld', 09:06:08 INFO - 'MAIL': '/var/mail/cltbld', 09:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:08 INFO - 'MOZ_NO_REMOTE': '1', 09:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:08 INFO - 'NO_EM_RESTART': '1', 09:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:08 INFO - 'PWD': '/builds/slave/test', 09:06:08 INFO - 'SHELL': '/bin/bash', 09:06:08 INFO - 'SHLVL': '1', 09:06:08 INFO - 'TERM': 'linux', 09:06:08 INFO - 'TMOUT': '86400', 09:06:08 INFO - 'USER': 'cltbld', 09:06:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:08 INFO - '_': '/tools/buildbot/bin/python'} 09:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:06:10 INFO - Installing collected packages: mozsystemmonitor 09:06:10 INFO - Running setup.py install for mozsystemmonitor 09:06:10 INFO - Successfully installed mozsystemmonitor 09:06:10 INFO - Cleaning up... 09:06:10 INFO - Return code: 0 09:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06:10 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:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:10 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:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:10 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:10 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:06:10 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:06:10 INFO - Using env: {'DISPLAY': ':0', 09:06:10 INFO - 'HOME': '/home/cltbld', 09:06:10 INFO - 'LANG': 'en_US.UTF-8', 09:06:10 INFO - 'LANGUAGE': 'en_US:en', 09:06:10 INFO - 'LOGNAME': 'cltbld', 09:06:10 INFO - 'MAIL': '/var/mail/cltbld', 09:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:10 INFO - 'MOZ_NO_REMOTE': '1', 09:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:10 INFO - 'NO_EM_RESTART': '1', 09:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:10 INFO - 'PWD': '/builds/slave/test', 09:06:10 INFO - 'SHELL': '/bin/bash', 09:06:10 INFO - 'SHLVL': '1', 09:06:10 INFO - 'TERM': 'linux', 09:06:10 INFO - 'TMOUT': '86400', 09:06:10 INFO - 'USER': 'cltbld', 09:06:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:10 INFO - '_': '/tools/buildbot/bin/python'} 09:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:06:10 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:06:10 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:06:10 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:06:10 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:06:10 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:06:10 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:06:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:06:12 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:06:12 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:06:12 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:06:12 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:06:12 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:06:12 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:06:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:12 INFO - warning: no files found matching '*.txt' 09:06:12 INFO - no previously-included directories found matching 'build' 09:06:12 INFO - no previously-included directories found matching 'dist' 09:06:12 INFO - no previously-included directories found matching '.git*' 09:06:12 INFO - Installing collected packages: jsonschema, functools32 09:06:13 INFO - Running setup.py install for functools32 09:06:13 INFO - warning: no files found matching '*.txt' 09:06:13 INFO - no previously-included directories found matching 'build' 09:06:13 INFO - no previously-included directories found matching 'dist' 09:06:13 INFO - no previously-included directories found matching '.git*' 09:06:13 INFO - Successfully installed jsonschema functools32 09:06:13 INFO - Cleaning up... 09:06:13 INFO - Return code: 0 09:06:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:06:13 INFO - Using env: {'DISPLAY': ':0', 09:06:13 INFO - 'HOME': '/home/cltbld', 09:06:13 INFO - 'LANG': 'en_US.UTF-8', 09:06:13 INFO - 'LANGUAGE': 'en_US:en', 09:06:13 INFO - 'LOGNAME': 'cltbld', 09:06:13 INFO - 'MAIL': '/var/mail/cltbld', 09:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:13 INFO - 'MOZ_NO_REMOTE': '1', 09:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:13 INFO - 'NO_EM_RESTART': '1', 09:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:13 INFO - 'PWD': '/builds/slave/test', 09:06:13 INFO - 'SHELL': '/bin/bash', 09:06:13 INFO - 'SHLVL': '1', 09:06:13 INFO - 'TERM': 'linux', 09:06:13 INFO - 'TMOUT': '86400', 09:06:13 INFO - 'USER': 'cltbld', 09:06:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:13 INFO - '_': '/tools/buildbot/bin/python'} 09:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:06:13 INFO - Cleaning up... 09:06:13 INFO - Return code: 0 09:06:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:06:13 INFO - Using env: {'DISPLAY': ':0', 09:06:13 INFO - 'HOME': '/home/cltbld', 09:06:13 INFO - 'LANG': 'en_US.UTF-8', 09:06:13 INFO - 'LANGUAGE': 'en_US:en', 09:06:13 INFO - 'LOGNAME': 'cltbld', 09:06:13 INFO - 'MAIL': '/var/mail/cltbld', 09:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:13 INFO - 'MOZ_NO_REMOTE': '1', 09:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:13 INFO - 'NO_EM_RESTART': '1', 09:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:13 INFO - 'PWD': '/builds/slave/test', 09:06:13 INFO - 'SHELL': '/bin/bash', 09:06:13 INFO - 'SHLVL': '1', 09:06:13 INFO - 'TERM': 'linux', 09:06:13 INFO - 'TMOUT': '86400', 09:06:13 INFO - 'USER': 'cltbld', 09:06:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:13 INFO - '_': '/tools/buildbot/bin/python'} 09:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:06:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06:16 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:06:16 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:06:16 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:06:16 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:06:16 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:06:16 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:06:16 INFO - Downloading docopt-0.6.1.tar.gz 09:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:16 INFO - Running setup.py install for blobuploader 09:06:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:06:16 INFO - Running setup.py install for requests 09:06:16 INFO - Running setup.py install for docopt 09:06:16 INFO - Successfully installed blobuploader requests docopt 09:06:16 INFO - Cleaning up... 09:06:17 INFO - Return code: 0 09:06:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:17 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:17 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:06:17 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:06:17 INFO - Using env: {'DISPLAY': ':0', 09:06:17 INFO - 'HOME': '/home/cltbld', 09:06:17 INFO - 'LANG': 'en_US.UTF-8', 09:06:17 INFO - 'LANGUAGE': 'en_US:en', 09:06:17 INFO - 'LOGNAME': 'cltbld', 09:06:17 INFO - 'MAIL': '/var/mail/cltbld', 09:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:17 INFO - 'MOZ_NO_REMOTE': '1', 09:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:17 INFO - 'NO_EM_RESTART': '1', 09:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:17 INFO - 'PWD': '/builds/slave/test', 09:06:17 INFO - 'SHELL': '/bin/bash', 09:06:17 INFO - 'SHLVL': '1', 09:06:17 INFO - 'TERM': 'linux', 09:06:17 INFO - 'TMOUT': '86400', 09:06:17 INFO - 'USER': 'cltbld', 09:06:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:17 INFO - '_': '/tools/buildbot/bin/python'} 09:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:17 INFO - Running setup.py (path:/tmp/pip-twdRvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:17 INFO - Running setup.py (path:/tmp/pip-0TtXNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:17 INFO - Running setup.py (path:/tmp/pip-hNPEcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:17 INFO - Running setup.py (path:/tmp/pip-s0vmuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:17 INFO - Running setup.py (path:/tmp/pip-WsA_yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:17 INFO - Running setup.py (path:/tmp/pip-w4urF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:17 INFO - Running setup.py (path:/tmp/pip-d39RAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:17 INFO - Running setup.py (path:/tmp/pip-GusTg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:17 INFO - Running setup.py (path:/tmp/pip-YJ3klT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:17 INFO - Running setup.py (path:/tmp/pip-47snub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:17 INFO - Running setup.py (path:/tmp/pip-U2Jr7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:18 INFO - Running setup.py (path:/tmp/pip-oIH_he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:18 INFO - Running setup.py (path:/tmp/pip-kma3Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:18 INFO - Running setup.py (path:/tmp/pip-Zt0rET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:18 INFO - Running setup.py (path:/tmp/pip-uJxKQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:18 INFO - Running setup.py (path:/tmp/pip-y35jjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:18 INFO - Running setup.py (path:/tmp/pip-uWaJGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:18 INFO - Running setup.py install for manifestparser 09:06:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:06:18 INFO - Running setup.py install for mozcrash 09:06:18 INFO - Running setup.py install for mozdebug 09:06:18 INFO - Running setup.py install for mozdevice 09:06:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:06:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:06:18 INFO - Running setup.py install for mozfile 09:06:18 INFO - Running setup.py install for mozhttpd 09:06:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Running setup.py install for mozinfo 09:06:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Running setup.py install for mozInstall 09:06:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Running setup.py install for mozleak 09:06:19 INFO - Running setup.py install for mozlog 09:06:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Running setup.py install for moznetwork 09:06:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Running setup.py install for mozprocess 09:06:19 INFO - Running setup.py install for mozprofile 09:06:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Running setup.py install for mozrunner 09:06:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:06:19 INFO - Running setup.py install for mozscreenshot 09:06:20 INFO - Running setup.py install for moztest 09:06:20 INFO - Running setup.py install for mozversion 09:06:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:06:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:20 INFO - Cleaning up... 09:06:20 INFO - Return code: 0 09:06:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:20 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:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:20 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:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:20 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:20 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:06:20 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:06:20 INFO - Using env: {'DISPLAY': ':0', 09:06:20 INFO - 'HOME': '/home/cltbld', 09:06:20 INFO - 'LANG': 'en_US.UTF-8', 09:06:20 INFO - 'LANGUAGE': 'en_US:en', 09:06:20 INFO - 'LOGNAME': 'cltbld', 09:06:20 INFO - 'MAIL': '/var/mail/cltbld', 09:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:20 INFO - 'MOZ_NO_REMOTE': '1', 09:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:20 INFO - 'NO_EM_RESTART': '1', 09:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:20 INFO - 'PWD': '/builds/slave/test', 09:06:20 INFO - 'SHELL': '/bin/bash', 09:06:20 INFO - 'SHLVL': '1', 09:06:20 INFO - 'TERM': 'linux', 09:06:20 INFO - 'TMOUT': '86400', 09:06:20 INFO - 'USER': 'cltbld', 09:06:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:20 INFO - '_': '/tools/buildbot/bin/python'} 09:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:20 INFO - Running setup.py (path:/tmp/pip-powuH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:20 INFO - Running setup.py (path:/tmp/pip-SlfWNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:20 INFO - Running setup.py (path:/tmp/pip-3PWBDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:20 INFO - Running setup.py (path:/tmp/pip-LgvEIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:20 INFO - Running setup.py (path:/tmp/pip-kK4GcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:20 INFO - Running setup.py (path:/tmp/pip-JiSSTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:20 INFO - Running setup.py (path:/tmp/pip-lFnRqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:20 INFO - Running setup.py (path:/tmp/pip-xu1a2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:21 INFO - Running setup.py (path:/tmp/pip-ID2M1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:21 INFO - Running setup.py (path:/tmp/pip-jTDm51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:21 INFO - Running setup.py (path:/tmp/pip-bn4f8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:21 INFO - Running setup.py (path:/tmp/pip-_Nwm5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:21 INFO - Running setup.py (path:/tmp/pip-diNn3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:21 INFO - Running setup.py (path:/tmp/pip-ZwJUxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:21 INFO - Running setup.py (path:/tmp/pip-t7h9QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:21 INFO - Running setup.py (path:/tmp/pip-d42mdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:21 INFO - Running setup.py (path:/tmp/pip-QqZlFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:23 INFO - Downloading blessings-1.6.tar.gz 09:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:23 INFO - Installing collected packages: blessings 09:06:23 INFO - Running setup.py install for blessings 09:06:23 INFO - Successfully installed blessings 09:06:23 INFO - Cleaning up... 09:06:23 INFO - Return code: 0 09:06:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:24 INFO - Reading from file tmpfile_stdout 09:06:24 INFO - Current package versions: 09:06:24 INFO - argparse == 1.2.1 09:06:24 INFO - blessings == 1.6 09:06:24 INFO - blobuploader == 1.2.4 09:06:24 INFO - docopt == 0.6.1 09:06:24 INFO - functools32 == 3.2.3-2 09:06:24 INFO - jsonschema == 2.5.1 09:06:24 INFO - manifestparser == 1.1 09:06:24 INFO - mozInstall == 1.12 09:06:24 INFO - mozcrash == 1.0 09:06:24 INFO - mozdebug == 0.1 09:06:24 INFO - mozdevice == 0.49 09:06:24 INFO - mozfile == 1.2 09:06:24 INFO - mozhttpd == 0.7 09:06:24 INFO - mozinfo == 0.9 09:06:24 INFO - mozleak == 0.1 09:06:24 INFO - mozlog == 3.4 09:06:24 INFO - moznetwork == 0.27 09:06:24 INFO - mozprocess == 0.25 09:06:24 INFO - mozprofile == 0.28 09:06:24 INFO - mozrunner == 6.13 09:06:24 INFO - mozscreenshot == 0.1 09:06:24 INFO - mozsystemmonitor == 0.3 09:06:24 INFO - moztest == 0.8 09:06:24 INFO - mozversion == 1.4 09:06:24 INFO - psutil == 3.1.1 09:06:24 INFO - requests == 1.2.3 09:06:24 INFO - wsgiref == 0.1.2 09:06:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:24 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:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 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:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:24 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:06:24 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:06:24 INFO - Using env: {'DISPLAY': ':0', 09:06:24 INFO - 'HOME': '/home/cltbld', 09:06:24 INFO - 'LANG': 'en_US.UTF-8', 09:06:24 INFO - 'LANGUAGE': 'en_US:en', 09:06:24 INFO - 'LOGNAME': 'cltbld', 09:06:24 INFO - 'MAIL': '/var/mail/cltbld', 09:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:24 INFO - 'MOZ_NO_REMOTE': '1', 09:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:24 INFO - 'NO_EM_RESTART': '1', 09:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:24 INFO - 'PWD': '/builds/slave/test', 09:06:24 INFO - 'SHELL': '/bin/bash', 09:06:24 INFO - 'SHLVL': '1', 09:06:24 INFO - 'TERM': 'linux', 09:06:24 INFO - 'TMOUT': '86400', 09:06:24 INFO - 'USER': 'cltbld', 09:06:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:24 INFO - '_': '/tools/buildbot/bin/python'} 09:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 INFO - Cleaning up... 09:06:24 INFO - Return code: 0 09:06:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06:24 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:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 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:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', '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:06:24 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:06:24 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:06:24 INFO - Using env: {'DISPLAY': ':0', 09:06:24 INFO - 'HOME': '/home/cltbld', 09:06:24 INFO - 'LANG': 'en_US.UTF-8', 09:06:24 INFO - 'LANGUAGE': 'en_US:en', 09:06:24 INFO - 'LOGNAME': 'cltbld', 09:06:24 INFO - 'MAIL': '/var/mail/cltbld', 09:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:24 INFO - 'MOZ_NO_REMOTE': '1', 09:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:24 INFO - 'NO_EM_RESTART': '1', 09:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:24 INFO - 'PWD': '/builds/slave/test', 09:06:24 INFO - 'SHELL': '/bin/bash', 09:06:24 INFO - 'SHLVL': '1', 09:06:24 INFO - 'TERM': 'linux', 09:06:24 INFO - 'TMOUT': '86400', 09:06:24 INFO - 'USER': 'cltbld', 09:06:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:24 INFO - '_': '/tools/buildbot/bin/python'} 09:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:24 INFO - Cleaning up... 09:06:24 INFO - Return code: 0 09:06:24 INFO - Running post-action listener: _resource_record_post_action 09:06:24 INFO - Running post-action listener: _start_resource_monitoring 09:06:24 INFO - Starting resource monitoring. 09:06:24 INFO - [mozharness: 2017-04-03 16:06:24.707845Z] Finished create-virtualenv step (success) 09:06:24 INFO - [mozharness: 2017-04-03 16:06:24.708408Z] Running install step. 09:06:24 INFO - Running pre-action listener: _resource_record_pre_action 09:06:24 INFO - Running main action method: install 09:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:24 INFO - Reading from file tmpfile_stdout 09:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:25 INFO - Reading from file tmpfile_stdout 09:06:25 INFO - Output received: 09:06:25 INFO - Usage: mozinstall [options] installer 09:06:25 INFO - Options: 09:06:25 INFO - -h, --help show this help message and exit 09:06:25 INFO - -d DEST, --destination=DEST 09:06:25 INFO - Directory to install application into. [default: 09:06:25 INFO - "/builds/slave/test"] 09:06:25 INFO - --app=APP Application being installed. [default: firefox] 09:06:25 INFO - mkdir: /builds/slave/test/build/application 09:06:25 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:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:06:41 INFO - Reading from file tmpfile_stdout 09:06:41 INFO - Output received: 09:06:41 INFO - /builds/slave/test/build/application/firefox/firefox 09:06:41 INFO - Running post-action listener: _resource_record_post_action 09:06:41 INFO - [mozharness: 2017-04-03 16:06:41.601344Z] Finished install step (success) 09:06:41 INFO - [mozharness: 2017-04-03 16:06:41.601619Z] Running run-tests step. 09:06:41 INFO - Running pre-action listener: _resource_record_pre_action 09:06:41 INFO - Running main action method: run_tests 09:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:41 INFO - Python 2.7.3 09:06:41 INFO - Return code: 0 09:06:41 INFO - grabbing minidump binary from tooltool 09:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:41 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 0xf4c290>, '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 0xf4cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4d040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:41 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:06:41 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:06:41 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:06:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:41 INFO - Return code: 0 09:06:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:06:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:41 INFO - ENV: RUST_BACKTRACE is now 1 09:06:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:06:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:06:41 INFO - Using env: {'DISPLAY': ':0', 09:06:41 INFO - 'HOME': '/home/cltbld', 09:06:41 INFO - 'LANG': 'en_US.UTF-8', 09:06:41 INFO - 'LANGUAGE': 'en_US:en', 09:06:41 INFO - 'LOGNAME': 'cltbld', 09:06:41 INFO - 'MAIL': '/var/mail/cltbld', 09:06:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:41 INFO - 'MOZ_NO_REMOTE': '1', 09:06:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:41 INFO - 'NO_EM_RESTART': '1', 09:06:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:41 INFO - 'PWD': '/builds/slave/test', 09:06:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:41 INFO - 'RUST_BACKTRACE': '1', 09:06:41 INFO - 'SHELL': '/bin/bash', 09:06:41 INFO - 'SHLVL': '1', 09:06:41 INFO - 'TERM': 'linux', 09:06:41 INFO - 'TMOUT': '86400', 09:06:41 INFO - 'USER': 'cltbld', 09:06:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249', 09:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:41 INFO - '_': '/tools/buildbot/bin/python'} 09:06:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:06:41 INFO - mozversion application_buildid: 20170403150256 09:06:41 INFO - mozversion application_changeset: 8dccb2103beea5cae59114efb151a9f6d185a75a 09:06:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:06:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:41 INFO - mozversion application_name: Firefox 09:06:41 INFO - mozversion application_remotingname: firefox-dev 09:06:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:06:41 INFO - mozversion application_vendor: Mozilla 09:06:41 INFO - mozversion application_version: 54.0a2 09:06:41 INFO - mozversion platform_buildid: 20170403150256 09:06:41 INFO - mozversion platform_changeset: 8dccb2103beea5cae59114efb151a9f6d185a75a 09:06:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:06:41 INFO - mozversion platform_version: 54.0a2 09:06:41 INFO - using testdate: 1491235601 09:06:41 INFO - actual date: 1491235601 09:06:41 INFO - starting webserver on 'localhost:58156' 09:06:41 INFO - SUITE-START | Running 2 tests 09:06:41 INFO - TEST-START | dromaeo_css 09:06:41 INFO - operating with platform_type : linux_ 09:06:41 INFO - Initialising browser for dromaeo_css test... 09:06:41 INFO - TEST-INFO | started process 4043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPFKSOF/profile http://localhost:58156/getInfo.html) 09:06:45 INFO - PROCESS | 4043 | __metrics Screen width/height:1600/1200 09:06:45 INFO - PROCESS | 4043 | colorDepth:24 09:06:45 INFO - PROCESS | 4043 | Browser inner width/height: 1024/697 09:06:45 INFO - PROCESS | 4043 | __metrics 09:06:46 INFO - PROCESS | 4043 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:06:46 INFO - PROCESS | 4043 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:47 INFO - TEST-INFO | 4043: exit 0 09:06:47 INFO - Browser initialized. 09:06:47 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:47 INFO - TEST-INFO | started process 4135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPFKSOF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:59 INFO - PROCESS | 4135 | RSS: Main: 139771904 09:06:59 INFO - PROCESS | 4135 | 09:10:00 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:58156/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58156/tests/dromaeo/cssquery-ext.html) 09:10:01 INFO - PROCESS | 4135 | RSS: Main: 276516864 09:10:01 INFO - PROCESS | 4135 | 09:11:49 INFO - PROCESS | 4135 | ************************* 09:11:49 INFO - PROCESS | 4135 | A coding exception was thrown and uncaught in a Task. 09:11:49 INFO - PROCESS | 4135 | 09:11:49 ERROR - PROCESS | 4135 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:11:49 INFO - PROCESS | 4135 | Full stack: 09:11:49 INFO - PROCESS | 4135 | ************************* 09:13:03 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:58156/tests/dromaeo/cssquery-ext.html (next: http://localhost:58156/tests/dromaeo/cssquery-jquery.html) 09:13:04 INFO - PROCESS | 4135 | RSS: Main: 227590144 09:13:04 INFO - PROCESS | 4135 | 09:16:06 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:58156/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58156/tests/dromaeo/cssquery-mootools.html) 09:16:07 INFO - PROCESS | 4135 | RSS: Main: 192991232 09:16:07 INFO - PROCESS | 4135 | 09:19:08 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:58156/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58156/tests/dromaeo/cssquery-prototype.html) 09:19:09 INFO - PROCESS | 4135 | RSS: Main: 177655808 09:19:09 INFO - PROCESS | 4135 | 09:22:12 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:58156/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58156/tests/dromaeo/cssquery-yui.html) 09:22:12 INFO - PROCESS | 4135 | RSS: Main: 174465024 09:22:12 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:58156/tests/dromaeo/cssquery-yui.html (next: http://localhost:58156/tests/dromaeo/cssquery-dojo.html) 09:25:15 INFO - PROCESS | 4135 | RSS: Main: 267280384 09:25:15 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | __start_tp_report 09:25:15 INFO - PROCESS | 4135 | _x_x_mozilla_page_load 09:25:15 INFO - PROCESS | 4135 | _x_x_mozilla_page_load_details 09:25:15 INFO - PROCESS | 4135 | |i|pagename|runs| 09:25:15 INFO - PROCESS | 4135 | |0;dojo.html;3384.6784555467225;3411.4712219605954;3424.8116353600544;3436.31273745251;3463.948040779387;5809.0415081511555;5896.027155519339;5897.587168898179;5901.144334071557;5926.436988486098;5918.082697181933;5967.075103358976;5971.343152253248;5972.820815375535;5984.820455386334;5330.946690533094;5358.089124848785;5360.892782144355;5427.104527752916;5443;5169.3279873616375;5203.0114278287;5456.536194423479;5461.890762184754;5464.7540860661165;5306.151015837467;5346.759395827177;5412.864678383033;5420.566354691635;5429.728513574325;5437.510624043815;5443.537299329542;5448.101063324547;5451.073317536028;5452;5184.559312458446;5302.09864323066;5349.117395629716;5383.515483606494;5447.727613619303;5711.971440142815;5727.398623144593;5746.224259724967;5779.017567013576;5822.82531524055;6261.937380626181;6267.341929097471;6268.968655156741;6290.056491526262;6292.937070629281;6331.2085989251345;6338.683065846735;6343.651099189543;6345.746170153188;6348.9365106348805;5693.430656934315;5736.799212027559;5814.360420353758;5865.736041878125;5881.2942446906645;6470.061841033118;6478.060681201294;6479.740810367627;6480.740770369132;6484.157059582319;6144.139820425144;6155.076738489173;6204.410580994799;6211.65835879031;6235.781747638811;6104.4200800923845;6109.929007496936;6148.1392605035335;6319.24169099711;6323.462505686976;6288.874222515524;6299.716512756937;6312.621242725451;6313.273973493107;6319.9368006320265;6056.545759068087;6112.633242005494;6115.449609535163;6162.753489860445;6330.68346582669;4739.265413860857;4775.21209000511;4780.139574876486;4789.281607758864;4795.520447955177;4145.585441455831;4251.532331443539;4271.231178387858;4281.486221653359;4284.293091639907;6022.849428764228;6070.484008859296;6071;6143.784967526115;6145.26256849172;6343.080253363237;6378.075179099097;6387.393197646309;6389.424951754364;6404.807855764335;6128.693565321716;6137.478314343241;6145.4161854623735;6153.753849845956;6156.753729850845;5216.113260745682;5270.947290527122;5295;5367.919481207785;5434.83695489136;6588.242352129375;6649.235337936199;6649.335066493312;6654.6672666366485;6659.933400666028;6342.175517182736;6343.90484142729;6387.808365749035;6396.936030639634;6410.358964103552;6323.525735569942;6352.142460767737;6507.446867016357;6628.933710662832;6631.701573429304;6225.719842607185;6249.937500624936;6258.374162583706;6263.091851681572;6266.811995640138;6352.9047064295;6355.396237357444;6371.13989611415;6379.298277189413;6384.265809431789;5948.702564871653;5985.670788106696;6150.600210986271;6151.0773383992755;6214.471769899609;6124.846878827887;6125.449118208347;6232.8130156095385;6240.219972503437;6248.875022499616;6225.906611400742;6231.314555398993;6235.127082208403;6244.125822384779;6244.125822384961;5976.551758618208;6001.849953751192;6053.485453736305;6138.572327483795;6271.717772700331;6069.787557435468;6104.298005729221;6111.052786818051;6130.570860039755;6141.385861413823 09:25:15 INFO - PROCESS | 4135 | |1;ext.html;757.7272182014474;828.3869936247177;846.0186184026528;913.867489214064;925.62512182566;31481.05556833293;42870.35694464586;44090;44228;44250.55749442505;45665.54334456663;45902.31146532796;45948;45996;46031.53968460314;7904.604769761518;8006.039275286974;9156.633734650623;9304.255659547254;9305.348625596178;10903.127749780038;11060.612878549253;11095.778084438307;11147.609833655824;11165.609203677874;10768.623098191565;10845.186611004166;10922.235443518917;10928.890711092907;10954.233203675745;10862.945685271603;10890.128789696806;10904.400257985808;10911.945440272748;10912.781744365067;10476.63331783384;10516.369017858953;10520.736981575445;10521.05310522049;10523.736906577396;43212;43321.35017974733;43326;43468.782656086834;43582.78208608968;3428.5542879425766;3451.706604938583;3462.690136564512;3463.255400088993;3507.631698671654;30470.390592188254;30617.387652247053;30626.23434414135;30641.387172256655;30648;4369.1480161368545;4379.824807007716;4468.128714900596;4529.59233668968;4587.105514424688;234307;234515;236166;236453;237316.81341593355;54355.45644543504;54448.72775636097;54468.455315446336;54603.18095228495;54815.45184548183;56684.43315566792;56737;56842.43157568372;56856;56871;15899.125548094966;15907;16036.278367473491;16038.518844434686;16056.27746751399;13184.538541151014;13417.329133543479;13655.317234138254;13855.58433246984;13911.582652520441;13421.328933553283;13449.663758405923;13572.796408053888;13683.24742139172;13695.246761428218;5348.973255133699;5378.704171270618;5394.622376433612;5455.890882182334;5483.698396588226;991.3358050106445;995.85560093786;996.1134590214715;1001.2040427859869;1013.2350075692805;28512.857435713104;28819.279518012216;29038.274043148667;31195.84402077975;31343.84328078345;1173.208084542947;1186.0215322359088;1191.6603767926272;1208.8065909454444;1221.82283568882;13685.589432317047;13707.109037912503;13975.23136227497;14049;14066.156030638194;336511;337642;337997;338229;339045;48972.5102748968;49020.75489622529;49076.50923490719;49184.01631967341;49221.261681074095;1429.9642508937152;1454.120257244373;1485.6211666025094;1486.4351546412295;1506.9020513666576;24028.87985560061;29093;30691.13046754629;30944.69055309418;30981.53527697041;47336.28995565138;47553.76223118862;47568.2864757022;47602.285965711235;47685.52314476811;325178;325423;325977;326123;326803;25300.620490692287;25903.870480647474;28628;29834.701652983193;29920.401591967602;39214.80392598019;39447.408288876264;39459.60540394674;39531.20937581175;39660.80169599134;31006;31408.214794629403;31502.21244468815;31647.36705265928;31933.680663194;30622.387552248383;30813.691863081083;30951.91668291599;31115.533267001465;31488;34982.47526287057;35159.47260791141;35169.47245791366;35752.284954300245;35888.4616730744;29276.56085158767;29481.410371792874;29487;29566.113016609535;30295.545566816956;23388.298351049496;24458.26625201247;24472.388190294674;24689.629655555542;24763.380915477257 09:25:15 INFO - PROCESS | 4135 | |2;jquery.html;441.4261460101867;459.91261660284545;464.93955785747846;465.94408670959467;478.3470562681939;16031.198440078007;16686.58283542912;20482.590348193025;20639.071241794118;21712.3486295411;21111.366659000254;21203.469913252175;22080.22719204828;22614.547709045808;22811;6716.496262780299;6918.827029324257;6945.097137372135;6959.8956015659805;6960.651967401635;5812.418758124175;5960.165576819227;6722.563033402837;6725.092112564815;6731.596104233738;6759.32406759325;6800.931990680079;6803.421709154703;6812.386885180333;6815.863682726343;6636.236832764245;6640.435562977153;6686.531942764009;6690.765823196213;6750.8312292192595;6578.736850525973;6582.6050436973455;7073.964630176868;7361.889571656376;7415.88876166858;24812.627810582857;25022.624660630107;25175.87412062946;25190.874045629836;25496.490070198677;2791.232411086947;2843.1896909380935;2847.117393607988;2920.897768578111;2937.221636266391;15923.203839807964;16126.113063781488;16220.10789406582;16265.756013659804;16988.49034528966;2264;2323.0591610397814;2360.24472168906;2361.126383238213;2479;72679.63660181718;93353;122572.38713806463;122698.38650806778;126329.99999999908;16813.61964171478;16986.915065424593;17528.737068943978;18334;18430.35493757712;31431.799774016057;31537.36925261482;31565.526517102262;31579.684203157674;31581.684183158333;10543;10596.576136954589;10623.150147988143;10669.19981001428;10844.349339039683;8880.467171969702;8885.822283554293;8907.910920890708;9081.954590227007;9086.318526110568;9290.953545232365;9291.163795258459;9450.149486546245;9571.569279382444;9598.856017159747;3453.015890471204;3517.296540691872;3561.7684850484634;3646.4712616670436;3689.4834723138783;922.1746536849482;933.09955892564;941.9670311539063;949.3259785552198;957.4829592020232;19237.230510779413;20855.791442085385;20918.47703807417;20924.89537552333;21191.8940405297;949.3212353167519;956.3926906414338;956.5121787888227;964.9276304277207;967.8451447768323;10959.287646302964;11333.563283894002;11628.302301861915;11631.88368116325;11728.354940478184;658923.1387690816;661624;665620;671863;674609;78283.60858195786;88068.5596572013;99110.5044474773;115922;117892;1360.897932655035;1366.6173471428017;1386.334559411488;1394.28194479845;1412.1033143953664;17940.192691329183;18882;19074.904625476785;19086.427407177805;19120.90439547849;51391.22913156381;52027.47972520226;52057.47942520526;52348;53719.46280537145;68208;68513.31486685069;68586.65706671435;69257.65371173313;69698.30301696918;11012;11763.941180294387;12343.753124937271;12360.44378002974;12536.122471427278;12525.686857828627;13036.804447933098;13064.608061758163;13354.265515396746;13749.450021999008;11944.402779860799;12149.331786751813;12394.256344619353;12416.565420210249;12518.874811252135;11146.164037697366;11178.608748693756;11471.885281147082;11619.709507262387;11770.352630605057;11863.466144023367;12151.270923744603;12152.088593355356;12317.876821231674;12545.87454125447;12233.877661223274;12304.569340073054;12309.630711078682;12330.506779729069;12346.876531234573;11446;11633.53465861356;11701.88298117008;11869.940650296694;12202 09:25:15 INFO - PROCESS | 4135 | |3;mootools.html;1527.679187370652;1556.9377224911004;1568.7253482450442;1572.3867691600271;1599.89600675956;10741.51663175157;11426.600068997586;11438.942805285973;11458.71353216171;11480.196386252945;11040.116790656728;11162.441877906112;11168.832467512973;11211.551537938492;11239.213255072149;2478.541469828083;2512.1458704040624;2515.584928486807;2517.3706573356662;2517.546841568517;2443.3280847766828;2461.520003599299;2501.3871601457668;2503.2615378463397;2503.5618766715843;2440.5851005329137;2454.4232105455203;2459.754024597544;2487.2289590226997;2491.8754062296903;2403.831731778776;2445.4742230420457;2446.2538925627678;2450.105711415338;2474.059857254241;2302.1366987379733;2308.933051893742;2328.918487852934;2335.2760644200184;2337.49743805081;11262;11517.021053210487;11520.596779112691;11524.135689823297;11534.423278836024;5905.143754155623;6068.787592434288;6073.180120683695;6084.847878803021;6089.451949324538;3465.151037995682;3535.7878527288444;3559.537260156163;3681.9079523012138;3730.8321125549146;1327.5287273018132;1338.9397477113553;1358.5516779462753;1385.411200239894;1395.9720805583934;16536.338546458126;16552;16776.245068971926;16983.405580804738;17542.47372578812;4689.226277664147;4748.6438517111355;4825.758712064383;4849.321095046696;4852.0295940811975;12469.812952805714;12492.437840297209;12495.312757798227;12496.375181241083;12519.3740312984;5967.31375891778;5968.880622387528;5976.342602313742;5976.7908123215475;5978.641281523122;5442.863928401822;5594.552435805207;5595;5621.016322143691;5625.353084395347;3973.5827738087664;4040.959590404117;4091.6522095622204;4108.63022327986;4119.8352065917625;1051.695008447557;1054.699410667956;1057.709129989259;1064.377339256528;1066.7386490309923;1085.8968398002178;1110.3967625056744;1111.2499063132354;1115.6653004098737;1119.7312644965314;7301.598412087386;7318.194998550155;7375.520591161558;7385.926140738631;7462.96268518654;1059.9523021464054;1066.9626563070256;1077.9083777878811;1103.0954617213968;1119.4346854838254;4579.107074120581;4726.078414709167;4872.610191184696;4901.387326584177;4973.825916092919;14305.28473576317;14472.565823025327;14828.481003164838;14898.031627944149;14935.402583896739;14448.277586120652;14578.927105364617;14717.969742118163;14728.779068313985;14741.631459213606;10577.735556610993;10811.135109191246;10892.292001019909;10902.672919812418;10911.127109831354;7252.093488313961;7267.091613548307;7508.361789247975;7523.285287897641;7573.129090154703;12733.490660373482;13117;13187.53843615469;13212.933935330646;13234.536791212262;13382.397792099184;13405.463781448632;13425.597232083053;13425.798613020617;13523;9367.484788336707;9442.716718498456;9453.24374050088;9583.616655333988;9601.90398096038;10903.781924361627;10910.454477276264;11032.613858514913;11042;11043.723906902393;9167.220786233245;9308.48803315824;9360.906390936003;9404.529773511435;9524.428534287965;9103.135202155785;9119.407238529475;9153.725388238363;9233.538323083952;9325.347225694137;8312.875306870523;8416.915830841614;8503.404761666625;8516.40385173032;8529.275011624082;6325.399087086719;6328.240611126695;6413.454856337264;6418.550701450854;6543.607383557001;6411.583247089111;6443.09796628463;6535.673216339259;6673.733050677918;6692.130023096966 09:25:15 INFO - PROCESS | 4135 | |4;prototype.html;384.28331162382165;417.2885230681688;421.54894263138436;428.824182085345;437.5755517148365;5170.79316827327;5270.841874743759;5277.15565509519;5286.233496143057;5331.614424840225;5000.674956127849;5177.430482646906;5183.60473889602;5185.637005409623;5213.973930130344;4421.9336709949375;4429.490608580006;4434.889127771816;4438.267685831834;4459.130469558438;4232.936505952413;4330.653547716175;4338.349247612852;4352.499462561798;4454.97772511137;4334.804933777988;4375.321825117096;4408;4433.623142032931;4447.755373454459;4372.956270437287;4383.3424986252;4388.561143885602;4406.889827754299;4410.1179764047;3983.7609743415196;4141.7100802943805;4178.289690752549;4199.91600167998;4216.9578304216875;5095.8980820383385;5102.617303702237;5110.821121260775;5113.897722045575;5122.871928201787;5065.696058236481;5067.505085999639;5116.897662046776;5160.845174644766;5161.458046905059;5314.229436731691;5438.464997751454;5465.699386533739;5482.643628164196;5504.284443022381;4549.772511374418;4561.9927232018135;4568.70303430276;4571.794269257858;4587.8623641290815;5746.310442746855;5751.884962300773;5761.48146666802;5766.163906233573;5832.737526811304;4670.346151538787;4685.906281874411;4688.624910007191;4711.882202944886;4759.38128043359;4559.349463547163;4797.56821886032;4814.133455977958;4816.397950256218;4846;4901.3383193269165;4949.653524253267;4991.326170966946;5049.899002019939;5057.190849464068;5457.553748256715;5486.91769623456;5496.093144631171;5512.173174023848;5518.503334699896;1562.734335163025;1603.8556529912364;1636.378176293001;1637.656092220647;1656.3540219314477;1244.2223610243598;1269.4858582274194;1274.751423472414;1279.0087682046487;1295.3846922711637;5419.349678038582;5445.576718360292;5469.699166545878;5475.342958844884;5482.835514934558;5545.833624991256;5619.438056194348;5636.577256705764;5658;5686.947914635805;5160.716160611128;5433.673979561239;5448.264484294569;5457.945420545823;5485.698286594195;2981.508051171576;2987.2979849735293;2989.342344684166;2989.5814585957983;2993.6407631084408;5697.629654072555;5891.499222566044;5891.675957822361;5930.169776231331;5947.881042379215;5749.252597162342;5789.884202316014;5802.593818432669;5822.912656310159;5879.735411906475;5848.736806843703;5868.413158684098;5882.49998750111;5944.613600115978;5983.461488466059;5430.8099216527235;5678.375378708256;5718.828435146952;5728.742206600797;5777.45114214149;5622.85942851432;5657.32112146545;5666.235058267246;5690.800821971211;5691;5756.812411283853;5931.851703707442;5996.340402555628;5997.790077347272;6019.508684962623;4730.172219861579;4747.691400058985;4768.356271903249;4770.880727981828;4772.5227477252;5499.367572729027;5502.504774570308;5609.868250064949;5689.800856969986;5693.4021927696995;5537.446255374431;5548.778048878161;5582.637128586629;5587.972060139673;5613.915791263216;5318.361796584435;5552.444755524577;5555.333359996826;5595.63628364155;5597.524210441995;5479.972600137134;5536.52939500147;5546.696526316232;5560.805371811967;5610.635308704921;5504.697241651747;5553.333999799963;5591.552675786009;5598.888022239451;5635;5281.339832520935;5427.240186373831;5429.918551221655;5474.3704473986;5512.586556008235 09:25:15 INFO - PROCESS | 4135 | |5;yui.html;852.9232369086781;865.6061492021131;914.1452741686521;915.1534830281989;928.9117533834287;16549.089800060992;16759.581010474743;17668.116594170304;17736.379226727066;18270;16248.83751162488;16757.24592393342;16941;17041.82958170421;17109.40117095902;877.4121338703052;892.6518657723477;903.7966457547066;905.443152461235;908.0420156734642;892.4600616626944;892.937494375394;894.9731508054768;896.0546623312403;896.1934259166769;953.0945601678399;954.0793134625086;954.3081266082104;954.7613096725819;955.0544960489135;937.5921474158763;946.857971304303;953.4946478366477;954.5847556312991;955.1976339874504;690.1338819781192;694.5277211496181;699.8040548646336;699.8215455058927;701.4738945790657;17327.133643317782;17443.21505532254;17610.735838962424;17704.468865933915;17718.822811771846;16072.196390180445;16128.274227659665;16357.59106022347;16398.26207820651;16457.506274811774;13961.79057314141;14257.78613320801;14428.153663429577;14491.71016579673;14562.98059135861;4005.2790497710403;4031;4112.588741125894;4124.340105583123;4127.009517715756;93595;93600;93770;94404;95954;11521.423928803526;11688.94155529217;11790.292582445081;11826.172167948333;11860.169788114748;21399.25102621401;21954.89022554877;21993.34019979403;23904.16335428252;24111.51776964486;8846.15961483658;9080.772980675403;9273.397229180082;9283.303752218611;9344.2524598032;5240.633155679066;5275.788968441296;5310.946890531045;5383.353997520244;5421.430749771296;3670.2659468106485;3757.267332870119;3758.6805121564425;3771.26460340231;3785.167263202091;661.8146918862726;664.3987191591617;671.1208317104608;674.7031306225246;684.5721424109931;846.8772028055897;852.5311078906576;874.5364956573027;884.3720958119678;891.9152680495342;10749.659064892183;10889.673309800719;11228.943855280671;11467;12120.939395303143;830.7217082277384;831.9584020798936;851.1871163039283;854.4958474500074;892.2326798952895;5167.302414174038;5254.343207099113;5299.284596579412;5346.8395948121615;5363;70776;82844.58577707193;83503.6598536064;84259.57870210732;86029;69128;70040.6497967517;70431.64784176047;71615;72685;57108.42891571197;65783.34216657867;66877.66561167261;67122;67402.66298668475;11636.41817909118;11903.642890713292;11965.401729913296;12169.756604868031;12236;37491.43762843505;38749.41875871921;40270;41396.793016034724;42703.145937080466;56354;56754.43245567491;56767;56971.71514142403;58133;13549.79675304891;13727.450901964208;13735.931320343334;14227.715445690821;14728.484503042342;16656.50030499087;16672.916635416746;16838.831611683727;18273;18286.725699114257;16411.521078721253;16844.25199875903;17045.318187272867;17156.39952601653;17951.640967180843;14408.351624176728;15292;15352.539423817303;15940.840591593935;15952;16191.67616647684;16370.181490925168;16980.915095424443;17358.479245622653;17432.477025689248;11449.370284634091;11592.246503977214;11754.118441117122;11863.584774533196;12207.45066471993;12383.380830958236;12461.75076498483;12777.425015874122;12783.424745886272;12827.55103571408 09:25:15 INFO - PROCESS | 4135 | __end_tp_report 09:25:15 INFO - PROCESS | 4135 | __start_cc_report 09:25:15 INFO - PROCESS | 4135 | _x_x_mozilla_cycle_collect,1328 09:25:15 INFO - PROCESS | 4135 | __end_cc_report 09:25:15 INFO - PROCESS | 4135 | __startTimestamp1491236715916__endTimestamp 09:25:15 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | ------- Summary: start ------- 09:25:15 INFO - PROCESS | 4135 | Number of tests: 6 09:25:15 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | [#0] dojo.html Cycles:165 Average:5863.02 Median:6125.45 stddev:678.95 (11.1%) stddev-sans-first:652.60 09:25:15 INFO - PROCESS | 4135 | Values: 3384.7 3411.5 3424.8 3436.3 3463.9 5809.0 5896.0 5897.6 5901.1 5926.4 5918.1 5967.1 5971.3 5972.8 5984.8 5330.9 5358.1 5360.9 5427.1 5443.0 5169.3 5203.0 5456.5 5461.9 5464.8 5306.2 5346.8 5412.9 5420.6 5429.7 5437.5 5443.5 5448.1 5451.1 5452.0 5184.6 5302.1 5349.1 5383.5 5447.7 5712.0 5727.4 5746.2 5779.0 5822.8 6261.9 6267.3 6269.0 6290.1 6292.9 6331.2 6338.7 6343.7 6345.7 6348.9 5693.4 5736.8 5814.4 5865.7 5881.3 6470.1 6478.1 6479.7 6480.7 6484.2 6144.1 6155.1 6204.4 6211.7 6235.8 6104.4 6109.9 6148.1 6319.2 6323.5 6288.9 6299.7 6312.6 6313.3 6319.9 6056.5 6112.6 6115.4 6162.8 6330.7 4739.3 4775.2 4780.1 4789.3 4795.5 4145.6 4251.5 4271.2 4281.5 4284.3 6022.8 6070.5 6071.0 6143.8 6145.3 6343.1 6378.1 6387.4 6389.4 6404.8 6128.7 6137.5 6145.4 6153.8 6156.8 5216.1 5270.9 5295.0 5367.9 5434.8 6588.2 6649.2 6649.3 6654.7 6659.9 6342.2 6343.9 6387.8 6396.9 6410.4 6323.5 6352.1 6507.4 6628.9 6631.7 6225.7 6249.9 6258.4 6263.1 6266.8 6352.9 6355.4 6371.1 6379.3 6384.3 5948.7 5985.7 6150.6 6151.1 6214.5 6124.8 6125.4 6232.8 6240.2 6248.9 6225.9 6231.3 6235.1 6244.1 6244.1 5976.6 6001.8 6053.5 6138.6 6271.7 6069.8 6104.3 6111.1 6130.6 6141.4 09:25:15 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | [#1] ext.html Cycles:180 Average:46499.65 Median:31269.84 stddev:79426.73 (254.0%) stddev-sans-first:79575.29 09:25:15 INFO - PROCESS | 4135 | Values: 757.7 828.4 846.0 913.9 925.6 31481.1 42870.4 44090.0 44228.0 44250.6 45665.5 45902.3 45948.0 45996.0 46031.5 7904.6 8006.0 9156.6 9304.3 9305.3 10903.1 11060.6 11095.8 11147.6 11165.6 10768.6 10845.2 10922.2 10928.9 10954.2 10862.9 10890.1 10904.4 10911.9 10912.8 10476.6 10516.4 10520.7 10521.1 10523.7 43212.0 43321.4 43326.0 43468.8 43582.8 3428.6 3451.7 3462.7 3463.3 3507.6 30470.4 30617.4 30626.2 30641.4 30648.0 4369.1 4379.8 4468.1 4529.6 4587.1 234307.0 234515.0 236166.0 236453.0 237316.8 54355.5 54448.7 54468.5 54603.2 54815.5 56684.4 56737.0 56842.4 56856.0 56871.0 15899.1 15907.0 16036.3 16038.5 16056.3 13184.5 13417.3 13655.3 13855.6 13911.6 13421.3 13449.7 13572.8 13683.2 13695.2 5349.0 5378.7 5394.6 5455.9 5483.7 991.3 995.9 996.1 1001.2 1013.2 28512.9 28819.3 29038.3 31195.8 31343.8 1173.2 1186.0 1191.7 1208.8 1221.8 13685.6 13707.1 13975.2 14049.0 14066.2 336511.0 337642.0 337997.0 338229.0 339045.0 48972.5 49020.8 49076.5 49184.0 49221.3 1430.0 1454.1 1485.6 1486.4 1506.9 24028.9 29093.0 30691.1 30944.7 30981.5 47336.3 47553.8 47568.3 47602.3 47685.5 325178.0 325423.0 325977.0 326123.0 326803.0 25300.6 25903.9 28628.0 29834.7 29920.4 39214.8 39447.4 39459.6 39531.2 39660.8 31006.0 31408.2 31502.2 31647.4 31933.7 30622.4 30813.7 30951.9 31115.5 31488.0 34982.5 35159.5 35169.5 35752.3 35888.5 29276.6 29481.4 29487.0 29566.1 30295.5 23388.3 24458.3 24472.4 24689.6 24763.4 09:25:15 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | [#2] jquery.html Cycles:180 Average:37171.84 Median:24917.63 stddev:109569.32 (439.7%) stddev-sans-first:109841.98 09:25:15 INFO - PROCESS | 4135 | Values: 441.4 459.9 464.9 465.9 478.3 16031.2 16686.6 20482.6 20639.1 21712.3 21111.4 21203.5 22080.2 22614.5 22811.0 6716.5 6918.8 6945.1 6959.9 6960.7 5812.4 5960.2 6722.6 6725.1 6731.6 6759.3 6800.9 6803.4 6812.4 6815.9 6636.2 6640.4 6686.5 6690.8 6750.8 6578.7 6582.6 7074.0 7361.9 7415.9 24812.6 25022.6 25175.9 25190.9 25496.5 2791.2 2843.2 2847.1 2920.9 2937.2 15923.2 16126.1 16220.1 16265.8 16988.5 2264.0 2323.1 2360.2 2361.1 2479.0 72679.6 93353.0 122572.4 122698.4 126330.0 16813.6 16986.9 17528.7 18334.0 18430.4 31431.8 31537.4 31565.5 31579.7 31581.7 10543.0 10596.6 10623.2 10669.2 10844.3 8880.5 8885.8 8907.9 9082.0 9086.3 9291.0 9291.2 9450.1 9571.6 9598.9 3453.0 3517.3 3561.8 3646.5 3689.5 922.2 933.1 942.0 949.3 957.5 19237.2 20855.8 20918.5 20924.9 21191.9 949.3 956.4 956.5 964.9 967.8 10959.3 11333.6 11628.3 11631.9 11728.4 658923.1 661624.0 665620.0 671863.0 674609.0 78283.6 88068.6 99110.5 115922.0 117892.0 1360.9 1366.6 1386.3 1394.3 1412.1 17940.2 18882.0 19074.9 19086.4 19120.9 51391.2 52027.5 52057.5 52348.0 53719.5 68208.0 68513.3 68586.7 69257.7 69698.3 11012.0 11763.9 12343.8 12360.4 12536.1 12525.7 13036.8 13064.6 13354.3 13749.5 11944.4 12149.3 12394.3 12416.6 12518.9 11146.2 11178.6 11471.9 11619.7 11770.4 11863.5 12151.3 12152.1 12317.9 12545.9 12233.9 12304.6 12309.6 12330.5 12346.9 11446.0 11633.5 11701.9 11869.9 12202.0 09:25:15 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | [#3] mootools.html Cycles:180 Average:7180.08 Median:2452.26 stddev:4524.94 (184.5%) stddev-sans-first:4517.70 09:25:15 INFO - PROCESS | 4135 | Values: 1527.7 1556.9 1568.7 1572.4 1599.9 10741.5 11426.6 11438.9 11458.7 11480.2 11040.1 11162.4 11168.8 11211.6 11239.2 2478.5 2512.1 2515.6 2517.4 2517.5 2443.3 2461.5 2501.4 2503.3 2503.6 2440.6 2454.4 2459.8 2487.2 2491.9 2403.8 2445.5 2446.3 2450.1 2474.1 2302.1 2308.9 2328.9 2335.3 2337.5 11262.0 11517.0 11520.6 11524.1 11534.4 5905.1 6068.8 6073.2 6084.8 6089.5 3465.2 3535.8 3559.5 3681.9 3730.8 1327.5 1338.9 1358.6 1385.4 1396.0 16536.3 16552.0 16776.2 16983.4 17542.5 4689.2 4748.6 4825.8 4849.3 4852.0 12469.8 12492.4 12495.3 12496.4 12519.4 5967.3 5968.9 5976.3 5976.8 5978.6 5442.9 5594.6 5595.0 5621.0 5625.4 3973.6 4041.0 4091.7 4108.6 4119.8 1051.7 1054.7 1057.7 1064.4 1066.7 1085.9 1110.4 1111.2 1115.7 1119.7 7301.6 7318.2 7375.5 7385.9 7463.0 1060.0 1067.0 1077.9 1103.1 1119.4 4579.1 4726.1 4872.6 4901.4 4973.8 14305.3 14472.6 14828.5 14898.0 14935.4 14448.3 14578.9 14718.0 14728.8 14741.6 10577.7 10811.1 10892.3 10902.7 10911.1 7252.1 7267.1 7508.4 7523.3 7573.1 12733.5 13117.0 13187.5 13212.9 13234.5 13382.4 13405.5 13425.6 13425.8 13523.0 9367.5 9442.7 9453.2 9583.6 9601.9 10903.8 10910.5 11032.6 11042.0 11043.7 9167.2 9308.5 9360.9 9404.5 9524.4 9103.1 9119.4 9153.7 9233.5 9325.3 8312.9 8416.9 8503.4 8516.4 8529.3 6325.4 6328.2 6413.5 6418.6 6543.6 6411.6 6443.1 6535.7 6673.7 6692.1 09:25:15 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | [#4] prototype.html Cycles:180 Average:4826.09 Median:5300.23 stddev:1291.44 (24.4%) stddev-sans-first:1251.29 09:25:15 INFO - PROCESS | 4135 | Values: 384.3 417.3 421.5 428.8 437.6 5170.8 5270.8 5277.2 5286.2 5331.6 5000.7 5177.4 5183.6 5185.6 5214.0 4421.9 4429.5 4434.9 4438.3 4459.1 4232.9 4330.7 4338.3 4352.5 4455.0 4334.8 4375.3 4408.0 4433.6 4447.8 4373.0 4383.3 4388.6 4406.9 4410.1 3983.8 4141.7 4178.3 4199.9 4217.0 5095.9 5102.6 5110.8 5113.9 5122.9 5065.7 5067.5 5116.9 5160.8 5161.5 5314.2 5438.5 5465.7 5482.6 5504.3 4549.8 4562.0 4568.7 4571.8 4587.9 5746.3 5751.9 5761.5 5766.2 5832.7 4670.3 4685.9 4688.6 4711.9 4759.4 4559.3 4797.6 4814.1 4816.4 4846.0 4901.3 4949.7 4991.3 5049.9 5057.2 5457.6 5486.9 5496.1 5512.2 5518.5 1562.7 1603.9 1636.4 1637.7 1656.4 1244.2 1269.5 1274.8 1279.0 1295.4 5419.3 5445.6 5469.7 5475.3 5482.8 5545.8 5619.4 5636.6 5658.0 5686.9 5160.7 5433.7 5448.3 5457.9 5485.7 2981.5 2987.3 2989.3 2989.6 2993.6 5697.6 5891.5 5891.7 5930.2 5947.9 5749.3 5789.9 5802.6 5822.9 5879.7 5848.7 5868.4 5882.5 5944.6 5983.5 5430.8 5678.4 5718.8 5728.7 5777.5 5622.9 5657.3 5666.2 5690.8 5691.0 5756.8 5931.9 5996.3 5997.8 6019.5 4730.2 4747.7 4768.4 4770.9 4772.5 5499.4 5502.5 5609.9 5689.8 5693.4 5537.4 5548.8 5582.6 5588.0 5613.9 5318.4 5552.4 5555.3 5595.6 5597.5 5480.0 5536.5 5546.7 5560.8 5610.6 5504.7 5553.3 5591.6 5598.9 5635.0 5281.3 5427.2 5429.9 5474.4 5512.6 09:25:15 INFO - PROCESS | 4135 | 09:25:15 INFO - PROCESS | 4135 | [#5] yui.html Cycles:180 Average:19138.17 Median:4118.46 stddev:23954.72 (581.6%) stddev-sans-first:23982.57 09:25:15 INFO - PROCESS | 4135 | Values: 852.9 865.6 914.1 915.2 928.9 16549.1 16759.6 17668.1 17736.4 18270.0 16248.8 16757.2 16941.0 17041.8 17109.4 877.4 892.7 903.8 905.4 908.0 892.5 892.9 895.0 896.1 896.2 953.1 954.1 954.3 954.8 955.1 937.6 946.9 953.5 954.6 955.2 690.1 694.5 699.8 699.8 701.5 17327.1 17443.2 17610.7 17704.5 17718.8 16072.2 16128.3 16357.6 16398.3 16457.5 13961.8 14257.8 14428.2 14491.7 14563.0 4005.3 4031.0 4112.6 4124.3 4127.0 93595.0 93600.0 93770.0 94404.0 95954.0 11521.4 11688.9 11790.3 11826.2 11860.2 21399.3 21954.9 21993.3 23904.2 24111.5 8846.2 9080.8 9273.4 9283.3 9344.3 5240.6 5275.8 5310.9 5383.4 5421.4 3670.3 3757.3 3758.7 3771.3 3785.2 661.8 664.4 671.1 674.7 684.6 846.9 852.5 874.5 884.4 891.9 10749.7 10889.7 11228.9 11467.0 12120.9 830.7 832.0 851.2 854.5 892.2 5167.3 5254.3 5299.3 5346.8 5363.0 70776.0 82844.6 83503.7 84259.6 86029.0 69128.0 70040.6 70431.6 71615.0 72685.0 57108.4 65783.3 66877.7 67122.0 67402.7 11636.4 11903.6 11965.4 12169.8 12236.0 37491.4 38749.4 40270.0 41396.8 42703.1 56354.0 56754.4 56767.0 56971.7 58133.0 13549.8 13727.5 13735.9 14227.7 14728.5 16656.5 16672.9 16838.8 18273.0 18286.7 16411.5 16844.3 17045.3 17156.4 17951.6 14408.4 15292.0 15352.5 15940.8 15952.0 16191.7 16370.2 16980.9 17358.5 17432.5 11449.4 11592.2 11754.1 11863.6 12207.5 12383.4 12461.8 12777.4 12783.4 12827.6 09:25:15 INFO - PROCESS | 4135 | -------- Summary: end -------- 09:25:15 INFO - PROCESS | 4135 | 09:25:16 INFO - TEST-INFO | 4135: exit 0 09:25:16 INFO - TEST-OK | dromaeo_css | took 1114843ms 09:25:16 INFO - TEST-START | kraken 09:25:16 INFO - operating with platform_type : linux_ 09:25:16 INFO - Initialising browser for kraken test... 09:25:16 INFO - TEST-INFO | started process 4465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW5PUcM/profile http://localhost:58156/getInfo.html) 09:25:20 INFO - PROCESS | 4465 | __metrics Screen width/height:1600/1200 09:25:20 INFO - PROCESS | 4465 | colorDepth:24 09:25:20 INFO - PROCESS | 4465 | Browser inner width/height: 1024/697 09:25:20 INFO - PROCESS | 4465 | __metrics 09:25:20 INFO - PROCESS | 4465 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:25:20 INFO - PROCESS | 4465 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:21 INFO - TEST-INFO | 4465: exit 0 09:25:21 INFO - Browser initialized. 09:25:21 INFO - Running cycle 1/1 for kraken test... 09:25:21 INFO - TEST-INFO | started process 4556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW5PUcM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:33 INFO - PROCESS | 4556 | RSS: Main: 139722752 09:25:33 INFO - PROCESS | 4556 | 09:25:36 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58156/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:36 INFO - PROCESS | 4556 | RSS: Main: 183713792 09:25:36 INFO - PROCESS | 4556 | 09:25:39 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58156/tests/kraken/driver.html?testName=audio-dft) 09:25:40 INFO - PROCESS | 4556 | RSS: Main: 174112768 09:25:40 INFO - PROCESS | 4556 | 09:25:42 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58156/tests/kraken/driver.html?testName=audio-fft) 09:25:43 INFO - PROCESS | 4556 | RSS: Main: 265240576 09:25:43 INFO - PROCESS | 4556 | 09:25:45 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58156/tests/kraken/driver.html?testName=audio-oscillator) 09:25:46 INFO - PROCESS | 4556 | RSS: Main: 171732992 09:25:46 INFO - PROCESS | 4556 | 09:25:48 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58156/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:48 INFO - PROCESS | 4556 | RSS: Main: 174526464 09:25:48 INFO - PROCESS | 4556 | 09:25:51 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58156/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:52 INFO - PROCESS | 4556 | RSS: Main: 212803584 09:25:52 INFO - PROCESS | 4556 | 09:25:55 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58156/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:56 INFO - PROCESS | 4556 | RSS: Main: 211296256 09:25:56 INFO - PROCESS | 4556 | 09:25:59 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58156/tests/kraken/driver.html?testName=json-parse-financial) 09:25:59 INFO - PROCESS | 4556 | RSS: Main: 210886656 09:25:59 INFO - PROCESS | 4556 | 09:26:01 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58156/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:01 INFO - PROCESS | 4556 | RSS: Main: 172990464 09:26:01 INFO - PROCESS | 4556 | 09:26:03 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58156/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:04 INFO - PROCESS | 4556 | RSS: Main: 180002816 09:26:04 INFO - PROCESS | 4556 | 09:26:06 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58156/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:06 INFO - PROCESS | 4556 | RSS: Main: 188747776 09:26:06 INFO - PROCESS | 4556 | 09:26:09 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:09 INFO - PROCESS | 4556 | RSS: Main: 198107136 09:26:09 INFO - PROCESS | 4556 | 09:26:12 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:13 INFO - PROCESS | 4556 | RSS: Main: 194273280 09:26:13 INFO - PROCESS | 4556 | 09:26:14 INFO - PROCESS | 4556 | Cycle 1(1): loaded http://localhost:58156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58156/tests/kraken/driver.html?testName=ai-astar) 09:26:15 INFO - PROCESS | 4556 | RSS: Main: 245256192 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | __start_tp_report 09:26:15 INFO - PROCESS | 4556 | _x_x_mozilla_page_load 09:26:15 INFO - PROCESS | 4556 | _x_x_mozilla_page_load_details 09:26:15 INFO - PROCESS | 4556 | |i|pagename|runs| 09:26:15 INFO - PROCESS | 4556 | |0;ai-astar;104;115;113;112;115;113;113;113;112;113 09:26:15 INFO - PROCESS | 4556 | |1;audio-beat-detection;143;115;116;151;122;116;115;114;136;115 09:26:15 INFO - PROCESS | 4556 | |2;audio-dft;161;162;162;164;163;164;161;161;162;162 09:26:15 INFO - PROCESS | 4556 | |3;audio-fft;75;75;75;113;75;75;75;75;90;75 09:26:15 INFO - PROCESS | 4556 | |4;audio-oscillator;83;81;103;82;82;82;94;83;82;103 09:26:15 INFO - PROCESS | 4556 | |5;imaging-gaussian-blur;113;112;113;113;114;113;114;113;113;113 09:26:15 INFO - PROCESS | 4556 | |6;imaging-darkroom;146;147;146;146;146;147;146;146;146;146 09:26:15 INFO - PROCESS | 4556 | |7;imaging-desaturate;95;94;93;94;94;94;93;94;93;94 09:26:15 INFO - PROCESS | 4556 | |8;json-parse-financial;54;53;53;54;53;54;54;53;53;53 09:26:15 INFO - PROCESS | 4556 | |9;json-stringify-tinderbox;54;54;54;53;54;54;53;53;53;53 09:26:15 INFO - PROCESS | 4556 | |10;stanford-crypto-aes;76;76;76;76;74;81;79;76;75;80 09:26:15 INFO - PROCESS | 4556 | |11;stanford-crypto-ccm;121;138;130;129;123;118;121;126;163;139 09:26:15 INFO - PROCESS | 4556 | |12;stanford-crypto-pbkdf2;168;164;165;161;159;163;161;164;166;163 09:26:15 INFO - PROCESS | 4556 | |13;stanford-crypto-sha256-iterative;62;61;60;61;61;60;63;60;59;58 09:26:15 INFO - PROCESS | 4556 | __end_tp_report 09:26:15 INFO - PROCESS | 4556 | __start_cc_report 09:26:15 INFO - PROCESS | 4556 | _x_x_mozilla_cycle_collect,1676 09:26:15 INFO - PROCESS | 4556 | __end_cc_report 09:26:15 INFO - PROCESS | 4556 | __startTimestamp1491236775229__endTimestamp 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | ------- Summary: start ------- 09:26:15 INFO - PROCESS | 4556 | Number of tests: 14 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.09 (2.7%) stddev-sans-first:1.09 09:26:15 INFO - PROCESS | 4556 | Values: 104.0 115.0 113.0 112.0 115.0 113.0 113.0 113.0 112.0 113.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:119.00 stddev:13.78 (11.6%) stddev-sans-first:12.84 09:26:15 INFO - PROCESS | 4556 | Values: 143.0 115.0 116.0 151.0 122.0 116.0 115.0 114.0 136.0 115.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 09:26:15 INFO - PROCESS | 4556 | Values: 161.0 162.0 162.0 164.0 163.0 164.0 161.0 161.0 162.0 162.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:12.42 (16.6%) stddev-sans-first:13.02 09:26:15 INFO - PROCESS | 4556 | Values: 75.0 75.0 75.0 113.0 75.0 75.0 75.0 75.0 90.0 75.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:82.00 stddev:8.98 (11.0%) stddev-sans-first:9.38 09:26:15 INFO - PROCESS | 4556 | Values: 83.0 81.0 103.0 82.0 82.0 82.0 94.0 83.0 82.0 103.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:26:15 INFO - PROCESS | 4556 | Values: 113.0 112.0 113.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 09:26:15 INFO - PROCESS | 4556 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 09:26:15 INFO - PROCESS | 4556 | Values: 95.0 94.0 93.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.50 09:26:15 INFO - PROCESS | 4556 | Values: 54.0 53.0 53.0 54.0 53.0 54.0 54.0 53.0 53.0 53.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:54.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 09:26:15 INFO - PROCESS | 4556 | Values: 54.0 54.0 54.0 53.0 54.0 54.0 53.0 53.0 53.0 53.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.00 stddev:2.28 (3.0%) stddev-sans-first:2.40 09:26:15 INFO - PROCESS | 4556 | Values: 76.0 76.0 76.0 76.0 74.0 81.0 79.0 76.0 75.0 80.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:129.50 stddev:13.33 (10.3%) stddev-sans-first:13.66 09:26:15 INFO - PROCESS | 4556 | Values: 121.0 138.0 130.0 129.0 123.0 118.0 121.0 126.0 163.0 139.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:2.63 (1.6%) stddev-sans-first:2.20 09:26:15 INFO - PROCESS | 4556 | Values: 168.0 164.0 165.0 161.0 159.0 163.0 161.0 164.0 166.0 163.0 09:26:15 INFO - PROCESS | 4556 | 09:26:15 INFO - PROCESS | 4556 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.00 stddev:1.43 (2.4%) stddev-sans-first:1.41 09:26:15 INFO - PROCESS | 4556 | Values: 62.0 61.0 60.0 61.0 61.0 60.0 63.0 60.0 59.0 58.0 09:26:15 INFO - PROCESS | 4556 | -------- Summary: end -------- 09:26:15 INFO - PROCESS | 4556 | 09:26:16 INFO - TEST-INFO | 4556: exit 0 09:26:16 INFO - TEST-OK | kraken | took 59602ms 09:26:16 INFO - SUITE-END | took 1174s 09:26:16 INFO - Completed test suite (00:19:34) 09:26:16 INFO - javascript benchmark 09:26:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7896.308414963122, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.6784555467225, 3411.4712219605954, 3424.8116353600544, 3436.31273745251, 3463.948040779387, 5809.0415081511555, 5896.027155519339, 5897.587168898179, 5901.144334071557, 5926.436988486098, 5918.082697181933, 5967.075103358976, 5971.343152253248, 5972.820815375535, 5984.820455386334, 5330.946690533094, 5358.089124848785, 5360.892782144355, 5427.104527752916, 5443.0, 5169.3279873616375, 5203.0114278287, 5456.536194423479, 5461.890762184754, 5464.7540860661165, 5306.151015837467, 5346.759395827177, 5412.864678383033, 5420.566354691635, 5429.728513574325, 5437.510624043815, 5443.537299329542, 5448.101063324547, 5451.073317536028, 5452.0, 5184.559312458446, 5302.09864323066, 5349.117395629716, 5383.515483606494, 5447.727613619303, 5711.971440142815, 5727.398623144593, 5746.224259724967, 5779.017567013576, 5822.82531524055, 6261.937380626181, 6267.341929097471, 6268.968655156741, 6290.056491526262, 6292.937070629281, 6331.2085989251345, 6338.683065846735, 6343.651099189543, 6345.746170153188, 6348.9365106348805, 5693.430656934315, 5736.799212027559, 5814.360420353758, 5865.736041878125, 5881.2942446906645, 6470.061841033118, 6478.060681201294, 6479.740810367627, 6480.740770369132, 6484.157059582319, 6144.139820425144, 6155.076738489173, 6204.410580994799, 6211.65835879031, 6235.781747638811, 6104.4200800923845, 6109.929007496936, 6148.1392605035335, 6319.24169099711, 6323.462505686976, 6288.874222515524, 6299.716512756937, 6312.621242725451, 6313.273973493107, 6319.9368006320265, 6056.545759068087, 6112.633242005494, 6115.449609535163, 6162.753489860445, 6330.68346582669, 4739.265413860857, 4775.21209000511, 4780.139574876486, 4789.281607758864, 4795.520447955177, 4145.585441455831, 4251.532331443539, 4271.231178387858, 4281.486221653359, 4284.293091639907, 6022.849428764228, 6070.484008859296, 6071.0, 6143.784967526115, 6145.26256849172, 6343.080253363237, 6378.075179099097, 6387.393197646309, 6389.424951754364, 6404.807855764335, 6128.693565321716, 6137.478314343241, 6145.4161854623735, 6153.753849845956, 6156.753729850845, 5216.113260745682, 5270.947290527122, 5295.0, 5367.919481207785, 5434.83695489136, 6588.242352129375, 6649.235337936199, 6649.335066493312, 6654.6672666366485, 6659.933400666028, 6342.175517182736, 6343.90484142729, 6387.808365749035, 6396.936030639634, 6410.358964103552, 6323.525735569942, 6352.142460767737, 6507.446867016357, 6628.933710662832, 6631.701573429304, 6225.719842607185, 6249.937500624936, 6258.374162583706, 6263.091851681572, 6266.811995640138, 6352.9047064295, 6355.396237357444, 6371.13989611415, 6379.298277189413, 6384.265809431789, 5948.702564871653, 5985.670788106696, 6150.600210986271, 6151.0773383992755, 6214.471769899609, 6124.846878827887, 6125.449118208347, 6232.8130156095385, 6240.219972503437, 6248.875022499616, 6225.906611400742, 6231.314555398993, 6235.127082208403, 6244.125822384779, 6244.125822384961, 5976.551758618208, 6001.849953751192, 6053.485453736305, 6138.572327483795, 6271.717772700331, 6069.787557435468, 6104.298005729221, 6111.052786818051, 6130.570860039755, 6141.385861413823], "value": 5816.464845692344, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.7272182014474, 828.3869936247177, 846.0186184026528, 913.867489214064, 925.62512182566, 31481.05556833293, 42870.35694464586, 44090.0, 44228.0, 44250.55749442505, 45665.54334456663, 45902.31146532796, 45948.0, 45996.0, 46031.53968460314, 7904.604769761518, 8006.039275286974, 9156.633734650623, 9304.255659547254, 9305.348625596178, 10903.127749780038, 11060.612878549253, 11095.778084438307, 11147.609833655824, 11165.609203677874, 10768.623098191565, 10845.186611004166, 10922.235443518917, 10928.890711092907, 10954.233203675745, 10862.945685271603, 10890.128789696806, 10904.400257985808, 10911.945440272748, 10912.781744365067, 10476.63331783384, 10516.369017858953, 10520.736981575445, 10521.05310522049, 10523.736906577396, 43212.0, 43321.35017974733, 43326.0, 43468.782656086834, 43582.78208608968, 3428.5542879425766, 3451.706604938583, 3462.690136564512, 3463.255400088993, 3507.631698671654, 30470.390592188254, 30617.387652247053, 30626.23434414135, 30641.387172256655, 30648.0, 4369.1480161368545, 4379.824807007716, 4468.128714900596, 4529.59233668968, 4587.105514424688, 234307.0, 234515.0, 236166.0, 236453.0, 237316.81341593355, 54355.45644543504, 54448.72775636097, 54468.455315446336, 54603.18095228495, 54815.45184548183, 56684.43315566792, 56737.0, 56842.43157568372, 56856.0, 56871.0, 15899.125548094966, 15907.0, 16036.278367473491, 16038.518844434686, 16056.27746751399, 13184.538541151014, 13417.329133543479, 13655.317234138254, 13855.58433246984, 13911.582652520441, 13421.328933553283, 13449.663758405923, 13572.796408053888, 13683.24742139172, 13695.246761428218, 5348.973255133699, 5378.704171270618, 5394.622376433612, 5455.890882182334, 5483.698396588226, 991.3358050106445, 995.85560093786, 996.1134590214715, 1001.2040427859869, 1013.2350075692805, 28512.857435713104, 28819.279518012216, 29038.274043148667, 31195.84402077975, 31343.84328078345, 1173.208084542947, 1186.0215322359088, 1191.6603767926272, 1208.8065909454444, 1221.82283568882, 13685.589432317047, 13707.109037912503, 13975.23136227497, 14049.0, 14066.156030638194, 336511.0, 337642.0, 337997.0, 338229.0, 339045.0, 48972.5102748968, 49020.75489622529, 49076.50923490719, 49184.01631967341, 49221.261681074095, 1429.9642508937152, 1454.120257244373, 1485.6211666025094, 1486.4351546412295, 1506.9020513666576, 24028.87985560061, 29093.0, 30691.13046754629, 30944.69055309418, 30981.53527697041, 47336.28995565138, 47553.76223118862, 47568.2864757022, 47602.285965711235, 47685.52314476811, 325178.0, 325423.0, 325977.0, 326123.0, 326803.0, 25300.620490692287, 25903.870480647474, 28628.0, 29834.701652983193, 29920.401591967602, 39214.80392598019, 39447.408288876264, 39459.60540394674, 39531.20937581175, 39660.80169599134, 31006.0, 31408.214794629403, 31502.21244468815, 31647.36705265928, 31933.680663194, 30622.387552248383, 30813.691863081083, 30951.91668291599, 31115.533267001465, 31488.0, 34982.47526287057, 35159.47260791141, 35169.47245791366, 35752.284954300245, 35888.4616730744, 29276.56085158767, 29481.410371792874, 29487.0, 29566.113016609535, 30295.545566816956, 23388.298351049496, 24458.26625201247, 24472.388190294674, 24689.629655555542, 24763.380915477257], "value": 18774.587485088425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.4261460101867, 459.91261660284545, 464.93955785747846, 465.94408670959467, 478.3470562681939, 16031.198440078007, 16686.58283542912, 20482.590348193025, 20639.071241794118, 21712.3486295411, 21111.366659000254, 21203.469913252175, 22080.22719204828, 22614.547709045808, 22811.0, 6716.496262780299, 6918.827029324257, 6945.097137372135, 6959.8956015659805, 6960.651967401635, 5812.418758124175, 5960.165576819227, 6722.563033402837, 6725.092112564815, 6731.596104233738, 6759.32406759325, 6800.931990680079, 6803.421709154703, 6812.386885180333, 6815.863682726343, 6636.236832764245, 6640.435562977153, 6686.531942764009, 6690.765823196213, 6750.8312292192595, 6578.736850525973, 6582.6050436973455, 7073.964630176868, 7361.889571656376, 7415.88876166858, 24812.627810582857, 25022.624660630107, 25175.87412062946, 25190.874045629836, 25496.490070198677, 2791.232411086947, 2843.1896909380935, 2847.117393607988, 2920.897768578111, 2937.221636266391, 15923.203839807964, 16126.113063781488, 16220.10789406582, 16265.756013659804, 16988.49034528966, 2264.0, 2323.0591610397814, 2360.24472168906, 2361.126383238213, 2479.0, 72679.63660181718, 93353.0, 122572.38713806463, 122698.38650806778, 126329.99999999908, 16813.61964171478, 16986.915065424593, 17528.737068943978, 18334.0, 18430.35493757712, 31431.799774016057, 31537.36925261482, 31565.526517102262, 31579.684203157674, 31581.684183158333, 10543.0, 10596.576136954589, 10623.150147988143, 10669.19981001428, 10844.349339039683, 8880.467171969702, 8885.822283554293, 8907.910920890708, 9081.954590227007, 9086.318526110568, 9290.953545232365, 9291.163795258459, 9450.149486546245, 9571.569279382444, 9598.856017159747, 3453.015890471204, 3517.296540691872, 3561.7684850484634, 3646.4712616670436, 3689.4834723138783, 922.1746536849482, 933.09955892564, 941.9670311539063, 949.3259785552198, 957.4829592020232, 19237.230510779413, 20855.791442085385, 20918.47703807417, 20924.89537552333, 21191.8940405297, 949.3212353167519, 956.3926906414338, 956.5121787888227, 964.9276304277207, 967.8451447768323, 10959.287646302964, 11333.563283894002, 11628.302301861915, 11631.88368116325, 11728.354940478184, 658923.1387690816, 661624.0, 665620.0, 671863.0, 674609.0, 78283.60858195786, 88068.5596572013, 99110.5044474773, 115922.0, 117892.0, 1360.897932655035, 1366.6173471428017, 1386.334559411488, 1394.28194479845, 1412.1033143953664, 17940.192691329183, 18882.0, 19074.904625476785, 19086.427407177805, 19120.90439547849, 51391.22913156381, 52027.47972520226, 52057.47942520526, 52348.0, 53719.46280537145, 68208.0, 68513.31486685069, 68586.65706671435, 69257.65371173313, 69698.30301696918, 11012.0, 11763.941180294387, 12343.753124937271, 12360.44378002974, 12536.122471427278, 12525.686857828627, 13036.804447933098, 13064.608061758163, 13354.265515396746, 13749.450021999008, 11944.402779860799, 12149.331786751813, 12394.256344619353, 12416.565420210249, 12518.874811252135, 11146.164037697366, 11178.608748693756, 11471.885281147082, 11619.709507262387, 11770.352630605057, 11863.466144023367, 12151.270923744603, 12152.088593355356, 12317.876821231674, 12545.87454125447, 12233.877661223274, 12304.569340073054, 12309.630711078682, 12330.506779729069, 12346.876531234573, 11446.0, 11633.53465861356, 11701.88298117008, 11869.940650296694, 12202.0], "value": 11278.983139147618, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.679187370652, 1556.9377224911004, 1568.7253482450442, 1572.3867691600271, 1599.89600675956, 10741.51663175157, 11426.600068997586, 11438.942805285973, 11458.71353216171, 11480.196386252945, 11040.116790656728, 11162.441877906112, 11168.832467512973, 11211.551537938492, 11239.213255072149, 2478.541469828083, 2512.1458704040624, 2515.584928486807, 2517.3706573356662, 2517.546841568517, 2443.3280847766828, 2461.520003599299, 2501.3871601457668, 2503.2615378463397, 2503.5618766715843, 2440.5851005329137, 2454.4232105455203, 2459.754024597544, 2487.2289590226997, 2491.8754062296903, 2403.831731778776, 2445.4742230420457, 2446.2538925627678, 2450.105711415338, 2474.059857254241, 2302.1366987379733, 2308.933051893742, 2328.918487852934, 2335.2760644200184, 2337.49743805081, 11262.0, 11517.021053210487, 11520.596779112691, 11524.135689823297, 11534.423278836024, 5905.143754155623, 6068.787592434288, 6073.180120683695, 6084.847878803021, 6089.451949324538, 3465.151037995682, 3535.7878527288444, 3559.537260156163, 3681.9079523012138, 3730.8321125549146, 1327.5287273018132, 1338.9397477113553, 1358.5516779462753, 1385.411200239894, 1395.9720805583934, 16536.338546458126, 16552.0, 16776.245068971926, 16983.405580804738, 17542.47372578812, 4689.226277664147, 4748.6438517111355, 4825.758712064383, 4849.321095046696, 4852.0295940811975, 12469.812952805714, 12492.437840297209, 12495.312757798227, 12496.375181241083, 12519.3740312984, 5967.31375891778, 5968.880622387528, 5976.342602313742, 5976.7908123215475, 5978.641281523122, 5442.863928401822, 5594.552435805207, 5595.0, 5621.016322143691, 5625.353084395347, 3973.5827738087664, 4040.959590404117, 4091.6522095622204, 4108.63022327986, 4119.8352065917625, 1051.695008447557, 1054.699410667956, 1057.709129989259, 1064.377339256528, 1066.7386490309923, 1085.8968398002178, 1110.3967625056744, 1111.2499063132354, 1115.6653004098737, 1119.7312644965314, 7301.598412087386, 7318.194998550155, 7375.520591161558, 7385.926140738631, 7462.96268518654, 1059.9523021464054, 1066.9626563070256, 1077.9083777878811, 1103.0954617213968, 1119.4346854838254, 4579.107074120581, 4726.078414709167, 4872.610191184696, 4901.387326584177, 4973.825916092919, 14305.28473576317, 14472.565823025327, 14828.481003164838, 14898.031627944149, 14935.402583896739, 14448.277586120652, 14578.927105364617, 14717.969742118163, 14728.779068313985, 14741.631459213606, 10577.735556610993, 10811.135109191246, 10892.292001019909, 10902.672919812418, 10911.127109831354, 7252.093488313961, 7267.091613548307, 7508.361789247975, 7523.285287897641, 7573.129090154703, 12733.490660373482, 13117.0, 13187.53843615469, 13212.933935330646, 13234.536791212262, 13382.397792099184, 13405.463781448632, 13425.597232083053, 13425.798613020617, 13523.0, 9367.484788336707, 9442.716718498456, 9453.24374050088, 9583.616655333988, 9601.90398096038, 10903.781924361627, 10910.454477276264, 11032.613858514913, 11042.0, 11043.723906902393, 9167.220786233245, 9308.48803315824, 9360.906390936003, 9404.529773511435, 9524.428534287965, 9103.135202155785, 9119.407238529475, 9153.725388238363, 9233.538323083952, 9325.347225694137, 8312.875306870523, 8416.915830841614, 8503.404761666625, 8516.40385173032, 8529.275011624082, 6325.399087086719, 6328.240611126695, 6413.454856337264, 6418.550701450854, 6543.607383557001, 6411.583247089111, 6443.09796628463, 6535.673216339259, 6673.733050677918, 6692.130023096966], "value": 5461.9760877747485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.28331162382165, 417.2885230681688, 421.54894263138436, 428.824182085345, 437.5755517148365, 5170.79316827327, 5270.841874743759, 5277.15565509519, 5286.233496143057, 5331.614424840225, 5000.674956127849, 5177.430482646906, 5183.60473889602, 5185.637005409623, 5213.973930130344, 4421.9336709949375, 4429.490608580006, 4434.889127771816, 4438.267685831834, 4459.130469558438, 4232.936505952413, 4330.653547716175, 4338.349247612852, 4352.499462561798, 4454.97772511137, 4334.804933777988, 4375.321825117096, 4408.0, 4433.623142032931, 4447.755373454459, 4372.956270437287, 4383.3424986252, 4388.561143885602, 4406.889827754299, 4410.1179764047, 3983.7609743415196, 4141.7100802943805, 4178.289690752549, 4199.91600167998, 4216.9578304216875, 5095.8980820383385, 5102.617303702237, 5110.821121260775, 5113.897722045575, 5122.871928201787, 5065.696058236481, 5067.505085999639, 5116.897662046776, 5160.845174644766, 5161.458046905059, 5314.229436731691, 5438.464997751454, 5465.699386533739, 5482.643628164196, 5504.284443022381, 4549.772511374418, 4561.9927232018135, 4568.70303430276, 4571.794269257858, 4587.8623641290815, 5746.310442746855, 5751.884962300773, 5761.48146666802, 5766.163906233573, 5832.737526811304, 4670.346151538787, 4685.906281874411, 4688.624910007191, 4711.882202944886, 4759.38128043359, 4559.349463547163, 4797.56821886032, 4814.133455977958, 4816.397950256218, 4846.0, 4901.3383193269165, 4949.653524253267, 4991.326170966946, 5049.899002019939, 5057.190849464068, 5457.553748256715, 5486.91769623456, 5496.093144631171, 5512.173174023848, 5518.503334699896, 1562.734335163025, 1603.8556529912364, 1636.378176293001, 1637.656092220647, 1656.3540219314477, 1244.2223610243598, 1269.4858582274194, 1274.751423472414, 1279.0087682046487, 1295.3846922711637, 5419.349678038582, 5445.576718360292, 5469.699166545878, 5475.342958844884, 5482.835514934558, 5545.833624991256, 5619.438056194348, 5636.577256705764, 5658.0, 5686.947914635805, 5160.716160611128, 5433.673979561239, 5448.264484294569, 5457.945420545823, 5485.698286594195, 2981.508051171576, 2987.2979849735293, 2989.342344684166, 2989.5814585957983, 2993.6407631084408, 5697.629654072555, 5891.499222566044, 5891.675957822361, 5930.169776231331, 5947.881042379215, 5749.252597162342, 5789.884202316014, 5802.593818432669, 5822.912656310159, 5879.735411906475, 5848.736806843703, 5868.413158684098, 5882.49998750111, 5944.613600115978, 5983.461488466059, 5430.8099216527235, 5678.375378708256, 5718.828435146952, 5728.742206600797, 5777.45114214149, 5622.85942851432, 5657.32112146545, 5666.235058267246, 5690.800821971211, 5691.0, 5756.812411283853, 5931.851703707442, 5996.340402555628, 5997.790077347272, 6019.508684962623, 4730.172219861579, 4747.691400058985, 4768.356271903249, 4770.880727981828, 4772.5227477252, 5499.367572729027, 5502.504774570308, 5609.868250064949, 5689.800856969986, 5693.4021927696995, 5537.446255374431, 5548.778048878161, 5582.637128586629, 5587.972060139673, 5613.915791263216, 5318.361796584435, 5552.444755524577, 5555.333359996826, 5595.63628364155, 5597.524210441995, 5479.972600137134, 5536.52939500147, 5546.696526316232, 5560.805371811967, 5610.635308704921, 5504.697241651747, 5553.333999799963, 5591.552675786009, 5598.888022239451, 5635.0, 5281.339832520935, 5427.240186373831, 5429.918551221655, 5474.3704473986, 5512.586556008235], "value": 4449.417208766501, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.9232369086781, 865.6061492021131, 914.1452741686521, 915.1534830281989, 928.9117533834287, 16549.089800060992, 16759.581010474743, 17668.116594170304, 17736.379226727066, 18270.0, 16248.83751162488, 16757.24592393342, 16941.0, 17041.82958170421, 17109.40117095902, 877.4121338703052, 892.6518657723477, 903.7966457547066, 905.443152461235, 908.0420156734642, 892.4600616626944, 892.937494375394, 894.9731508054768, 896.0546623312403, 896.1934259166769, 953.0945601678399, 954.0793134625086, 954.3081266082104, 954.7613096725819, 955.0544960489135, 937.5921474158763, 946.857971304303, 953.4946478366477, 954.5847556312991, 955.1976339874504, 690.1338819781192, 694.5277211496181, 699.8040548646336, 699.8215455058927, 701.4738945790657, 17327.133643317782, 17443.21505532254, 17610.735838962424, 17704.468865933915, 17718.822811771846, 16072.196390180445, 16128.274227659665, 16357.59106022347, 16398.26207820651, 16457.506274811774, 13961.79057314141, 14257.78613320801, 14428.153663429577, 14491.71016579673, 14562.98059135861, 4005.2790497710403, 4031.0, 4112.588741125894, 4124.340105583123, 4127.009517715756, 93595.0, 93600.0, 93770.0, 94404.0, 95954.0, 11521.423928803526, 11688.94155529217, 11790.292582445081, 11826.172167948333, 11860.169788114748, 21399.25102621401, 21954.89022554877, 21993.34019979403, 23904.16335428252, 24111.51776964486, 8846.15961483658, 9080.772980675403, 9273.397229180082, 9283.303752218611, 9344.2524598032, 5240.633155679066, 5275.788968441296, 5310.946890531045, 5383.353997520244, 5421.430749771296, 3670.2659468106485, 3757.267332870119, 3758.6805121564425, 3771.26460340231, 3785.167263202091, 661.8146918862726, 664.3987191591617, 671.1208317104608, 674.7031306225246, 684.5721424109931, 846.8772028055897, 852.5311078906576, 874.5364956573027, 884.3720958119678, 891.9152680495342, 10749.659064892183, 10889.673309800719, 11228.943855280671, 11467.0, 12120.939395303143, 830.7217082277384, 831.9584020798936, 851.1871163039283, 854.4958474500074, 892.2326798952895, 5167.302414174038, 5254.343207099113, 5299.284596579412, 5346.8395948121615, 5363.0, 70776.0, 82844.58577707193, 83503.6598536064, 84259.57870210732, 86029.0, 69128.0, 70040.6497967517, 70431.64784176047, 71615.0, 72685.0, 57108.42891571197, 65783.34216657867, 66877.66561167261, 67122.0, 67402.66298668475, 11636.41817909118, 11903.642890713292, 11965.401729913296, 12169.756604868031, 12236.0, 37491.43762843505, 38749.41875871921, 40270.0, 41396.793016034724, 42703.145937080466, 56354.0, 56754.43245567491, 56767.0, 56971.71514142403, 58133.0, 13549.79675304891, 13727.450901964208, 13735.931320343334, 14227.715445690821, 14728.484503042342, 16656.50030499087, 16672.916635416746, 16838.831611683727, 18273.0, 18286.725699114257, 16411.521078721253, 16844.25199875903, 17045.318187272867, 17156.39952601653, 17951.640967180843, 14408.351624176728, 15292.0, 15352.539423817303, 15940.840591593935, 15952.0, 16191.67616647684, 16370.181490925168, 16980.915095424443, 17358.479245622653, 17432.477025689248, 11449.370284634091, 11592.246503977214, 11754.118441117122, 11863.584774533196, 12207.45066471993, 12383.380830958236, 12461.75076498483, 12777.425015874122, 12783.424745886272, 12827.55103571408], "value": 8097.578846701755, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 112.0, 115.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 116.0, 151.0, 122.0, 116.0, 115.0, 114.0, 136.0, 115.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 164.0, 163.0, 164.0, 161.0, 161.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 113.0, 75.0, 75.0, 75.0, 75.0, 90.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 103.0, 82.0, 82.0, 82.0, 94.0, 83.0, 82.0, 103.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 74.0, 81.0, 79.0, 76.0, 75.0, 80.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 138.0, 130.0, 129.0, 123.0, 118.0, 121.0, 126.0, 163.0, 139.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 165.0, 161.0, 159.0, 163.0, 161.0, 164.0, 166.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 61.0, 60.0, 63.0, 60.0, 59.0, 58.0], "value": 60.5, "unit": "score"}]}]} 09:26:16 INFO - Return code: 0 09:26:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:16 ERROR - # TBPL SUCCESS # 09:26:16 INFO - Running post-action listener: _resource_record_post_action 09:26:16 INFO - [mozharness: 2017-04-03 16:26:16.555948Z] Finished run-tests step (success) 09:26:16 INFO - Running post-run listener: _resource_record_post_run 09:26:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 368848896; Read time: 16; Write time: 236480 09:26:16 INFO - TinderboxPrint: CPU usage
13.1% 09:26:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:26:16 INFO - TinderboxPrint: I/O write bytes / time
368,848,896 / 236,480 09:26:16 INFO - TinderboxPrint: CPU idle
8,257.6 (86.9%) 09:26:16 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 09:26:16 INFO - TinderboxPrint: Swap in / out
0 / 0 09:26:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110702592; Read time: 0; Write time: 100148 09:26:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258146304; Read time: 16; Write time: 136332 09:26:17 INFO - Running post-run listener: _upload_blobber_files 09:26:17 INFO - Blob upload gear active. 09:26:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:17 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:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:26:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:18 INFO - (blobuploader) - INFO - Done attempting. 09:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:21 INFO - (blobuploader) - INFO - Done attempting. 09:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:22 INFO - (blobuploader) - INFO - Done attempting. 09:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:23 INFO - (blobuploader) - INFO - Done attempting. 09:26:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:23 INFO - Return code: 0 09:26:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cba5c4a2e06921033252c7d45f430ce1264ceb5fd5d1c4f889325ef5c081f2440931550295bfc525c35a34abd26c2929edcb209d6377922d073ab675a4d7a61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/952cea6a28399db57bc9964adb31cc70c201463fb49c13929aa05c3bb9c74ea780a9560095522396576c5144bb133c09f7df4d84bcb1ea5a89e993dfe16216c5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b67d5e2fe223d6e1a5fc7a7477bbca5355cf75cef2c41f3de63777271218cd62617249cb7184905ab584ea08379721a41fe107f02ecaf588049a01c71a13acc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6b783bb1c5f7a259b8b60dc77e52374832e2a45a3c878fa9cf8b38608b42e32cefc477cdabef5e0399e429cb730b98e52ceef91c56a208aca5f6754ee2698f"} 09:26:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:23 INFO - Contents: 09:26:23 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cba5c4a2e06921033252c7d45f430ce1264ceb5fd5d1c4f889325ef5c081f2440931550295bfc525c35a34abd26c2929edcb209d6377922d073ab675a4d7a61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/952cea6a28399db57bc9964adb31cc70c201463fb49c13929aa05c3bb9c74ea780a9560095522396576c5144bb133c09f7df4d84bcb1ea5a89e993dfe16216c5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b67d5e2fe223d6e1a5fc7a7477bbca5355cf75cef2c41f3de63777271218cd62617249cb7184905ab584ea08379721a41fe107f02ecaf588049a01c71a13acc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6b783bb1c5f7a259b8b60dc77e52374832e2a45a3c878fa9cf8b38608b42e32cefc477cdabef5e0399e429cb730b98e52ceef91c56a208aca5f6754ee2698f"} 09:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:23 INFO - Copying logs to upload dir... 09:26:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.256459 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-04-03 09:26:23.356566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 09:26:23.360275) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cba5c4a2e06921033252c7d45f430ce1264ceb5fd5d1c4f889325ef5c081f2440931550295bfc525c35a34abd26c2929edcb209d6377922d073ab675a4d7a61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/952cea6a28399db57bc9964adb31cc70c201463fb49c13929aa05c3bb9c74ea780a9560095522396576c5144bb133c09f7df4d84bcb1ea5a89e993dfe16216c5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b67d5e2fe223d6e1a5fc7a7477bbca5355cf75cef2c41f3de63777271218cd62617249cb7184905ab584ea08379721a41fe107f02ecaf588049a01c71a13acc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6b783bb1c5f7a259b8b60dc77e52374832e2a45a3c878fa9cf8b38608b42e32cefc477cdabef5e0399e429cb730b98e52ceef91c56a208aca5f6754ee2698f"} build_url:https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/XCqniTduSp-UaPwEl1T3rA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cba5c4a2e06921033252c7d45f430ce1264ceb5fd5d1c4f889325ef5c081f2440931550295bfc525c35a34abd26c2929edcb209d6377922d073ab675a4d7a61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/952cea6a28399db57bc9964adb31cc70c201463fb49c13929aa05c3bb9c74ea780a9560095522396576c5144bb133c09f7df4d84bcb1ea5a89e993dfe16216c5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b67d5e2fe223d6e1a5fc7a7477bbca5355cf75cef2c41f3de63777271218cd62617249cb7184905ab584ea08379721a41fe107f02ecaf588049a01c71a13acc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6b783bb1c5f7a259b8b60dc77e52374832e2a45a3c878fa9cf8b38608b42e32cefc477cdabef5e0399e429cb730b98e52ceef91c56a208aca5f6754ee2698f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 09:26:23.385672) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:26:23.386007) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1491235532.471200-3925249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:26:23.467561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 09:26:23.467881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 09:26:23.468446) ========= ========= Total master_lag: 0.15 =========