builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1491408903.66 results: success (0) revision: 720b9177c6856c1c4339d0fac1bf5149c0d53950 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.658831) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.659296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.659628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.675334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.675646) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 09:15:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2017-04-05 09:15:04 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.801934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.802283) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019424 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.851611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:03.851987) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 720b9177c6856c1c4339d0fac1bf5149c0d53950 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 720b9177c6856c1c4339d0fac1bf5149c0d53950 --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=e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 09:15:04,205 truncating revision to first 12 chars 2017-04-05 09:15:04,205 Setting DEBUG logging. 2017-04-05 09:15:04,205 attempt 1/10 2017-04-05 09:15:04,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/720b9177c685?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 09:15:04,545 unpacking tar archive at: mozilla-central-720b9177c685/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676477 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:04.542177) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:04.542516) ========= script_repo_revision: 720b9177c6856c1c4339d0fac1bf5149c0d53950 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:04.542954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:04.543255) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:04.553067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-05 09:15:04.553487) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:04 INFO - MultiFileLogger online at 20170405 09:15:04 in /builds/slave/test 09:15:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:15:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:05 INFO - {'append_to_log': False, 09:15:05 INFO - 'base_work_dir': '/builds/slave/test', 09:15:05 INFO - 'blob_upload_branch': 'Firefox', 09:15:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:05 INFO - 'branch': 'Firefox', 09:15:05 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:05 INFO - 'config_files': ('talos/linux_config.py',), 09:15:05 INFO - 'default_actions': ('clobber', 09:15:05 INFO - 'read-buildbot-config', 09:15:05 INFO - 'download-and-extract', 09:15:05 INFO - 'populate-webroot', 09:15:05 INFO - 'create-virtualenv', 09:15:05 INFO - 'install', 09:15:05 INFO - 'run-tests'), 09:15:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:05 INFO - 'download_minidump_stackwalk': True, 09:15:05 INFO - 'download_symbols': 'ondemand', 09:15:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:05 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:05 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:05 INFO - 'gecko_profile': False, 09:15:05 INFO - 'gecko_profile_interval': 0, 09:15:05 INFO - 'installer_path': 'installer.exe', 09:15:05 INFO - 'log_level': 'info', 09:15:05 INFO - 'log_name': 'talos', 09:15:05 INFO - 'log_to_console': True, 09:15:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:05 INFO - 'opt_config_files': (), 09:15:05 INFO - 'pip_index': False, 09:15:05 INFO - 'suite': 'dromaeojs', 09:15:05 INFO - 'system_bits': '32', 09:15:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:05 INFO - 'title': 'talos-linux64-ix-006', 09:15:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:05 INFO - 'use_talos_json': True, 09:15:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:05 INFO - 'work_dir': 'build'} 09:15:05 INFO - [mozharness: 2017-04-05 16:15:05.009642Z] Running clobber step. 09:15:05 INFO - Running pre-action listener: _resource_record_pre_action 09:15:05 INFO - Running main action method: clobber 09:15:05 INFO - rmtree: /builds/slave/test/build 09:15:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:06 INFO - Running post-action listener: _resource_record_post_action 09:15:06 INFO - [mozharness: 2017-04-05 16:15:06.523006Z] Finished clobber step (success) 09:15:06 INFO - [mozharness: 2017-04-05 16:15:06.523105Z] Running read-buildbot-config step. 09:15:06 INFO - Running pre-action listener: _resource_record_pre_action 09:15:06 INFO - Running main action method: read_buildbot_config 09:15:06 INFO - Using buildbot properties: 09:15:06 INFO - { 09:15:06 INFO - "project": "", 09:15:06 INFO - "product": "firefox", 09:15:06 INFO - "who": "ffxbld@noreply.mozilla.org", 09:15:06 INFO - "installer_path": "public/build/target.tar.bz2", 09:15:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:15:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:15:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:15:06 INFO - "stage_platform": "linux64-pgo", 09:15:06 INFO - "basedir": "/builds/slave/test", 09:15:06 INFO - "buildnumber": 115, 09:15:06 INFO - "platform": "ubuntu64_hw", 09:15:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:15:06 INFO - "slavebuilddir": "test", 09:15:06 INFO - "taskId": "TkDh57pYR9WPQlJGaE0Jeg", 09:15:06 INFO - "branch": "mozilla-central", 09:15:06 INFO - "script_repo_revision": "production", 09:15:06 INFO - "revision": "720b9177c6856c1c4339d0fac1bf5149c0d53950", 09:15:06 INFO - "slavename": "talos-linux64-ix-006", 09:15:06 INFO - "repo_path": "mozilla-central" 09:15:06 INFO - } 09:15:06 INFO - Finding installer, test and symbols from parent task. 09:15:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TkDh57pYR9WPQlJGaE0Jeg'}, attempt #1 09:15:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TkDh57pYR9WPQlJGaE0Jeg'}, attempt #1 09:15:07 INFO - Task dependencies: LomcT0IJShO75ulxeABkJg 09:15:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg'}, attempt #1 09:15:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.tar.bz2 09:15:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/test_packages.json 09:15:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.crashreporter-symbols.zip 09:15:07 INFO - Running post-action listener: _resource_record_post_action 09:15:07 INFO - [mozharness: 2017-04-05 16:15:07.877005Z] Finished read-buildbot-config step (success) 09:15:07 INFO - [mozharness: 2017-04-05 16:15:07.877220Z] Running download-and-extract step. 09:15:07 INFO - Running pre-action listener: _resource_record_pre_action 09:15:07 INFO - Running main action method: download_and_extract 09:15:07 INFO - mkdir: /builds/slave/test/build/tests 09:15:07 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:15:07 INFO - trying https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.test_packages.json 09:15:07 INFO - Downloading https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:15:08 INFO - Downloaded 986 bytes. 09:15:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:15:08 INFO - Using the following test package requirements: 09:15:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:15:08 INFO - u'common': [u'target.common.tests.zip'], 09:15:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:15:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:15:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:15:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:15:08 INFO - u'mozbase': [u'target.common.tests.zip'], 09:15:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:15:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:15:08 INFO - u'web-platform': [u'target.common.tests.zip', 09:15:08 INFO - u'target.web-platform.tests.zip'], 09:15:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:15:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:15:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.common.tests.zip 09:15:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:15:08 INFO - Fetch https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.common.tests.zip into memory 09:15:09 INFO - Expected file size: 60356377 09:15:09 INFO - Obtained file size: 60356377 09:15:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:15:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.common.tests.zip 09:15:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:15:19 INFO - Fetch https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.common.tests.zip into memory 09:15:20 INFO - Expected file size: 60356377 09:15:20 INFO - Obtained file size: 60356377 09:15:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.talos.tests.zip 09:15:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:15:31 INFO - Fetch https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.talos.tests.zip into memory 09:15:31 INFO - Expected file size: 14404152 09:15:31 INFO - Obtained file size: 14404152 09:15:32 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:15:32 INFO - trying https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.tar.bz2 09:15:32 INFO - Downloading https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:15:33 INFO - Downloaded 63094034 bytes. 09:15:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.tar.bz2 09:15:33 INFO - mkdir: /builds/slave/test/properties 09:15:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:33 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:33 INFO - Contents: 09:15:33 INFO - build_url:https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.tar.bz2 09:15:33 INFO - Running post-action listener: _resource_record_post_action 09:15:33 INFO - Running post-action listener: set_extra_try_arguments 09:15:33 INFO - [mozharness: 2017-04-05 16:15:33.359599Z] Finished download-and-extract step (success) 09:15:33 INFO - [mozharness: 2017-04-05 16:15:33.359695Z] Running populate-webroot step. 09:15:33 INFO - Running pre-action listener: _resource_record_pre_action 09:15:33 INFO - Running main action method: populate_webroot 09:15:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:33 INFO - '--tppagecycles', 09:15:33 INFO - '7'], 09:15:33 INFO - 'tests': ['tsvgm']}}, 09:15:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:15:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:15:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:15:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:15:33 INFO - 'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:15:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:15:33 INFO - 'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['damp', 'tps']}, 09:15:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:15:33 INFO - 'tests': ['damp', 'tps']}, 09:15:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['dromaeo_dom']}, 09:15:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['basic_compositor_video']}, 09:15:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:15:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['a11yr', 09:15:33 INFO - 'ts_paint', 09:15:33 INFO - 'tpaint', 09:15:33 INFO - 'sessionrestore', 09:15:33 INFO - 'sessionrestore_no_auto_restore', 09:15:33 INFO - 'tabpaint']}, 09:15:33 INFO - 'other-e10s': {'tests': ['a11yr', 09:15:33 INFO - 'ts_paint', 09:15:33 INFO - 'tpaint', 09:15:33 INFO - 'sessionrestore', 09:15:33 INFO - 'sessionrestore_no_auto_restore', 09:15:33 INFO - 'tabpaint']}, 09:15:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:15:33 INFO - 'ts_paint', 09:15:33 INFO - 'tpaint', 09:15:33 INFO - 'sessionrestore', 09:15:33 INFO - 'sessionrestore_no_auto_restore', 09:15:33 INFO - 'tabpaint']}, 09:15:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:15:33 INFO - 'ts_paint', 09:15:33 INFO - 'tpaint', 09:15:33 INFO - 'sessionrestore', 09:15:33 INFO - 'sessionrestore_no_auto_restore', 09:15:33 INFO - 'tabpaint']}, 09:15:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['a11yr', 09:15:33 INFO - 'ts_paint', 09:15:33 INFO - 'tpaint', 09:15:33 INFO - 'sessionrestore', 09:15:33 INFO - 'sessionrestore_no_auto_restore', 09:15:33 INFO - 'tabpaint']}, 09:15:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['a11yr', 09:15:33 INFO - 'ts_paint', 09:15:33 INFO - 'tpaint', 09:15:33 INFO - 'sessionrestore', 09:15:33 INFO - 'sessionrestore_no_auto_restore', 09:15:33 INFO - 'tabpaint']}, 09:15:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['tsvgx', 09:15:33 INFO - 'tsvgr_opacity', 09:15:33 INFO - 'tart', 09:15:33 INFO - 'tscrollx', 09:15:33 INFO - 'cart', 09:15:33 INFO - 'tsvg_static']}, 09:15:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:15:33 INFO - 'tsvgr_opacity', 09:15:33 INFO - 'tart', 09:15:33 INFO - 'tscrollx', 09:15:33 INFO - 'cart', 09:15:33 INFO - 'tsvg_static']}, 09:15:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:15:33 INFO - 'talos_options': ['--disable-e10s'], 09:15:33 INFO - 'tests': ['tp5o']}, 09:15:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:15:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:15:33 INFO - 'talos_options': ['--disable-e10s', 09:15:33 INFO - '--xperf_path', 09:15:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:33 INFO - 'tests': ['tp5n']}, 09:15:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:15:33 INFO - 'talos_options': ['--xperf_path', 09:15:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:33 INFO - 'tests': ['tp5n']}}, 09:15:33 INFO - 'talos.zip': {'path': '', 09:15:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:33 INFO - Running post-action listener: _resource_record_post_action 09:15:33 INFO - [mozharness: 2017-04-05 16:15:33.372721Z] Finished populate-webroot step (success) 09:15:33 INFO - [mozharness: 2017-04-05 16:15:33.372811Z] Running create-virtualenv step. 09:15:33 INFO - Running pre-action listener: _resource_record_pre_action 09:15:33 INFO - Running main action method: create_virtualenv 09:15:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:33 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:15:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:33 INFO - Using real prefix '/usr' 09:15:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:35 INFO - Installing pip.................done. 09:15:35 INFO - Return code: 0 09:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:15:36 INFO - Reading from file tmpfile_stdout 09:15:36 INFO - Output received: 09:15:36 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:15:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15: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:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:36 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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:36 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:15:36 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:15:36 INFO - Using env: {'DISPLAY': ':0', 09:15:36 INFO - 'HOME': '/home/cltbld', 09:15:36 INFO - 'LANG': 'en_US.UTF-8', 09:15:36 INFO - 'LANGUAGE': 'en_US:en', 09:15:36 INFO - 'LOGNAME': 'cltbld', 09:15:36 INFO - 'MAIL': '/var/mail/cltbld', 09:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:36 INFO - 'MOZ_NO_REMOTE': '1', 09:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:36 INFO - 'NO_EM_RESTART': '1', 09:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:36 INFO - 'PWD': '/builds/slave/test', 09:15:36 INFO - 'SHELL': '/bin/bash', 09:15:36 INFO - 'SHLVL': '1', 09:15:36 INFO - 'TERM': 'linux', 09:15:36 INFO - 'TMOUT': '86400', 09:15:36 INFO - 'USER': 'cltbld', 09:15:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:36 INFO - '_': '/tools/buildbot/bin/python'} 09:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:36 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:15:36 INFO - Cleaning up... 09:15:36 INFO - Return code: 0 09:15:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:15: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:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:36 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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:36 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:15:36 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:15:36 INFO - Using env: {'DISPLAY': ':0', 09:15:36 INFO - 'HOME': '/home/cltbld', 09:15:36 INFO - 'LANG': 'en_US.UTF-8', 09:15:36 INFO - 'LANGUAGE': 'en_US:en', 09:15:36 INFO - 'LOGNAME': 'cltbld', 09:15:36 INFO - 'MAIL': '/var/mail/cltbld', 09:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:36 INFO - 'MOZ_NO_REMOTE': '1', 09:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:36 INFO - 'NO_EM_RESTART': '1', 09:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:36 INFO - 'PWD': '/builds/slave/test', 09:15:36 INFO - 'SHELL': '/bin/bash', 09:15:36 INFO - 'SHLVL': '1', 09:15:36 INFO - 'TERM': 'linux', 09:15:36 INFO - 'TMOUT': '86400', 09:15:36 INFO - 'USER': 'cltbld', 09:15:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:36 INFO - '_': '/tools/buildbot/bin/python'} 09:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:36 INFO - Downloading/unpacking psutil>=3.1.1 09:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:38 INFO - Installing collected packages: psutil 09:15:38 INFO - Running setup.py install for psutil 09:15:38 INFO - building 'psutil._psutil_linux' extension 09:15:38 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:15:39 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:15:39 INFO - building 'psutil._psutil_posix' extension 09:15:39 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:15:39 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:15:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:39 INFO - Successfully installed psutil 09:15:39 INFO - Cleaning up... 09:15:39 INFO - Return code: 0 09:15:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:15:39 INFO - Using env: {'DISPLAY': ':0', 09:15:39 INFO - 'HOME': '/home/cltbld', 09:15:39 INFO - 'LANG': 'en_US.UTF-8', 09:15:39 INFO - 'LANGUAGE': 'en_US:en', 09:15:39 INFO - 'LOGNAME': 'cltbld', 09:15:39 INFO - 'MAIL': '/var/mail/cltbld', 09:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:39 INFO - 'MOZ_NO_REMOTE': '1', 09:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:39 INFO - 'NO_EM_RESTART': '1', 09:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:39 INFO - 'PWD': '/builds/slave/test', 09:15:39 INFO - 'SHELL': '/bin/bash', 09:15:39 INFO - 'SHLVL': '1', 09:15:39 INFO - 'TERM': 'linux', 09:15:39 INFO - 'TMOUT': '86400', 09:15:39 INFO - 'USER': 'cltbld', 09:15:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:39 INFO - '_': '/tools/buildbot/bin/python'} 09:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:15:41 INFO - Installing collected packages: mozsystemmonitor 09:15:41 INFO - Running setup.py install for mozsystemmonitor 09:15:41 INFO - Successfully installed mozsystemmonitor 09:15:41 INFO - Cleaning up... 09:15:41 INFO - Return code: 0 09:15:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:15: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:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:15:41 INFO - Using env: {'DISPLAY': ':0', 09:15:41 INFO - 'HOME': '/home/cltbld', 09:15:41 INFO - 'LANG': 'en_US.UTF-8', 09:15:41 INFO - 'LANGUAGE': 'en_US:en', 09:15:41 INFO - 'LOGNAME': 'cltbld', 09:15:41 INFO - 'MAIL': '/var/mail/cltbld', 09:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:41 INFO - 'MOZ_NO_REMOTE': '1', 09:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:41 INFO - 'NO_EM_RESTART': '1', 09:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:41 INFO - 'PWD': '/builds/slave/test', 09:15:41 INFO - 'SHELL': '/bin/bash', 09:15:41 INFO - 'SHLVL': '1', 09:15:41 INFO - 'TERM': 'linux', 09:15:41 INFO - 'TMOUT': '86400', 09:15:41 INFO - 'USER': 'cltbld', 09:15:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:41 INFO - '_': '/tools/buildbot/bin/python'} 09:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:42 INFO - Downloading/unpacking jsonschema==2.5.1 09:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:44 INFO - warning: no files found matching '*.txt' 09:15:44 INFO - no previously-included directories found matching 'build' 09:15:44 INFO - no previously-included directories found matching 'dist' 09:15:44 INFO - no previously-included directories found matching '.git*' 09:15:44 INFO - Installing collected packages: jsonschema, functools32 09:15:44 INFO - Running setup.py install for functools32 09:15:44 INFO - warning: no files found matching '*.txt' 09:15:44 INFO - no previously-included directories found matching 'build' 09:15:44 INFO - no previously-included directories found matching 'dist' 09:15:44 INFO - no previously-included directories found matching '.git*' 09:15:44 INFO - Successfully installed jsonschema functools32 09:15:44 INFO - Cleaning up... 09:15:44 INFO - Return code: 0 09:15:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:15:44 INFO - Using env: {'DISPLAY': ':0', 09:15:44 INFO - 'HOME': '/home/cltbld', 09:15:44 INFO - 'LANG': 'en_US.UTF-8', 09:15:44 INFO - 'LANGUAGE': 'en_US:en', 09:15:44 INFO - 'LOGNAME': 'cltbld', 09:15:44 INFO - 'MAIL': '/var/mail/cltbld', 09:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:44 INFO - 'MOZ_NO_REMOTE': '1', 09:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:44 INFO - 'NO_EM_RESTART': '1', 09:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:44 INFO - 'PWD': '/builds/slave/test', 09:15:44 INFO - 'SHELL': '/bin/bash', 09:15:44 INFO - 'SHLVL': '1', 09:15:44 INFO - 'TERM': 'linux', 09:15:44 INFO - 'TMOUT': '86400', 09:15:44 INFO - 'USER': 'cltbld', 09:15:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:44 INFO - '_': '/tools/buildbot/bin/python'} 09:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:15:44 INFO - Cleaning up... 09:15:44 INFO - Return code: 0 09:15:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:15:44 INFO - Using env: {'DISPLAY': ':0', 09:15:44 INFO - 'HOME': '/home/cltbld', 09:15:44 INFO - 'LANG': 'en_US.UTF-8', 09:15:44 INFO - 'LANGUAGE': 'en_US:en', 09:15:44 INFO - 'LOGNAME': 'cltbld', 09:15:44 INFO - 'MAIL': '/var/mail/cltbld', 09:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:44 INFO - 'MOZ_NO_REMOTE': '1', 09:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:44 INFO - 'NO_EM_RESTART': '1', 09:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:44 INFO - 'PWD': '/builds/slave/test', 09:15:44 INFO - 'SHELL': '/bin/bash', 09:15:44 INFO - 'SHLVL': '1', 09:15:44 INFO - 'TERM': 'linux', 09:15:44 INFO - 'TMOUT': '86400', 09:15:44 INFO - 'USER': 'cltbld', 09:15:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:44 INFO - '_': '/tools/buildbot/bin/python'} 09:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 INFO - Downloading docopt-0.6.1.tar.gz 09:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:47 INFO - Running setup.py install for blobuploader 09:15:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:47 INFO - Running setup.py install for requests 09:15:48 INFO - Running setup.py install for docopt 09:15:48 INFO - Successfully installed blobuploader requests docopt 09:15:48 INFO - Cleaning up... 09:15:48 INFO - Return code: 0 09:15:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:48 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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:48 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:15:48 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:15:48 INFO - Using env: {'DISPLAY': ':0', 09:15:48 INFO - 'HOME': '/home/cltbld', 09:15:48 INFO - 'LANG': 'en_US.UTF-8', 09:15:48 INFO - 'LANGUAGE': 'en_US:en', 09:15:48 INFO - 'LOGNAME': 'cltbld', 09:15:48 INFO - 'MAIL': '/var/mail/cltbld', 09:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:48 INFO - 'MOZ_NO_REMOTE': '1', 09:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:48 INFO - 'NO_EM_RESTART': '1', 09:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:48 INFO - 'PWD': '/builds/slave/test', 09:15:48 INFO - 'SHELL': '/bin/bash', 09:15:48 INFO - 'SHLVL': '1', 09:15:48 INFO - 'TERM': 'linux', 09:15:48 INFO - 'TMOUT': '86400', 09:15:48 INFO - 'USER': 'cltbld', 09:15:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:48 INFO - '_': '/tools/buildbot/bin/python'} 09:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:48 INFO - Running setup.py (path:/tmp/pip-EbFMTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:48 INFO - Running setup.py (path:/tmp/pip-iOsl7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:48 INFO - Running setup.py (path:/tmp/pip-eVoZ5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:48 INFO - Running setup.py (path:/tmp/pip-OYKcxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:48 INFO - Running setup.py (path:/tmp/pip-Bj_9Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:49 INFO - Running setup.py (path:/tmp/pip-nlhEBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:49 INFO - Running setup.py (path:/tmp/pip-ots55r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:49 INFO - Running setup.py (path:/tmp/pip-ZowTSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:49 INFO - Running setup.py (path:/tmp/pip-baQkv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:49 INFO - Running setup.py (path:/tmp/pip-2XzPku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:49 INFO - Running setup.py (path:/tmp/pip-aS9sQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:49 INFO - Running setup.py (path:/tmp/pip-IOeS6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:49 INFO - Running setup.py (path:/tmp/pip-JpUUyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:49 INFO - Running setup.py (path:/tmp/pip-TaK4zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:49 INFO - Running setup.py (path:/tmp/pip-EPWINJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:49 INFO - Running setup.py (path:/tmp/pip-10OcAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:49 INFO - Running setup.py (path:/tmp/pip-IGOdib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:49 INFO - Running setup.py install for manifestparser 09:15:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:49 INFO - Running setup.py install for mozcrash 09:15:50 INFO - Running setup.py install for mozdebug 09:15:50 INFO - Running setup.py install for mozdevice 09:15:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Running setup.py install for mozfile 09:15:50 INFO - Running setup.py install for mozhttpd 09:15:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Running setup.py install for mozinfo 09:15:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Running setup.py install for mozInstall 09:15:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Running setup.py install for mozleak 09:15:50 INFO - Running setup.py install for mozlog 09:15:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Running setup.py install for moznetwork 09:15:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Running setup.py install for mozprocess 09:15:51 INFO - Running setup.py install for mozprofile 09:15:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for mozrunner 09:15:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for mozscreenshot 09:15:51 INFO - Running setup.py install for moztest 09:15:51 INFO - Running setup.py install for mozversion 09:15:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:51 INFO - Cleaning up... 09:15:51 INFO - Return code: 0 09:15:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:51 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:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:51 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:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:51 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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:51 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:15:51 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:15:51 INFO - Using env: {'DISPLAY': ':0', 09:15:51 INFO - 'HOME': '/home/cltbld', 09:15:51 INFO - 'LANG': 'en_US.UTF-8', 09:15:51 INFO - 'LANGUAGE': 'en_US:en', 09:15:51 INFO - 'LOGNAME': 'cltbld', 09:15:51 INFO - 'MAIL': '/var/mail/cltbld', 09:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:51 INFO - 'MOZ_NO_REMOTE': '1', 09:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:51 INFO - 'NO_EM_RESTART': '1', 09:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:51 INFO - 'PWD': '/builds/slave/test', 09:15:51 INFO - 'SHELL': '/bin/bash', 09:15:51 INFO - 'SHLVL': '1', 09:15:51 INFO - 'TERM': 'linux', 09:15:51 INFO - 'TMOUT': '86400', 09:15:51 INFO - 'USER': 'cltbld', 09:15:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:51 INFO - '_': '/tools/buildbot/bin/python'} 09:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:51 INFO - Running setup.py (path:/tmp/pip-mP6yP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:51 INFO - Running setup.py (path:/tmp/pip-sPy4Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:52 INFO - Running setup.py (path:/tmp/pip-fZwTNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:52 INFO - Running setup.py (path:/tmp/pip-LwOuF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:52 INFO - Running setup.py (path:/tmp/pip-Kxx9_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:52 INFO - Running setup.py (path:/tmp/pip-ALVHI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:52 INFO - Running setup.py (path:/tmp/pip-5okvRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:52 INFO - Running setup.py (path:/tmp/pip-ULHIpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:52 INFO - Running setup.py (path:/tmp/pip-h7QWyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:52 INFO - Running setup.py (path:/tmp/pip-9vyXS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:52 INFO - Running setup.py (path:/tmp/pip-tX91XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:52 INFO - Running setup.py (path:/tmp/pip-lE3cKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:52 INFO - Running setup.py (path:/tmp/pip-QL3ljM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:52 INFO - Running setup.py (path:/tmp/pip-h37HxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:52 INFO - Running setup.py (path:/tmp/pip-MUQcqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:52 INFO - Running setup.py (path:/tmp/pip-lW8qTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:53 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:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:53 INFO - Running setup.py (path:/tmp/pip-xgHEb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:55 INFO - Downloading blessings-1.6.tar.gz 09:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:55 INFO - Installing collected packages: blessings 09:15:55 INFO - Running setup.py install for blessings 09:15:55 INFO - Successfully installed blessings 09:15:55 INFO - Cleaning up... 09:15:55 INFO - Return code: 0 09:15:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:55 INFO - Reading from file tmpfile_stdout 09:15:55 INFO - Current package versions: 09:15:55 INFO - argparse == 1.2.1 09:15:55 INFO - blessings == 1.6 09:15:55 INFO - blobuploader == 1.2.4 09:15:55 INFO - docopt == 0.6.1 09:15:55 INFO - functools32 == 3.2.3-2 09:15:55 INFO - jsonschema == 2.5.1 09:15:55 INFO - manifestparser == 1.1 09:15:55 INFO - mozInstall == 1.12 09:15:55 INFO - mozcrash == 1.0 09:15:55 INFO - mozdebug == 0.1 09:15:55 INFO - mozdevice == 0.49 09:15:55 INFO - mozfile == 1.2 09:15:55 INFO - mozhttpd == 0.7 09:15:55 INFO - mozinfo == 0.9 09:15:55 INFO - mozleak == 0.1 09:15:55 INFO - mozlog == 3.4 09:15:55 INFO - moznetwork == 0.27 09:15:55 INFO - mozprocess == 0.25 09:15:55 INFO - mozprofile == 0.28 09:15:55 INFO - mozrunner == 6.13 09:15:55 INFO - mozscreenshot == 0.1 09:15:55 INFO - mozsystemmonitor == 0.3 09:15:55 INFO - moztest == 0.8 09:15:55 INFO - mozversion == 1.4 09:15:55 INFO - psutil == 3.1.1 09:15:55 INFO - requests == 1.2.3 09:15:55 INFO - wsgiref == 0.1.2 09:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:55 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:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:55 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:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:55 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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:55 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:15:55 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:15:55 INFO - Using env: {'DISPLAY': ':0', 09:15:55 INFO - 'HOME': '/home/cltbld', 09:15:55 INFO - 'LANG': 'en_US.UTF-8', 09:15:55 INFO - 'LANGUAGE': 'en_US:en', 09:15:55 INFO - 'LOGNAME': 'cltbld', 09:15:55 INFO - 'MAIL': '/var/mail/cltbld', 09:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:55 INFO - 'MOZ_NO_REMOTE': '1', 09:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:55 INFO - 'NO_EM_RESTART': '1', 09:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:55 INFO - 'PWD': '/builds/slave/test', 09:15:55 INFO - 'SHELL': '/bin/bash', 09:15:55 INFO - 'SHLVL': '1', 09:15:55 INFO - 'TERM': 'linux', 09:15:55 INFO - 'TMOUT': '86400', 09:15:55 INFO - 'USER': 'cltbld', 09:15:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:55 INFO - '_': '/tools/buildbot/bin/python'} 09:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 INFO - Cleaning up... 09:15:55 INFO - Return code: 0 09:15:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15:55 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:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:55 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:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:55 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 0x143e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16dc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', '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:15:55 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:15:55 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:15:55 INFO - Using env: {'DISPLAY': ':0', 09:15:55 INFO - 'HOME': '/home/cltbld', 09:15:55 INFO - 'LANG': 'en_US.UTF-8', 09:15:55 INFO - 'LANGUAGE': 'en_US:en', 09:15:55 INFO - 'LOGNAME': 'cltbld', 09:15:55 INFO - 'MAIL': '/var/mail/cltbld', 09:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:55 INFO - 'MOZ_NO_REMOTE': '1', 09:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:55 INFO - 'NO_EM_RESTART': '1', 09:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:55 INFO - 'PWD': '/builds/slave/test', 09:15:55 INFO - 'SHELL': '/bin/bash', 09:15:55 INFO - 'SHLVL': '1', 09:15:55 INFO - 'TERM': 'linux', 09:15:55 INFO - 'TMOUT': '86400', 09:15:55 INFO - 'USER': 'cltbld', 09:15:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:55 INFO - '_': '/tools/buildbot/bin/python'} 09:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:15:56 INFO - Cleaning up... 09:15:56 INFO - Return code: 0 09:15:56 INFO - Running post-action listener: _resource_record_post_action 09:15:56 INFO - Running post-action listener: _start_resource_monitoring 09:15:56 INFO - Starting resource monitoring. 09:15:56 INFO - [mozharness: 2017-04-05 16:15:56.206936Z] Finished create-virtualenv step (success) 09:15:56 INFO - [mozharness: 2017-04-05 16:15:56.207446Z] Running install step. 09:15:56 INFO - Running pre-action listener: _resource_record_pre_action 09:15:56 INFO - Running main action method: install 09:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:56 INFO - Reading from file tmpfile_stdout 09:15:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:56 INFO - Reading from file tmpfile_stdout 09:15:56 INFO - Output received: 09:15:56 INFO - Usage: mozinstall [options] installer 09:15:56 INFO - Options: 09:15:56 INFO - -h, --help show this help message and exit 09:15:56 INFO - -d DEST, --destination=DEST 09:15:56 INFO - Directory to install application into. [default: 09:15:56 INFO - "/builds/slave/test"] 09:15:56 INFO - --app=APP Application being installed. [default: firefox] 09:15:56 INFO - mkdir: /builds/slave/test/build/application 09:15:56 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:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:16:12 INFO - Reading from file tmpfile_stdout 09:16:12 INFO - Output received: 09:16:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:12 INFO - Running post-action listener: _resource_record_post_action 09:16:12 INFO - [mozharness: 2017-04-05 16:16:12.480005Z] Finished install step (success) 09:16:12 INFO - [mozharness: 2017-04-05 16:16:12.480281Z] Running run-tests step. 09:16:12 INFO - Running pre-action listener: _resource_record_pre_action 09:16:12 INFO - Running main action method: run_tests 09:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:12 INFO - Python 2.7.3 09:16:12 INFO - Return code: 0 09:16:12 INFO - grabbing minidump binary from tooltool 09:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d9400>, '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 0x16da3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16da840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:16:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:16:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:16:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:12 INFO - Return code: 0 09:16:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:12 INFO - ENV: RUST_BACKTRACE is now 1 09:16:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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:16:12 INFO - Using env: {'DISPLAY': ':0', 09:16:12 INFO - 'HOME': '/home/cltbld', 09:16:12 INFO - 'LANG': 'en_US.UTF-8', 09:16:12 INFO - 'LANGUAGE': 'en_US:en', 09:16:12 INFO - 'LOGNAME': 'cltbld', 09:16:12 INFO - 'MAIL': '/var/mail/cltbld', 09:16:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:12 INFO - 'MOZ_NO_REMOTE': '1', 09:16:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:12 INFO - 'NO_EM_RESTART': '1', 09:16:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:12 INFO - 'PWD': '/builds/slave/test', 09:16:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:12 INFO - 'RUST_BACKTRACE': '1', 09:16:12 INFO - 'SHELL': '/bin/bash', 09:16:12 INFO - 'SHLVL': '1', 09:16:12 INFO - 'TERM': 'linux', 09:16:12 INFO - 'TMOUT': '86400', 09:16:12 INFO - 'USER': 'cltbld', 09:16:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540', 09:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:12 INFO - '_': '/tools/buildbot/bin/python'} 09:16:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:16:12 INFO - mozversion application_buildid: 20170405151816 09:16:12 INFO - mozversion application_changeset: 720b9177c6856c1c4339d0fac1bf5149c0d53950 09:16:12 INFO - mozversion application_display_name: Nightly 09:16:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:12 INFO - mozversion application_name: Firefox 09:16:12 INFO - mozversion application_remotingname: firefox 09:16:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:16:12 INFO - mozversion application_vendor: Mozilla 09:16:12 INFO - mozversion application_version: 55.0a1 09:16:12 INFO - mozversion platform_buildid: 20170405151816 09:16:12 INFO - mozversion platform_changeset: 720b9177c6856c1c4339d0fac1bf5149c0d53950 09:16:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:16:12 INFO - mozversion platform_version: 55.0a1 09:16:12 INFO - using testdate: 1491408972 09:16:12 INFO - actual date: 1491408972 09:16:12 INFO - starting webserver on 'localhost:39252' 09:16:12 INFO - SUITE-START | Running 2 tests 09:16:12 INFO - TEST-START | dromaeo_css 09:16:12 INFO - operating with platform_type : linux_ 09:16:12 INFO - Initialising browser for dromaeo_css test... 09:16:12 INFO - TEST-INFO | started process 12433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLantor/profile http://localhost:39252/getInfo.html) 09:16:16 INFO - PID 12433 | __metrics Screen width/height:1600/1200 09:16:16 INFO - PID 12433 | colorDepth:24 09:16:16 INFO - PID 12433 | Browser inner width/height: 1024/697 09:16:16 INFO - PID 12433 | __metrics 09:16:17 INFO - PID 12433 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:16:17 INFO - PID 12433 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:18 INFO - TEST-INFO | 12433: exit 0 09:16:18 INFO - Browser initialized. 09:16:18 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:18 INFO - TEST-INFO | started process 12528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLantor/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:30 INFO - PID 12528 | RSS: Main: 149811200 09:16:30 INFO - PID 12528 | 09:19:33 INFO - PID 12528 | Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39252/tests/dromaeo/cssquery-ext.html) 09:19:35 INFO - PID 12528 | RSS: Main: 289034240 09:19:35 INFO - PID 12528 | 09:21:20 INFO - PID 12528 | ************************* 09:21:20 INFO - PID 12528 | A coding exception was thrown and uncaught in a Task. 09:21:20 INFO - PID 12528 | 09:21:20 ERROR - PID 12528 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:21:20 INFO - PID 12528 | Full stack: 09:21:20 INFO - PID 12528 | ************************* 09:21:20 INFO - PID 12528 | ************************* 09:21:20 INFO - PID 12528 | A coding exception was thrown and uncaught in a Task. 09:21:20 INFO - PID 12528 | 09:21:20 ERROR - PID 12528 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:21:20 INFO - PID 12528 | Full stack: 09:21:20 INFO - PID 12528 | ************************* 09:21:20 INFO - PID 12528 | ************************* 09:21:20 INFO - PID 12528 | A coding exception was thrown and uncaught in a Task. 09:21:20 INFO - PID 12528 | 09:21:20 ERROR - PID 12528 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:21:20 INFO - PID 12528 | Full stack: 09:21:20 INFO - PID 12528 | ************************* 09:21:20 INFO - PID 12528 | ************************* 09:21:20 INFO - PID 12528 | A coding exception was thrown and uncaught in a Task. 09:21:20 INFO - PID 12528 | 09:21:20 ERROR - PID 12528 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:21:20 INFO - PID 12528 | Full stack: 09:21:20 INFO - PID 12528 | ************************* 09:22:37 INFO - PID 12528 | Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-ext.html (next: http://localhost:39252/tests/dromaeo/cssquery-jquery.html) 09:22:38 INFO - PID 12528 | RSS: Main: 227352576 09:22:38 INFO - PID 12528 | 09:25:39 INFO - PID 12528 | Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39252/tests/dromaeo/cssquery-mootools.html) 09:25:40 INFO - PID 12528 | RSS: Main: 210145280 09:25:40 INFO - PID 12528 | 09:28:42 INFO - PID 12528 | Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39252/tests/dromaeo/cssquery-prototype.html) 09:28:42 INFO - PID 12528 | RSS: Main: 194547712 09:28:42 INFO - PID 12528 | 09:31:45 INFO - PID 12528 | Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39252/tests/dromaeo/cssquery-yui.html) 09:31:46 INFO - PID 12528 | RSS: Main: 182718464 09:31:46 INFO - PID 12528 | 09:34:48 INFO - PID 12528 | Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-yui.html (next: http://localhost:39252/tests/dromaeo/cssquery-dojo.html) 09:34:49 INFO - PID 12528 | RSS: Main: 277917696 09:34:49 INFO - PID 12528 | 09:34:49 INFO - PID 12528 | __start_tp_report 09:34:49 INFO - PID 12528 | _x_x_mozilla_page_load 09:34:49 INFO - PID 12528 | _x_x_mozilla_page_load_details 09:34:49 INFO - PID 12528 | |i|pagename|runs| 09:34:49 INFO - PID 12528 | |0;dojo.html;3317.0878008547647;3340.1816554944044;3355.6812102850236;3364.1421437533427;3394.7793393429424;5816.709164541777;5901.911471327933;6006.909896351558;6015.518758499321;6015.5488338374635;5878.853028674285;5970.761169553212;5977.970110149454;6071.969640151804;6086.573939824214;5213.374395072597;5279.9208011879855;5290.523852853233;5300.045991721508;5336.066188417031;5256.185291279858;5378.273933019032;5392.757325920324;5401.972990135064;5422.511973922346;5139.408967968657;5169.302144210521;5341.172118321666;5343.8396848094235;5386.676799392029;5217.47825217479;5248.081585722483;5253.527182553588;5269.789208431658;5283.788648454057;5263.815766448156;5273.736313184326;5278.868028299285;5288.867778305535;5300.284461597674;5721.170430287627;5986.97006514969;5997.910031349533;6010.8497287567725;6017.277926648786;6241.3446588108045;6251.624902505864;6435.613863168225;6496.577722448026;6526.510511711641;6496.187976502937;6502;6502.804915852532;6506.186726659168;6509.9023514647315;6010.519158467312;6021;6025.397460253984;6026.578139530235;6030.306514750772;6289.7169627366875;6397.904031439439;6555.803325900135;6556.606603603799;6602.40578347951;6118.694065296718;6161.537884658668;6368.395002474757;6372.076048972873;6373.5857169283845;6207.503399728011;6213.03697926822;6429.324920883333;6430.485561155097;6502.317256688074;6376.234851817719;6454.483641308684;6460.870782584322;6469.417752402306;6470.352964703492;6414.711337989802;6432.453241474527;6438;6439.54923155384;6454.5159113065765;4789.4971028042255;4839.467658557556;4871.805127794849;4922.4093108826455;4925.38432695913;4351.82592696295;4357.477102747627;4368.4102646143;4382.7370357778;4404.273294906368;6061.605995610271;6078.088286757022;6086.847828804227;6090.847728806815;6117.663528505975;6114.358196333954;6261.029540421242;6475.417212450902;6525.086487891699;6566.671666416755;6006.789762358384;6060.2424696912885;6060.424259695322;6072.453479186895;6112.449879510866;5494.36814766307;5505.752241149158;5508.228847961289;5508.779648814083;5512.614117011771;6496.0580715795;6585.868282634225;6737.663116844236;6820.249772525019;6837.794866154023;6511.120998665309;6514.055461958084;6539.247986481425;6539.836504087436;6545.37818907203;6781.152355955505;6793.286704895915;6835.7949261522235;6848.623325717133;6854.897176542456;6135.569531795875;6214.5028397727165;6426.228852537725;6434.806955791334;6445.871082578416;6418.967905160631;6519.380658837403;6550.6069635822005;6568.80293591193;6572.474202063919;6371.96814015927;6374.107624932606;6377.266614339411;6380.712867920862;6388.265349484869;6056.606320589148;6079.270487541523;6138.846528836815;6270.686465676789;6345.777897773556;6333.176687030841;6337;6340.682965851781;6343.429091381798;6351.2696039956;6320.494360451245;6371.93628063732;6385.265694445198;6387.744490220339;6393.2647745508;5942.940570594239;5963.344032156372;6195.473384762346;6196.194494715658;6202.81391558254 09:34:49 INFO - PID 12528 | |1;ext.html;696.9059177011105;750.9023826902502;766.39837727384;1144.656603019094;1148.2536351371607;32950;33638.32723345532;33662.15844603886;33667.653293868214;33673.49489757649;40606.59393406072;41465.7926710366;41520.58479415205;41669.16661666765;41691.58308416915;8285.875711864326;8379.287760540361;8427.578621068922;8444;8449.619767110495;6044.486218671396;8251.504909705407;8387.077421483631;8387.664493420256;8388;6349.365063493637;8009.759707208764;8296.170382961685;8405.285550728166;8405.789855253606;8438.704645337415;8495.235428811375;8495.957520212422;8506.574671266411;8513.659453621847;5923.200367950358;8266.297364723945;8318.168183181693;8352.081271060179;8356.164383561656;30155.698443015728;38357.424638630444;38819.41770873439;38919.61080389188;38970.61029389726;3296.6373698893344;3340.66593340664;3343.0472315389998;3343.632200457948;3343.8996830095134;30950.583647861535;31108.37783244345;31173.220669483217;31194.220144496343;31230.21924451907;3965.365541513344;3974.225026119908;3989.9202015959518;3995.7402768820225;4065.918681626351;207402;208291;208615.95692021595;209301;209354;50926.49073509217;51009.48990510122;51189.48810511922;51229.7438512805;51246;52994.20508692373;53189.468105318454;53239.46760532345;53292.733536332846;53387.46612533825;15250.389984400721;15502.992305500107;15601.531954041397;15609.765853512206;15618.76571851423;12717.364131793373;12728.554500592434;12731.363431828557;12735.363231838372;12737.617871463872;12067.396630168456;12236.877631223751;13658.863411365957;13816.447342106405;13859.168449893039;4958.479359667255;5178.275041494194;5197.22041693749;5217.3999990000875;5231.24146998683;1026.9691909242736;1027.3117011602244;1035.4615599888016;1037.7820657661825;1053.3837704942541;25327.873360633446;25577.872110639328;25910.481790364087;25919.870400647877;26023;1127.9718007049726;1128.5831772737677;1157.6816375496637;1164.1036401970605;1167.7430965187646;13488.460461581622;13522.12106213093;13715.1085179465;13747.862521374858;13758.793618095737;280604;280929;283487;283550;284231;55012.44987550153;55172.17241741377;55174;55836.16245756317;55882.720586396805;1389.6942672612008;1461.853834186237;1474.1449959023741;1486.6283429142713;1497.5432493089495;23852.57439679547;25330.873345633154;25368;25416.618750718386;25703;40892.59107408888;40935.7953210232;40967.38548921828;40973.795131024155;40980.59019409768;295881;296090;296878;297397;298342;33868;34454;34479.827600861834;34550.30899382049;34576.82711586426;32968.67031329656;39766.60233397629;43289.567104328555;44298.11403771971;44838;34862;35033.124171895906;35051.474227886094;35154.64845351616;35637.82181089078;34886.476702849985;34898.47652285269;34914.82542587372;35001.64998350086;35054;40184.799076004434;40635;40837.591624083376;41455.37816932809;41940.790296048326;33977.49033764446;34140.31719365648;34218.657813421545;34239;34371.14072148217;26532.8673356632;27306.317342065813;27547.8481968161;27696;27878.721212788423 09:34:49 INFO - PID 12528 | |2;jquery.html;438.6030642268744;450.113276844616;455.51942700451013;461.26198083067095;464.91399091168137;21445.892770536146;22104.778952210472;22293.777062229372;22552.88723556384;22841.77158228417;22718.772812271873;22905.083796648116;23021;23066.538669226604;23152;5952.4047595240345;6006.129111278862;6045.153678485016;6087.0869369594475;6152.230971128609;5950.70246487676;6013.939860601382;6031.185789918349;6036.1851150094835;6051.1830902828215;5913.497352725002;6114;6121.326654068049;6148.84627884302;6149.323574406834;6043.486303664194;6133.969330153343;6152;6168.537359698041;6174.722137503823;5568.470995255444;5576.693281869496;5603.635763675348;5603.971980140073;5607.355154157283;25658.87170564154;26709.599356009676;27175.45649087027;27284.863575681993;27419.725802742116;2180.967285490719;2203.063697928374;2206.6689996500654;2207.249535158054;2207.2826331442184;17228.741568876478;17346;17793.377231796825;18098.547536311566;18262.72605910899;2294.7626064586893;2334.4514039200944;2335.1826860598826;2341.2156927429332;2351.8118550516087;102892.48553757257;105432.94567054308;110486;111088.44455777669;115306;12346.259224446561;12528.436220370106;12588.81116783249;12601.495940162475;12611.49554017829;17768.11159442023;17785.19966601506;17789.644207115784;17793.555161120818;17800.37698680566;8595.355348348774;8999.235065019415;9016.729498115066;9132.086791320948;9440.197583205505;8304.211099945496;8316.958415207886;8341.541215233221;8548.059713431518;8696.478211307342;7813.765587032398;7896.842063158705;7897.68409263623;7941.841163176704;8034.758957231293;2176.662617294322;2196.967045494319;2263.3096905443667;2279.8062164715852;2412.650165725995;967.5631686944881;975.4439969217619;984.4979060678962;985.103555764251;1008.9041541053588;20939.790602093784;21052.684209736864;21113;21167.25914592982;21252.574948500944;1028.388109075099;1034.462079718542;1046.581367453025;1054.8048611006989;1063.4363787192801;10456.581736730446;11389.202755807013;11420.14348923834;11442.54229830814;11452.885471145182;575013;592585;607368;608110.0267967872;609491;76981;102545;104917.47541262244;105205;111369.44315278372;1175.1421462332546;1188.6552899659002;1222.49877550204;1222.896053835416;1223.651259391087;19968.800311997275;20039.29862454807;20221.59556808826;20761.89619051895;20809.1676332945;49839.252411214584;49898;50024.74987625039;50691.49308506868;50852.74573627256;63447.6827615859;69290.65354673195;71194;71598.28401715917;72458.63770681113;9555.569999349907;9693;9775;9802.607895684092;10220.437875916896;14392.568222953329;15414.84585154134;15436.768448473507;15937;16091.114988675736;13021.47914083464;13188.142770719873;13394.665133371744;13599.932000339935;13608.251546165056;11606.76786464249;12049.578264760692;12083.160457292704;12268;12360.505579776709;13483.865161348653;13535.59393218205;13589.592312230649;13676.589702308947;13827.239501827496;9659.420434773936;9699.951500242454;9841.655542055994;9952.950235249067;10016.949915250669;12915.806262905877;13174.538891138764;13183.53857614979;13204.669883252996;13314.134581252187 09:34:49 INFO - PID 12528 | |3;mootools.html;1350.9459621615135;1386.9722605547888;1396.1343966740617;1402.6773842016341;1402.9158250504968;11152.553897844087;11613.245139065966;11623;11624;11628.069754419646;11259.831102533468;11595.826062609047;11780.646580602595;11947.701307467318;11950.103742219324;2375.8099352051836;2441.59713647248;2443.0838435586656;2450.669159663449;2452.2030340139436;2012.688033354825;2336.9532609347802;2393.3537944754908;2444.5844206484853;2449.0938352809485;2098.380977611608;2377.762223777626;2421.806255499556;2428.2351059416314;2450.0812195426715;2325.395397196724;2345.226075395124;2349.189529612281;2352.3883790214495;2418.0327868852423;2277.1802151225547;2307.180950762472;2307.6192428249487;2308.9191878284346;2311.9653205201935;11493.482793274323;11610;11672.35802030888;11697.47361368732;11714.472848721827;6360;6566.244881838602;6578.0132980052895;6582.868342633168;6593.20881494219;4024.4121701260588;4149.792510374469;4201.600847919473;4209.789510524462;4265.808038638269;1282.4613662261872;1311.4426368793224;1352.6821197018692;1360.2314692198975;1369.9726005479934;15247.847521524754;15528;15553.144577048259;15564.766528501968;15574.532764017098;5491.36849262332;5511.944880551143;5639.154126880919;5905.645661260338;5909.438603332676;14650.340734666966;14686.045407048508;14698.41206351734;14701.338439770236;14733;6602.636854973022;6607.306232845578;6608.966955165193;6611.86776264472;6615.768448104293;5927.1405646181065;5991.850203744942;6018.21763170785;6083.847903802441;6088;4496.3705081288645;4576.977115114403;4593.565410332529;4619.930701039487;4662.347271382009;1252.8684488128797;1281.2504684759333;1320.3662242123835;1350.0954360578437;1350.8176396186389;815.975520734379;820.5938060659893;831.584207896052;835.1856939484076;861.4443683824023;6654.900176497356;6766.25571187169;6878.759243426456;6947.652617369111;7112.928870711226;627.1564745417406;629.9779507717208;631.2393565753256;632.7437387857925;717.727263639824;4158.313878210061;4400.537943515948;4502;4534.750588717652;4590.265557510849;15011.549653510412;15770.369185232463;15771.842281577266;15772.76340854888;15803.525894223192;14503.709925801635;15127;15135.394584216509;15683.843161568238;15699.68600627981;10826.484292199098;10992.780144397067;11042.227044106996;11108.333499989865;11111.388873611868;6746.224184218878;7022.719091236293;7070.505064645426;7120.786376408716;7141.535800172972;13868.959828012737;13975.371108300355;14084.718305633625;14089.718205636034;14230.359633816295;14292.499762508678;14361.281935903373;14400.495982640557;14463.783043254149;14594.708105837612;9461.432314061178;9665.468399238109;9768.85346719814;9770.511474426392;9812.754681133028;10518.789624207626;10539.156867450432;10555.577776889146;10638;10667.359958402521;8895.198012626002;8915.475109510153;9024.097590240923;9274.118958698913;9279.025702301431;8698;8714.128587141235;8757.299416046828;8819.162179593184;8897;7701.614919254127;7843.333316668147;7921.841563168819;7927.61266778323;7953.164917683791;5854.648721076579;5893.882122357614;5968.343482216866;6125.081237814364;6187.319394866471;5866.2960444746905;5935.614185077956;5978.551608629283;6004.39956004396;6277.529185311028 09:34:49 INFO - PID 12528 | |4;prototype.html;413.7993073359422;422.9281022226221;430.5823351349191;434.1555674213654;436.36726746217994;5565.916511252334;5697.344805347387;5790.652560846347;5844.94790937631;5895.882082358356;5581.888362232753;5699.74351154198;5709.2292540507015;5745.770169193238;5754.942450575493;4542.364069030346;4546.704464209833;4558.247889098295;4561.863144105682;4573.7713114344315;4413.117376524708;4476.418065651461;4525.411696479453;4561.536770144118;4598.494165641793;4496.505384407713;4501.684882058241;4538.29656403258;4540.818367265322;4551.886202844922;4504.369388285642;4512.887177820581;4514.796834142471;4525.343825145368;4529.796159172813;4048.3725022621543;4058.5129784425762;4127.628513433805;4134.857508293689;4139.730917490354;5611.775528978836;5619.859503512404;5629.324481062258;5638.830835074954;5644.379118296984;5302.416734159239;5348.679079255218;5357.544608708265;5358.812441564526;5362.276092727471;5873.3245676746865;6028;6075.7873474428625;6082.817515474543;6109.175261339707;4558.316252562109;4586.816527338902;4596.701214421052;4596.816127354902;4609.147307748078;6216.844578885519;6276.403741644536;6327.968360158216;6336.303006669263;6348.873022539523;4688.835890743808;4725.40932383452;4725.834595789131;4736.692115012514;4738.597219236403;4807.230843065093;4807.807687692523;4811.422629284508;4814.735189564538;4832;5197.688138711689;5313.2561441397465;5352.437994010651;5355.250264962909;5387.757550910218;5854.121881717691;6100.72546735398;6101.328853826076;6111.480524155408;6118.1434599156155;1559.1113065552527;1624.8862579619313;1654.4374912529556;1663.991680041592;1672.3645014894262;1176.5470293936726;1191.9702007449882;1205.7287110400089;1208.456194712383;1211.6849619099098;5802.912956305659;5803.941960580424;5828.59199856006;5832.475077242983;5837.09525023622;6205.782797602063;6232.937670623326;6280.434760871452;6284.528660350492;6288.779892703825;5662.150677398423;5755.280589926259;5760.279965004374;5798.362180160263;5825.097109947965;3294.9670503295138;3310.8344582771247;3310.8841190558214;3310.9172270692943;3313.7680362374886;6242.375762423721;6426.646534440651;6451.935480645134;6514.83050847458;6526.477881769447;6300.243970723451;6322.7354529093445;6345;6361.586496877688;6379.234491860913;6270.341614130633;6452.354764523604;6456.612603243821;6482.935170648328;6521.804345869631;6233.719482623203;6263.718132683949;6268.561200716089;6287.434130928238;6299.464545513682;6193.84515387119;6219.4811101503965;6222.160008398808;6250.656003998501;6265.248170219603;6352.142460767737;6480.481561474976;6520.902186467112;6528.575642583217;6542.149520562297;4450.532694067206;4451.265541185668;4465.799039043316;4475.328700694922;4491.416115904912;5876.206712093813;5901.173835662925;6301.96849015752;6305.747770089145;6349;5967.224260846062;6021.9397806023135;6038.365971572922;6051.848703782264;6088.786892458743;5997.190379298739;6030.30651475086;6040.1241819934985;6047.244094488189;6101.6644084574;5867.501262392744;6074.665893375906;6117.938820611737;6142.600730952474;6143.416375444325;6117.174181485442;6163.599366041193;6166.352532984151;6178.66017369049;6204.224471941007;5860.794872179454;5870.383609720918;5941.306727582618;5941.465268125889;5999.220101386792 09:34:49 INFO - PID 12528 | |5;yui.html;779.3297763923025;802.2779498451393;826.0459169659043;835.8495470815251;837.2130197614242;15123.24383780812;15296.311665975016;15736.763948540767;15930.442434514795;16150.676986460263;14821.55535333939;14934;15430;15487.303071361788;15844.76232856508;940.0458534587416;979.1285755677453;987.1855719031792;987.239825334492;987.856760769688;972.6158167523823;1012.0284526854192;1024.8257796174669;1026.1329176845554;1027.0499787696351;991.613270824379;1055.7044027672225;1055.978880422391;1055.984160237597;1057.1595581512715;991.7619771254883;1051.8948105189497;1054.847047178155;1056.5298442193189;1057.4237040812698;727.1528669100492;757.7120694136192;774.9767506974799;775.0621747685308;775.6819703921421;15735.92132039344;16126.596835079099;16129.193540322936;16129.91935040329;16313.510594682179;14417.92791036038;15494.457693980768;15649.374025038986;15719.449819256386;16246.350145994145;13891.4443422263;13904.513342033082;13912.165270083726;13923.164610123426;13962.93018534911;3212.7429805615493;3229.4832826747843;3229.7416206703406;3231.1437469070715;3234.8059116453087;73766.63116684435;74860.99999999946;74981.25018749852;75883;76339.61830190869;11215.271007384494;11431.714207144722;11513;11608.883911160949;12179.817302740466;21157.471063223544;21245.57508849845;21492.57014859694;21873.453163670718;21878.45303867416;7532.887006694904;7610.4672672913475;7629.809254768676;7655;7869.988778438673;4060.309747342959;4119.299719047769;4145.2124096421585;4197.370394440858;4215.430916826251;4218.156368726206;4234.364845273234;4249.511306199826;4267.765272909957;4328.805203765838;768.4774353439715;778.8052986753312;791.5013541468837;791.782259878538;794.5709316968888;674.6660403100399;678.1827897383641;683.1911254362584;707.6391040569347;722.7253643615393;9647.324687271823;10536.631217907336;10573.894261057445;11035.83446248307;11067;666.9533132680763;677.5528151420137;686.2142846440797;701.0430762009921;723.1936390924081;4575.542445755398;4664.230401983703;4874.658773885794;5049.081398695821;5052.216198979571;76226.61886690531;76271;77255.2274477248;78105;80435;66561.66719166373;66910.21764661845;70000;70364.64817675878;71327.64336178286;45002.09995800131;57748.42251577514;58970.11544826831;59483.107753382865;64130.45651782631;10101.44442055694;10751.505760627671;10781.9460902695;10893.346399216072;10993.340399576051;31486.685133148374;31813.20466988344;31931.36137277288;32273.677263228008;32281.838590807834;37807.24385512329;38111.80944095262;38321.80839095786;38372.23255534818;39002.60997390103;13305.841649900602;13434.93282533581;13481.32593370308;13535;13738.450461981409;14794.260286985393;14991.325390357679;15024.549263522113;15108.244587770787;15382.615434614225;13264.071514993857;14034.719305613626;14191.858081419054;14772;15313.923430383222;13619.931900340434;13817.930910345383;13894.305284735521;14327.713445731235;14501.709965800836;12631.115821892747;12671.746565068832;13736.93131534336;13946.72252020754;14181.14913105217;9543.4751088688;9654.15863808817;10157.542910568895;10163.491825408848;10210.336328138646;11407.25852819564;11495.597654082067;11631.360275184947;11704.122190835891;11745.706357341134 09:34:49 INFO - PID 12528 | __end_tp_report 09:34:49 INFO - PID 12528 | __start_cc_report 09:34:49 INFO - PID 12528 | _x_x_mozilla_cycle_collect,1359 09:34:49 INFO - PID 12528 | __end_cc_report 09:34:49 INFO - PID 12528 | __startTimestamp1491410089031__endTimestamp 09:34:49 INFO - PID 12528 | 09:34:49 INFO - PID 12528 | ------- Summary: start ------- 09:34:49 INFO - PID 12528 | Number of tests: 6 09:34:49 INFO - PID 12528 | 09:34:49 INFO - PID 12528 | [#0] dojo.html Cycles:165 Average:5945.22 Median:6138.85 stddev:729.23 (11.9%) stddev-sans-first:701.72 09:34:49 INFO - PID 12528 | Values: 3317.1 3340.2 3355.7 3364.1 3394.8 5816.7 5901.9 6006.9 6015.5 6015.5 5878.9 5970.8 5978.0 6072.0 6086.6 5213.4 5279.9 5290.5 5300.0 5336.1 5256.2 5378.3 5392.8 5402.0 5422.5 5139.4 5169.3 5341.2 5343.8 5386.7 5217.5 5248.1 5253.5 5269.8 5283.8 5263.8 5273.7 5278.9 5288.9 5300.3 5721.2 5987.0 5997.9 6010.8 6017.3 6241.3 6251.6 6435.6 6496.6 6526.5 6496.2 6502.0 6502.8 6506.2 6509.9 6010.5 6021.0 6025.4 6026.6 6030.3 6289.7 6397.9 6555.8 6556.6 6602.4 6118.7 6161.5 6368.4 6372.1 6373.6 6207.5 6213.0 6429.3 6430.5 6502.3 6376.2 6454.5 6460.9 6469.4 6470.4 6414.7 6432.5 6438.0 6439.5 6454.5 4789.5 4839.5 4871.8 4922.4 4925.4 4351.8 4357.5 4368.4 4382.7 4404.3 6061.6 6078.1 6086.8 6090.8 6117.7 6114.4 6261.0 6475.4 6525.1 6566.7 6006.8 6060.2 6060.4 6072.5 6112.4 5494.4 5505.8 5508.2 5508.8 5512.6 6496.1 6585.9 6737.7 6820.2 6837.8 6511.1 6514.1 6539.2 6539.8 6545.4 6781.2 6793.3 6835.8 6848.6 6854.9 6135.6 6214.5 6426.2 6434.8 6445.9 6419.0 6519.4 6550.6 6568.8 6572.5 6372.0 6374.1 6377.3 6380.7 6388.3 6056.6 6079.3 6138.8 6270.7 6345.8 6333.2 6337.0 6340.7 6343.4 6351.3 6320.5 6371.9 6385.3 6387.7 6393.3 5942.9 5963.3 6195.5 6196.2 6202.8 09:34:49 INFO - PID 12528 | 09:34:49 INFO - PID 12528 | [#1] ext.html Cycles:180 Average:42873.08 Median:34466.91 stddev:69338.26 (201.2%) stddev-sans-first:69460.45 09:34:49 INFO - PID 12528 | Values: 696.9 750.9 766.4 1144.7 1148.3 32950.0 33638.3 33662.2 33667.7 33673.5 40606.6 41465.8 41520.6 41669.2 41691.6 8285.9 8379.3 8427.6 8444.0 8449.6 6044.5 8251.5 8387.1 8387.7 8388.0 6349.4 8009.8 8296.2 8405.3 8405.8 8438.7 8495.2 8496.0 8506.6 8513.7 5923.2 8266.3 8318.2 8352.1 8356.2 30155.7 38357.4 38819.4 38919.6 38970.6 3296.6 3340.7 3343.0 3343.6 3343.9 30950.6 31108.4 31173.2 31194.2 31230.2 3965.4 3974.2 3989.9 3995.7 4065.9 207402.0 208291.0 208616.0 209301.0 209354.0 50926.5 51009.5 51189.5 51229.7 51246.0 52994.2 53189.5 53239.5 53292.7 53387.5 15250.4 15503.0 15601.5 15609.8 15618.8 12717.4 12728.6 12731.4 12735.4 12737.6 12067.4 12236.9 13658.9 13816.4 13859.2 4958.5 5178.3 5197.2 5217.4 5231.2 1027.0 1027.3 1035.5 1037.8 1053.4 25327.9 25577.9 25910.5 25919.9 26023.0 1128.0 1128.6 1157.7 1164.1 1167.7 13488.5 13522.1 13715.1 13747.9 13758.8 280604.0 280929.0 283487.0 283550.0 284231.0 55012.4 55172.2 55174.0 55836.2 55882.7 1389.7 1461.9 1474.1 1486.6 1497.5 23852.6 25330.9 25368.0 25416.6 25703.0 40892.6 40935.8 40967.4 40973.8 40980.6 295881.0 296090.0 296878.0 297397.0 298342.0 33868.0 34454.0 34479.8 34550.3 34576.8 32968.7 39766.6 43289.6 44298.1 44838.0 34862.0 35033.1 35051.5 35154.6 35637.8 34886.5 34898.5 34914.8 35001.6 35054.0 40184.8 40635.0 40837.6 41455.4 41940.8 33977.5 34140.3 34218.7 34239.0 34371.1 26532.9 27306.3 27547.8 27696.0 27878.7 09:34:49 INFO - PID 12528 | 09:34:49 INFO - PID 12528 | [#2] jquery.html Cycles:180 Average:34820.39 Median:12560.79 stddev:98772.90 (786.4%) stddev-sans-first:99016.25 09:34:49 INFO - PID 12528 | Values: 438.6 450.1 455.5 461.3 464.9 21445.9 22104.8 22293.8 22552.9 22841.8 22718.8 22905.1 23021.0 23066.5 23152.0 5952.4 6006.1 6045.2 6087.1 6152.2 5950.7 6013.9 6031.2 6036.2 6051.2 5913.5 6114.0 6121.3 6148.8 6149.3 6043.5 6134.0 6152.0 6168.5 6174.7 5568.5 5576.7 5603.6 5604.0 5607.4 25658.9 26709.6 27175.5 27284.9 27419.7 2181.0 2203.1 2206.7 2207.2 2207.3 17228.7 17346.0 17793.4 18098.5 18262.7 2294.8 2334.5 2335.2 2341.2 2351.8 102892.5 105432.9 110486.0 111088.4 115306.0 12346.3 12528.4 12588.8 12601.5 12611.5 17768.1 17785.2 17789.6 17793.6 17800.4 8595.4 8999.2 9016.7 9132.1 9440.2 8304.2 8317.0 8341.5 8548.1 8696.5 7813.8 7896.8 7897.7 7941.8 8034.8 2176.7 2197.0 2263.3 2279.8 2412.7 967.6 975.4 984.5 985.1 1008.9 20939.8 21052.7 21113.0 21167.3 21252.6 1028.4 1034.5 1046.6 1054.8 1063.4 10456.6 11389.2 11420.1 11442.5 11452.9 575013.0 592585.0 607368.0 608110.0 609491.0 76981.0 102545.0 104917.5 105205.0 111369.4 1175.1 1188.7 1222.5 1222.9 1223.7 19968.8 20039.3 20221.6 20761.9 20809.2 49839.3 49898.0 50024.7 50691.5 50852.7 63447.7 69290.7 71194.0 71598.3 72458.6 9555.6 9693.0 9775.0 9802.6 10220.4 14392.6 15414.8 15436.8 15937.0 16091.1 13021.5 13188.1 13394.7 13599.9 13608.3 11606.8 12049.6 12083.2 12268.0 12360.5 13483.9 13535.6 13589.6 13676.6 13827.2 9659.4 9700.0 9841.7 9953.0 10016.9 12915.8 13174.5 13183.5 13204.7 13314.1 09:34:49 INFO - PID 12528 | 09:34:49 INFO - PID 12528 | [#3] mootools.html Cycles:180 Average:7296.28 Median:2446.84 stddev:4703.75 (192.2%) stddev-sans-first:4695.72 09:34:49 INFO - PID 12528 | Values: 1350.9 1387.0 1396.1 1402.7 1402.9 11152.6 11613.2 11623.0 11624.0 11628.1 11259.8 11595.8 11780.6 11947.7 11950.1 2375.8 2441.6 2443.1 2450.7 2452.2 2012.7 2337.0 2393.4 2444.6 2449.1 2098.4 2377.8 2421.8 2428.2 2450.1 2325.4 2345.2 2349.2 2352.4 2418.0 2277.2 2307.2 2307.6 2308.9 2312.0 11493.5 11610.0 11672.4 11697.5 11714.5 6360.0 6566.2 6578.0 6582.9 6593.2 4024.4 4149.8 4201.6 4209.8 4265.8 1282.5 1311.4 1352.7 1360.2 1370.0 15247.8 15528.0 15553.1 15564.8 15574.5 5491.4 5511.9 5639.2 5905.6 5909.4 14650.3 14686.0 14698.4 14701.3 14733.0 6602.6 6607.3 6609.0 6611.9 6615.8 5927.1 5991.9 6018.2 6083.8 6088.0 4496.4 4577.0 4593.6 4619.9 4662.3 1252.9 1281.3 1320.4 1350.1 1350.8 816.0 820.6 831.6 835.2 861.4 6654.9 6766.3 6878.8 6947.7 7112.9 627.2 630.0 631.2 632.7 717.7 4158.3 4400.5 4502.0 4534.8 4590.3 15011.5 15770.4 15771.8 15772.8 15803.5 14503.7 15127.0 15135.4 15683.8 15699.7 10826.5 10992.8 11042.2 11108.3 11111.4 6746.2 7022.7 7070.5 7120.8 7141.5 13869.0 13975.4 14084.7 14089.7 14230.4 14292.5 14361.3 14400.5 14463.8 14594.7 9461.4 9665.5 9768.9 9770.5 9812.8 10518.8 10539.2 10555.6 10638.0 10667.4 8895.2 8915.5 9024.1 9274.1 9279.0 8698.0 8714.1 8757.3 8819.2 8897.0 7701.6 7843.3 7921.8 7927.6 7953.2 5854.6 5893.9 5968.3 6125.1 6187.3 5866.3 5935.6 5978.6 6004.4 6277.5 09:34:49 INFO - PID 12528 | 09:34:49 INFO - PID 12528 | [#4] prototype.html Cycles:180 Average:5165.12 Median:5794.51 stddev:1470.71 (25.4%) stddev-sans-first:1430.95 09:34:49 INFO - PID 12528 | Values: 413.8 422.9 430.6 434.2 436.4 5565.9 5697.3 5790.7 5844.9 5895.9 5581.9 5699.7 5709.2 5745.8 5754.9 4542.4 4546.7 4558.2 4561.9 4573.8 4413.1 4476.4 4525.4 4561.5 4598.5 4496.5 4501.7 4538.3 4540.8 4551.9 4504.4 4512.9 4514.8 4525.3 4529.8 4048.4 4058.5 4127.6 4134.9 4139.7 5611.8 5619.9 5629.3 5638.8 5644.4 5302.4 5348.7 5357.5 5358.8 5362.3 5873.3 6028.0 6075.8 6082.8 6109.2 4558.3 4586.8 4596.7 4596.8 4609.1 6216.8 6276.4 6328.0 6336.3 6348.9 4688.8 4725.4 4725.8 4736.7 4738.6 4807.2 4807.8 4811.4 4814.7 4832.0 5197.7 5313.3 5352.4 5355.3 5387.8 5854.1 6100.7 6101.3 6111.5 6118.1 1559.1 1624.9 1654.4 1664.0 1672.4 1176.5 1192.0 1205.7 1208.5 1211.7 5802.9 5803.9 5828.6 5832.5 5837.1 6205.8 6232.9 6280.4 6284.5 6288.8 5662.2 5755.3 5760.3 5798.4 5825.1 3295.0 3310.8 3310.9 3310.9 3313.8 6242.4 6426.6 6451.9 6514.8 6526.5 6300.2 6322.7 6345.0 6361.6 6379.2 6270.3 6452.4 6456.6 6482.9 6521.8 6233.7 6263.7 6268.6 6287.4 6299.5 6193.8 6219.5 6222.2 6250.7 6265.2 6352.1 6480.5 6520.9 6528.6 6542.1 4450.5 4451.3 4465.8 4475.3 4491.4 5876.2 5901.2 6302.0 6305.7 6349.0 5967.2 6021.9 6038.4 6051.8 6088.8 5997.2 6030.3 6040.1 6047.2 6101.7 5867.5 6074.7 6117.9 6142.6 6143.4 6117.2 6163.6 6166.4 6178.7 6204.2 5860.8 5870.4 5941.3 5941.5 5999.2 09:34:49 INFO - PID 12528 | 09:34:49 INFO - PID 12528 | [#5] yui.html Cycles:180 Average:16775.17 Median:31872.28 stddev:20786.76 (65.2%) stddev-sans-first:20810.36 09:34:49 INFO - PID 12528 | Values: 779.3 802.3 826.0 835.8 837.2 15123.2 15296.3 15736.8 15930.4 16150.7 14821.6 14934.0 15430.0 15487.3 15844.8 940.0 979.1 987.2 987.2 987.9 972.6 1012.0 1024.8 1026.1 1027.0 991.6 1055.7 1056.0 1056.0 1057.2 991.8 1051.9 1054.8 1056.5 1057.4 727.2 757.7 775.0 775.1 775.7 15735.9 16126.6 16129.2 16129.9 16313.5 14417.9 15494.5 15649.4 15719.4 16246.4 13891.4 13904.5 13912.2 13923.2 13962.9 3212.7 3229.5 3229.7 3231.1 3234.8 73766.6 74861.0 74981.3 75883.0 76339.6 11215.3 11431.7 11513.0 11608.9 12179.8 21157.5 21245.6 21492.6 21873.5 21878.5 7532.9 7610.5 7629.8 7655.0 7870.0 4060.3 4119.3 4145.2 4197.4 4215.4 4218.2 4234.4 4249.5 4267.8 4328.8 768.5 778.8 791.5 791.8 794.6 674.7 678.2 683.2 707.6 722.7 9647.3 10536.6 10573.9 11035.8 11067.0 667.0 677.6 686.2 701.0 723.2 4575.5 4664.2 4874.7 5049.1 5052.2 76226.6 76271.0 77255.2 78105.0 80435.0 66561.7 66910.2 70000.0 70364.6 71327.6 45002.1 57748.4 58970.1 59483.1 64130.5 10101.4 10751.5 10781.9 10893.3 10993.3 31486.7 31813.2 31931.4 32273.7 32281.8 37807.2 38111.8 38321.8 38372.2 39002.6 13305.8 13434.9 13481.3 13535.0 13738.5 14794.3 14991.3 15024.5 15108.2 15382.6 13264.1 14034.7 14191.9 14772.0 15313.9 13619.9 13817.9 13894.3 14327.7 14501.7 12631.1 12671.7 13736.9 13946.7 14181.1 9543.5 9654.2 10157.5 10163.5 10210.3 11407.3 11495.6 11631.4 11704.1 11745.7 09:34:49 INFO - PID 12528 | -------- Summary: end -------- 09:34:49 INFO - PID 12528 | 09:34:49 INFO - TEST-INFO | 12528: exit 0 09:34:49 INFO - TEST-OK | dromaeo_css | took 1117116ms 09:34:49 INFO - TEST-START | kraken 09:34:49 INFO - operating with platform_type : linux_ 09:34:49 INFO - Initialising browser for kraken test... 09:34:49 INFO - TEST-INFO | started process 12860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgUe04D/profile http://localhost:39252/getInfo.html) 09:34:53 INFO - PID 12860 | __metrics Screen width/height:1600/1200 09:34:53 INFO - PID 12860 | colorDepth:24 09:34:53 INFO - PID 12860 | Browser inner width/height: 1024/697 09:34:53 INFO - PID 12860 | __metrics 09:34:54 INFO - PID 12860 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:34:54 INFO - PID 12860 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:55 INFO - TEST-INFO | 12860: exit 0 09:34:55 INFO - Browser initialized. 09:34:55 INFO - Running cycle 1/1 for kraken test... 09:34:55 INFO - TEST-INFO | started process 12953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgUe04D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:07 INFO - PID 12953 | RSS: Main: 150028288 09:35:07 INFO - PID 12953 | 09:35:10 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39252/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:11 INFO - PID 12953 | RSS: Main: 205561856 09:35:11 INFO - PID 12953 | 09:35:13 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39252/tests/kraken/driver.html?testName=audio-dft) 09:35:14 INFO - PID 12953 | RSS: Main: 184385536 09:35:14 INFO - PID 12953 | 09:35:17 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39252/tests/kraken/driver.html?testName=audio-fft) 09:35:18 INFO - PID 12953 | RSS: Main: 266584064 09:35:18 INFO - PID 12953 | 09:35:20 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39252/tests/kraken/driver.html?testName=audio-oscillator) 09:35:20 INFO - PID 12953 | RSS: Main: 176599040 09:35:20 INFO - PID 12953 | 09:35:22 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:23 INFO - PID 12953 | RSS: Main: 181641216 09:35:23 INFO - PID 12953 | 09:35:26 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39252/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:27 INFO - PID 12953 | RSS: Main: 220327936 09:35:27 INFO - PID 12953 | 09:35:30 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39252/tests/kraken/driver.html?testName=imaging-desaturate) 09:35:31 INFO - PID 12953 | RSS: Main: 235393024 09:35:31 INFO - PID 12953 | 09:35:33 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39252/tests/kraken/driver.html?testName=json-parse-financial) 09:35:34 INFO - PID 12953 | RSS: Main: 249942016 09:35:34 INFO - PID 12953 | 09:35:35 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:36 INFO - PID 12953 | RSS: Main: 182857728 09:35:36 INFO - PID 12953 | 09:35:38 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:38 INFO - PID 12953 | RSS: Main: 188796928 09:35:38 INFO - PID 12953 | 09:35:40 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:41 INFO - PID 12953 | RSS: Main: 199344128 09:35:41 INFO - PID 12953 | 09:35:44 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:44 INFO - PID 12953 | RSS: Main: 207757312 09:35:44 INFO - PID 12953 | 09:35:47 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:48 INFO - PID 12953 | RSS: Main: 205041664 09:35:48 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39252/tests/kraken/driver.html?testName=ai-astar) 09:35:50 INFO - PID 12953 | RSS: Main: 273125376 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | __start_tp_report 09:35:50 INFO - PID 12953 | _x_x_mozilla_page_load 09:35:50 INFO - PID 12953 | _x_x_mozilla_page_load_details 09:35:50 INFO - PID 12953 | |i|pagename|runs| 09:35:50 INFO - PID 12953 | |0;ai-astar;104;111;110;111;111;110;110;111;110;111 09:35:50 INFO - PID 12953 | |1;audio-beat-detection;153;118;121;159;126;121;119;118;159;120 09:35:50 INFO - PID 12953 | |2;audio-dft;164;164;165;164;165;164;169;165;164;165 09:35:50 INFO - PID 12953 | |3;audio-fft;75;75;79;110;75;76;74;75;92;74 09:35:50 INFO - PID 12953 | |4;audio-oscillator;83;83;111;82;82;83;97;83;83;103 09:35:50 INFO - PID 12953 | |5;imaging-gaussian-blur;114;113;122;113;113;113;113;113;114;114 09:35:50 INFO - PID 12953 | |6;imaging-darkroom;148;149;150;148;149;149;150;149;148;150 09:35:50 INFO - PID 12953 | |7;imaging-desaturate;94;96;96;95;95;94;94;95;95;94 09:35:50 INFO - PID 12953 | |8;json-parse-financial;47;51;46;55;48;48;48;48;47;48 09:35:50 INFO - PID 12953 | |9;json-stringify-tinderbox;54;55;55;55;56;54;54;54;55;54 09:35:50 INFO - PID 12953 | |10;stanford-crypto-aes;85;83;84;91;90;83;84;82;82;83 09:35:50 INFO - PID 12953 | |11;stanford-crypto-ccm;130;137;142;130;135;143;133;127;173;129 09:35:50 INFO - PID 12953 | |12;stanford-crypto-pbkdf2;191;183;186;195;182;183;187;187;187;186 09:35:50 INFO - PID 12953 | |13;stanford-crypto-sha256-iterative;67;65;65;66;64;69;65;66;63;63 09:35:50 INFO - PID 12953 | __end_tp_report 09:35:50 INFO - PID 12953 | __start_cc_report 09:35:50 INFO - PID 12953 | _x_x_mozilla_cycle_collect,1706 09:35:50 INFO - PID 12953 | __end_cc_report 09:35:50 INFO - PID 12953 | __startTimestamp1491410150440__endTimestamp 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | ------- Summary: start ------- 09:35:50 INFO - PID 12953 | Number of tests: 14 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.13 (1.9%) stddev-sans-first:0.53 09:35:50 INFO - PID 12953 | Values: 104.0 111.0 110.0 111.0 111.0 110.0 110.0 111.0 110.0 111.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:123.50 stddev:17.88 (14.5%) stddev-sans-first:17.18 09:35:50 INFO - PID 12953 | Values: 153.0 118.0 121.0 159.0 126.0 121.0 119.0 118.0 159.0 120.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 09:35:50 INFO - PID 12953 | Values: 164.0 164.0 165.0 164.0 165.0 164.0 169.0 165.0 164.0 165.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:11.69 (15.6%) stddev-sans-first:12.23 09:35:50 INFO - PID 12953 | Values: 75.0 75.0 79.0 110.0 75.0 76.0 74.0 75.0 92.0 74.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.00 stddev:10.66 (12.8%) stddev-sans-first:11.08 09:35:50 INFO - PID 12953 | Values: 83.0 83.0 111.0 82.0 82.0 83.0 97.0 83.0 83.0 103.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:113.50 stddev:2.78 (2.5%) stddev-sans-first:2.95 09:35:50 INFO - PID 12953 | Values: 114.0 113.0 122.0 113.0 113.0 113.0 113.0 113.0 114.0 114.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 09:35:50 INFO - PID 12953 | Values: 148.0 149.0 150.0 148.0 149.0 149.0 150.0 149.0 148.0 150.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 09:35:50 INFO - PID 12953 | Values: 94.0 96.0 96.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:48.00 stddev:2.59 (5.4%) stddev-sans-first:2.68 09:35:50 INFO - PID 12953 | Values: 47.0 51.0 46.0 55.0 48.0 48.0 48.0 48.0 47.0 48.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 09:35:50 INFO - PID 12953 | Values: 54.0 55.0 55.0 55.0 56.0 54.0 54.0 54.0 55.0 54.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.20 (3.8%) stddev-sans-first:3.39 09:35:50 INFO - PID 12953 | Values: 85.0 83.0 84.0 91.0 90.0 83.0 84.0 82.0 82.0 83.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:136.00 stddev:13.46 (9.9%) stddev-sans-first:13.97 09:35:50 INFO - PID 12953 | Values: 130.0 137.0 142.0 130.0 135.0 143.0 133.0 127.0 173.0 129.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.70 Median:187.00 stddev:3.92 (2.1%) stddev-sans-first:3.83 09:35:50 INFO - PID 12953 | Values: 191.0 183.0 186.0 195.0 182.0 183.0 187.0 187.0 187.0 186.0 09:35:50 INFO - PID 12953 | 09:35:50 INFO - PID 12953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.83 (2.8%) stddev-sans-first:1.83 09:35:50 INFO - PID 12953 | Values: 67.0 65.0 65.0 66.0 64.0 69.0 65.0 66.0 63.0 63.0 09:35:50 INFO - PID 12953 | -------- Summary: end -------- 09:35:50 INFO - PID 12953 | 09:35:51 INFO - TEST-INFO | 12953: exit 0 09:35:51 INFO - TEST-OK | kraken | took 61789ms 09:35:51 INFO - SUITE-END | took 1178s 09:35:52 INFO - Completed test suite (00:19:39) 09:35:52 INFO - javascript benchmark 09:35:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7714.079455754135, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.0878008547647, 3340.1816554944044, 3355.6812102850236, 3364.1421437533427, 3394.7793393429424, 5816.709164541777, 5901.911471327933, 6006.909896351558, 6015.518758499321, 6015.5488338374635, 5878.853028674285, 5970.761169553212, 5977.970110149454, 6071.969640151804, 6086.573939824214, 5213.374395072597, 5279.9208011879855, 5290.523852853233, 5300.045991721508, 5336.066188417031, 5256.185291279858, 5378.273933019032, 5392.757325920324, 5401.972990135064, 5422.511973922346, 5139.408967968657, 5169.302144210521, 5341.172118321666, 5343.8396848094235, 5386.676799392029, 5217.47825217479, 5248.081585722483, 5253.527182553588, 5269.789208431658, 5283.788648454057, 5263.815766448156, 5273.736313184326, 5278.868028299285, 5288.867778305535, 5300.284461597674, 5721.170430287627, 5986.97006514969, 5997.910031349533, 6010.8497287567725, 6017.277926648786, 6241.3446588108045, 6251.624902505864, 6435.613863168225, 6496.577722448026, 6526.510511711641, 6496.187976502937, 6502.0, 6502.804915852532, 6506.186726659168, 6509.9023514647315, 6010.519158467312, 6021.0, 6025.397460253984, 6026.578139530235, 6030.306514750772, 6289.7169627366875, 6397.904031439439, 6555.803325900135, 6556.606603603799, 6602.40578347951, 6118.694065296718, 6161.537884658668, 6368.395002474757, 6372.076048972873, 6373.5857169283845, 6207.503399728011, 6213.03697926822, 6429.324920883333, 6430.485561155097, 6502.317256688074, 6376.234851817719, 6454.483641308684, 6460.870782584322, 6469.417752402306, 6470.352964703492, 6414.711337989802, 6432.453241474527, 6438.0, 6439.54923155384, 6454.5159113065765, 4789.4971028042255, 4839.467658557556, 4871.805127794849, 4922.4093108826455, 4925.38432695913, 4351.82592696295, 4357.477102747627, 4368.4102646143, 4382.7370357778, 4404.273294906368, 6061.605995610271, 6078.088286757022, 6086.847828804227, 6090.847728806815, 6117.663528505975, 6114.358196333954, 6261.029540421242, 6475.417212450902, 6525.086487891699, 6566.671666416755, 6006.789762358384, 6060.2424696912885, 6060.424259695322, 6072.453479186895, 6112.449879510866, 5494.36814766307, 5505.752241149158, 5508.228847961289, 5508.779648814083, 5512.614117011771, 6496.0580715795, 6585.868282634225, 6737.663116844236, 6820.249772525019, 6837.794866154023, 6511.120998665309, 6514.055461958084, 6539.247986481425, 6539.836504087436, 6545.37818907203, 6781.152355955505, 6793.286704895915, 6835.7949261522235, 6848.623325717133, 6854.897176542456, 6135.569531795875, 6214.5028397727165, 6426.228852537725, 6434.806955791334, 6445.871082578416, 6418.967905160631, 6519.380658837403, 6550.6069635822005, 6568.80293591193, 6572.474202063919, 6371.96814015927, 6374.107624932606, 6377.266614339411, 6380.712867920862, 6388.265349484869, 6056.606320589148, 6079.270487541523, 6138.846528836815, 6270.686465676789, 6345.777897773556, 6333.176687030841, 6337.0, 6340.682965851781, 6343.429091381798, 6351.2696039956, 6320.494360451245, 6371.93628063732, 6385.265694445198, 6387.744490220339, 6393.2647745508, 5942.940570594239, 5963.344032156372, 6195.473384762346, 6196.194494715658, 6202.81391558254], "value": 5892.471224432135, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.9059177011105, 750.9023826902502, 766.39837727384, 1144.656603019094, 1148.2536351371607, 32950.0, 33638.32723345532, 33662.15844603886, 33667.653293868214, 33673.49489757649, 40606.59393406072, 41465.7926710366, 41520.58479415205, 41669.16661666765, 41691.58308416915, 8285.875711864326, 8379.287760540361, 8427.578621068922, 8444.0, 8449.619767110495, 6044.486218671396, 8251.504909705407, 8387.077421483631, 8387.664493420256, 8388.0, 6349.365063493637, 8009.759707208764, 8296.170382961685, 8405.285550728166, 8405.789855253606, 8438.704645337415, 8495.235428811375, 8495.957520212422, 8506.574671266411, 8513.659453621847, 5923.200367950358, 8266.297364723945, 8318.168183181693, 8352.081271060179, 8356.164383561656, 30155.698443015728, 38357.424638630444, 38819.41770873439, 38919.61080389188, 38970.61029389726, 3296.6373698893344, 3340.66593340664, 3343.0472315389998, 3343.632200457948, 3343.8996830095134, 30950.583647861535, 31108.37783244345, 31173.220669483217, 31194.220144496343, 31230.21924451907, 3965.365541513344, 3974.225026119908, 3989.9202015959518, 3995.7402768820225, 4065.918681626351, 207402.0, 208291.0, 208615.95692021595, 209301.0, 209354.0, 50926.49073509217, 51009.48990510122, 51189.48810511922, 51229.7438512805, 51246.0, 52994.20508692373, 53189.468105318454, 53239.46760532345, 53292.733536332846, 53387.46612533825, 15250.389984400721, 15502.992305500107, 15601.531954041397, 15609.765853512206, 15618.76571851423, 12717.364131793373, 12728.554500592434, 12731.363431828557, 12735.363231838372, 12737.617871463872, 12067.396630168456, 12236.877631223751, 13658.863411365957, 13816.447342106405, 13859.168449893039, 4958.479359667255, 5178.275041494194, 5197.22041693749, 5217.3999990000875, 5231.24146998683, 1026.9691909242736, 1027.3117011602244, 1035.4615599888016, 1037.7820657661825, 1053.3837704942541, 25327.873360633446, 25577.872110639328, 25910.481790364087, 25919.870400647877, 26023.0, 1127.9718007049726, 1128.5831772737677, 1157.6816375496637, 1164.1036401970605, 1167.7430965187646, 13488.460461581622, 13522.12106213093, 13715.1085179465, 13747.862521374858, 13758.793618095737, 280604.0, 280929.0, 283487.0, 283550.0, 284231.0, 55012.44987550153, 55172.17241741377, 55174.0, 55836.16245756317, 55882.720586396805, 1389.6942672612008, 1461.853834186237, 1474.1449959023741, 1486.6283429142713, 1497.5432493089495, 23852.57439679547, 25330.873345633154, 25368.0, 25416.618750718386, 25703.0, 40892.59107408888, 40935.7953210232, 40967.38548921828, 40973.795131024155, 40980.59019409768, 295881.0, 296090.0, 296878.0, 297397.0, 298342.0, 33868.0, 34454.0, 34479.827600861834, 34550.30899382049, 34576.82711586426, 32968.67031329656, 39766.60233397629, 43289.567104328555, 44298.11403771971, 44838.0, 34862.0, 35033.124171895906, 35051.474227886094, 35154.64845351616, 35637.82181089078, 34886.476702849985, 34898.47652285269, 34914.82542587372, 35001.64998350086, 35054.0, 40184.799076004434, 40635.0, 40837.591624083376, 41455.37816932809, 41940.790296048326, 33977.49033764446, 34140.31719365648, 34218.657813421545, 34239.0, 34371.14072148217, 26532.8673356632, 27306.317342065813, 27547.8481968161, 27696.0, 27878.721212788423], "value": 17779.770757059705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.6030642268744, 450.113276844616, 455.51942700451013, 461.26198083067095, 464.91399091168137, 21445.892770536146, 22104.778952210472, 22293.777062229372, 22552.88723556384, 22841.77158228417, 22718.772812271873, 22905.083796648116, 23021.0, 23066.538669226604, 23152.0, 5952.4047595240345, 6006.129111278862, 6045.153678485016, 6087.0869369594475, 6152.230971128609, 5950.70246487676, 6013.939860601382, 6031.185789918349, 6036.1851150094835, 6051.1830902828215, 5913.497352725002, 6114.0, 6121.326654068049, 6148.84627884302, 6149.323574406834, 6043.486303664194, 6133.969330153343, 6152.0, 6168.537359698041, 6174.722137503823, 5568.470995255444, 5576.693281869496, 5603.635763675348, 5603.971980140073, 5607.355154157283, 25658.87170564154, 26709.599356009676, 27175.45649087027, 27284.863575681993, 27419.725802742116, 2180.967285490719, 2203.063697928374, 2206.6689996500654, 2207.249535158054, 2207.2826331442184, 17228.741568876478, 17346.0, 17793.377231796825, 18098.547536311566, 18262.72605910899, 2294.7626064586893, 2334.4514039200944, 2335.1826860598826, 2341.2156927429332, 2351.8118550516087, 102892.48553757257, 105432.94567054308, 110486.0, 111088.44455777669, 115306.0, 12346.259224446561, 12528.436220370106, 12588.81116783249, 12601.495940162475, 12611.49554017829, 17768.11159442023, 17785.19966601506, 17789.644207115784, 17793.555161120818, 17800.37698680566, 8595.355348348774, 8999.235065019415, 9016.729498115066, 9132.086791320948, 9440.197583205505, 8304.211099945496, 8316.958415207886, 8341.541215233221, 8548.059713431518, 8696.478211307342, 7813.765587032398, 7896.842063158705, 7897.68409263623, 7941.841163176704, 8034.758957231293, 2176.662617294322, 2196.967045494319, 2263.3096905443667, 2279.8062164715852, 2412.650165725995, 967.5631686944881, 975.4439969217619, 984.4979060678962, 985.103555764251, 1008.9041541053588, 20939.790602093784, 21052.684209736864, 21113.0, 21167.25914592982, 21252.574948500944, 1028.388109075099, 1034.462079718542, 1046.581367453025, 1054.8048611006989, 1063.4363787192801, 10456.581736730446, 11389.202755807013, 11420.14348923834, 11442.54229830814, 11452.885471145182, 575013.0, 592585.0, 607368.0, 608110.0267967872, 609491.0, 76981.0, 102545.0, 104917.47541262244, 105205.0, 111369.44315278372, 1175.1421462332546, 1188.6552899659002, 1222.49877550204, 1222.896053835416, 1223.651259391087, 19968.800311997275, 20039.29862454807, 20221.59556808826, 20761.89619051895, 20809.1676332945, 49839.252411214584, 49898.0, 50024.74987625039, 50691.49308506868, 50852.74573627256, 63447.6827615859, 69290.65354673195, 71194.0, 71598.28401715917, 72458.63770681113, 9555.569999349907, 9693.0, 9775.0, 9802.607895684092, 10220.437875916896, 14392.568222953329, 15414.84585154134, 15436.768448473507, 15937.0, 16091.114988675736, 13021.47914083464, 13188.142770719873, 13394.665133371744, 13599.932000339935, 13608.251546165056, 11606.76786464249, 12049.578264760692, 12083.160457292704, 12268.0, 12360.505579776709, 13483.865161348653, 13535.59393218205, 13589.592312230649, 13676.589702308947, 13827.239501827496, 9659.420434773936, 9699.951500242454, 9841.655542055994, 9952.950235249067, 10016.949915250669, 12915.806262905877, 13174.538891138764, 13183.53857614979, 13204.669883252996, 13314.134581252187], "value": 10587.980007081747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.9459621615135, 1386.9722605547888, 1396.1343966740617, 1402.6773842016341, 1402.9158250504968, 11152.553897844087, 11613.245139065966, 11623.0, 11624.0, 11628.069754419646, 11259.831102533468, 11595.826062609047, 11780.646580602595, 11947.701307467318, 11950.103742219324, 2375.8099352051836, 2441.59713647248, 2443.0838435586656, 2450.669159663449, 2452.2030340139436, 2012.688033354825, 2336.9532609347802, 2393.3537944754908, 2444.5844206484853, 2449.0938352809485, 2098.380977611608, 2377.762223777626, 2421.806255499556, 2428.2351059416314, 2450.0812195426715, 2325.395397196724, 2345.226075395124, 2349.189529612281, 2352.3883790214495, 2418.0327868852423, 2277.1802151225547, 2307.180950762472, 2307.6192428249487, 2308.9191878284346, 2311.9653205201935, 11493.482793274323, 11610.0, 11672.35802030888, 11697.47361368732, 11714.472848721827, 6360.0, 6566.244881838602, 6578.0132980052895, 6582.868342633168, 6593.20881494219, 4024.4121701260588, 4149.792510374469, 4201.600847919473, 4209.789510524462, 4265.808038638269, 1282.4613662261872, 1311.4426368793224, 1352.6821197018692, 1360.2314692198975, 1369.9726005479934, 15247.847521524754, 15528.0, 15553.144577048259, 15564.766528501968, 15574.532764017098, 5491.36849262332, 5511.944880551143, 5639.154126880919, 5905.645661260338, 5909.438603332676, 14650.340734666966, 14686.045407048508, 14698.41206351734, 14701.338439770236, 14733.0, 6602.636854973022, 6607.306232845578, 6608.966955165193, 6611.86776264472, 6615.768448104293, 5927.1405646181065, 5991.850203744942, 6018.21763170785, 6083.847903802441, 6088.0, 4496.3705081288645, 4576.977115114403, 4593.565410332529, 4619.930701039487, 4662.347271382009, 1252.8684488128797, 1281.2504684759333, 1320.3662242123835, 1350.0954360578437, 1350.8176396186389, 815.975520734379, 820.5938060659893, 831.584207896052, 835.1856939484076, 861.4443683824023, 6654.900176497356, 6766.25571187169, 6878.759243426456, 6947.652617369111, 7112.928870711226, 627.1564745417406, 629.9779507717208, 631.2393565753256, 632.7437387857925, 717.727263639824, 4158.313878210061, 4400.537943515948, 4502.0, 4534.750588717652, 4590.265557510849, 15011.549653510412, 15770.369185232463, 15771.842281577266, 15772.76340854888, 15803.525894223192, 14503.709925801635, 15127.0, 15135.394584216509, 15683.843161568238, 15699.68600627981, 10826.484292199098, 10992.780144397067, 11042.227044106996, 11108.333499989865, 11111.388873611868, 6746.224184218878, 7022.719091236293, 7070.505064645426, 7120.786376408716, 7141.535800172972, 13868.959828012737, 13975.371108300355, 14084.718305633625, 14089.718205636034, 14230.359633816295, 14292.499762508678, 14361.281935903373, 14400.495982640557, 14463.783043254149, 14594.708105837612, 9461.432314061178, 9665.468399238109, 9768.85346719814, 9770.511474426392, 9812.754681133028, 10518.789624207626, 10539.156867450432, 10555.577776889146, 10638.0, 10667.359958402521, 8895.198012626002, 8915.475109510153, 9024.097590240923, 9274.118958698913, 9279.025702301431, 8698.0, 8714.128587141235, 8757.299416046828, 8819.162179593184, 8897.0, 7701.614919254127, 7843.333316668147, 7921.841563168819, 7927.61266778323, 7953.164917683791, 5854.648721076579, 5893.882122357614, 5968.343482216866, 6125.081237814364, 6187.319394866471, 5866.2960444746905, 5935.614185077956, 5978.551608629283, 6004.39956004396, 6277.529185311028], "value": 5414.0145499646915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7993073359422, 422.9281022226221, 430.5823351349191, 434.1555674213654, 436.36726746217994, 5565.916511252334, 5697.344805347387, 5790.652560846347, 5844.94790937631, 5895.882082358356, 5581.888362232753, 5699.74351154198, 5709.2292540507015, 5745.770169193238, 5754.942450575493, 4542.364069030346, 4546.704464209833, 4558.247889098295, 4561.863144105682, 4573.7713114344315, 4413.117376524708, 4476.418065651461, 4525.411696479453, 4561.536770144118, 4598.494165641793, 4496.505384407713, 4501.684882058241, 4538.29656403258, 4540.818367265322, 4551.886202844922, 4504.369388285642, 4512.887177820581, 4514.796834142471, 4525.343825145368, 4529.796159172813, 4048.3725022621543, 4058.5129784425762, 4127.628513433805, 4134.857508293689, 4139.730917490354, 5611.775528978836, 5619.859503512404, 5629.324481062258, 5638.830835074954, 5644.379118296984, 5302.416734159239, 5348.679079255218, 5357.544608708265, 5358.812441564526, 5362.276092727471, 5873.3245676746865, 6028.0, 6075.7873474428625, 6082.817515474543, 6109.175261339707, 4558.316252562109, 4586.816527338902, 4596.701214421052, 4596.816127354902, 4609.147307748078, 6216.844578885519, 6276.403741644536, 6327.968360158216, 6336.303006669263, 6348.873022539523, 4688.835890743808, 4725.40932383452, 4725.834595789131, 4736.692115012514, 4738.597219236403, 4807.230843065093, 4807.807687692523, 4811.422629284508, 4814.735189564538, 4832.0, 5197.688138711689, 5313.2561441397465, 5352.437994010651, 5355.250264962909, 5387.757550910218, 5854.121881717691, 6100.72546735398, 6101.328853826076, 6111.480524155408, 6118.1434599156155, 1559.1113065552527, 1624.8862579619313, 1654.4374912529556, 1663.991680041592, 1672.3645014894262, 1176.5470293936726, 1191.9702007449882, 1205.7287110400089, 1208.456194712383, 1211.6849619099098, 5802.912956305659, 5803.941960580424, 5828.59199856006, 5832.475077242983, 5837.09525023622, 6205.782797602063, 6232.937670623326, 6280.434760871452, 6284.528660350492, 6288.779892703825, 5662.150677398423, 5755.280589926259, 5760.279965004374, 5798.362180160263, 5825.097109947965, 3294.9670503295138, 3310.8344582771247, 3310.8841190558214, 3310.9172270692943, 3313.7680362374886, 6242.375762423721, 6426.646534440651, 6451.935480645134, 6514.83050847458, 6526.477881769447, 6300.243970723451, 6322.7354529093445, 6345.0, 6361.586496877688, 6379.234491860913, 6270.341614130633, 6452.354764523604, 6456.612603243821, 6482.935170648328, 6521.804345869631, 6233.719482623203, 6263.718132683949, 6268.561200716089, 6287.434130928238, 6299.464545513682, 6193.84515387119, 6219.4811101503965, 6222.160008398808, 6250.656003998501, 6265.248170219603, 6352.142460767737, 6480.481561474976, 6520.902186467112, 6528.575642583217, 6542.149520562297, 4450.532694067206, 4451.265541185668, 4465.799039043316, 4475.328700694922, 4491.416115904912, 5876.206712093813, 5901.173835662925, 6301.96849015752, 6305.747770089145, 6349.0, 5967.224260846062, 6021.9397806023135, 6038.365971572922, 6051.848703782264, 6088.786892458743, 5997.190379298739, 6030.30651475086, 6040.1241819934985, 6047.244094488189, 6101.6644084574, 5867.501262392744, 6074.665893375906, 6117.938820611737, 6142.600730952474, 6143.416375444325, 6117.174181485442, 6163.599366041193, 6166.352532984151, 6178.66017369049, 6204.224471941007, 5860.794872179454, 5870.383609720918, 5941.306727582618, 5941.465268125889, 5999.220101386792], "value": 4723.402614974951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.3297763923025, 802.2779498451393, 826.0459169659043, 835.8495470815251, 837.2130197614242, 15123.24383780812, 15296.311665975016, 15736.763948540767, 15930.442434514795, 16150.676986460263, 14821.55535333939, 14934.0, 15430.0, 15487.303071361788, 15844.76232856508, 940.0458534587416, 979.1285755677453, 987.1855719031792, 987.239825334492, 987.856760769688, 972.6158167523823, 1012.0284526854192, 1024.8257796174669, 1026.1329176845554, 1027.0499787696351, 991.613270824379, 1055.7044027672225, 1055.978880422391, 1055.984160237597, 1057.1595581512715, 991.7619771254883, 1051.8948105189497, 1054.847047178155, 1056.5298442193189, 1057.4237040812698, 727.1528669100492, 757.7120694136192, 774.9767506974799, 775.0621747685308, 775.6819703921421, 15735.92132039344, 16126.596835079099, 16129.193540322936, 16129.91935040329, 16313.510594682179, 14417.92791036038, 15494.457693980768, 15649.374025038986, 15719.449819256386, 16246.350145994145, 13891.4443422263, 13904.513342033082, 13912.165270083726, 13923.164610123426, 13962.93018534911, 3212.7429805615493, 3229.4832826747843, 3229.7416206703406, 3231.1437469070715, 3234.8059116453087, 73766.63116684435, 74860.99999999946, 74981.25018749852, 75883.0, 76339.61830190869, 11215.271007384494, 11431.714207144722, 11513.0, 11608.883911160949, 12179.817302740466, 21157.471063223544, 21245.57508849845, 21492.57014859694, 21873.453163670718, 21878.45303867416, 7532.887006694904, 7610.4672672913475, 7629.809254768676, 7655.0, 7869.988778438673, 4060.309747342959, 4119.299719047769, 4145.2124096421585, 4197.370394440858, 4215.430916826251, 4218.156368726206, 4234.364845273234, 4249.511306199826, 4267.765272909957, 4328.805203765838, 768.4774353439715, 778.8052986753312, 791.5013541468837, 791.782259878538, 794.5709316968888, 674.6660403100399, 678.1827897383641, 683.1911254362584, 707.6391040569347, 722.7253643615393, 9647.324687271823, 10536.631217907336, 10573.894261057445, 11035.83446248307, 11067.0, 666.9533132680763, 677.5528151420137, 686.2142846440797, 701.0430762009921, 723.1936390924081, 4575.542445755398, 4664.230401983703, 4874.658773885794, 5049.081398695821, 5052.216198979571, 76226.61886690531, 76271.0, 77255.2274477248, 78105.0, 80435.0, 66561.66719166373, 66910.21764661845, 70000.0, 70364.64817675878, 71327.64336178286, 45002.09995800131, 57748.42251577514, 58970.11544826831, 59483.107753382865, 64130.45651782631, 10101.44442055694, 10751.505760627671, 10781.9460902695, 10893.346399216072, 10993.340399576051, 31486.685133148374, 31813.20466988344, 31931.36137277288, 32273.677263228008, 32281.838590807834, 37807.24385512329, 38111.80944095262, 38321.80839095786, 38372.23255534818, 39002.60997390103, 13305.841649900602, 13434.93282533581, 13481.32593370308, 13535.0, 13738.450461981409, 14794.260286985393, 14991.325390357679, 15024.549263522113, 15108.244587770787, 15382.615434614225, 13264.071514993857, 14034.719305613626, 14191.858081419054, 14772.0, 15313.923430383222, 13619.931900340434, 13817.930910345383, 13894.305284735521, 14327.713445731235, 14501.709965800836, 12631.115821892747, 12671.746565068832, 13736.93131534336, 13946.72252020754, 14181.14913105217, 9543.4751088688, 9654.15863808817, 10157.542910568895, 10163.491825408848, 10210.336328138646, 11407.25852819564, 11495.597654082067, 11631.360275184947, 11704.122190835891, 11745.706357341134], "value": 7427.823003692705, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 121.0, 159.0, 126.0, 121.0, 119.0, 118.0, 159.0, 120.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 164.0, 165.0, 164.0, 169.0, 165.0, 164.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 79.0, 110.0, 75.0, 76.0, 74.0, 75.0, 92.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 82.0, 82.0, 83.0, 97.0, 83.0, 83.0, 103.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 122.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 148.0, 149.0, 149.0, 150.0, 149.0, 148.0, 150.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 51.0, 46.0, 55.0, 48.0, 48.0, 48.0, 48.0, 47.0, 48.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 56.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 91.0, 90.0, 83.0, 84.0, 82.0, 82.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 137.0, 142.0, 130.0, 135.0, 143.0, 133.0, 127.0, 173.0, 129.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 183.0, 186.0, 195.0, 182.0, 183.0, 187.0, 187.0, 187.0, 186.0], "value": 186.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 66.0, 64.0, 69.0, 65.0, 66.0, 63.0, 63.0], "value": 65.3, "unit": "score"}]}]} 09:35:52 INFO - Return code: 0 09:35:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:35:52 ERROR - # TBPL SUCCESS # 09:35:52 INFO - Running post-action listener: _resource_record_post_action 09:35:52 INFO - [mozharness: 2017-04-05 16:35:52.280606Z] Finished run-tests step (success) 09:35:52 INFO - Running post-run listener: _resource_record_post_run 09:35:52 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 363880448; Read time: 128; Write time: 243272 09:35:52 INFO - TinderboxPrint: CPU usage
13.0% 09:35:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 128 09:35:52 INFO - TinderboxPrint: I/O write bytes / time
363,880,448 / 243,272 09:35:52 INFO - TinderboxPrint: CPU idle
8,307.3 (87.0%) 09:35:52 INFO - TinderboxPrint: CPU user
1,191.2 (12.5%) 09:35:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:35:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 108388352; Read time: 0; Write time: 114784 09:35:52 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254963712; Read time: 112; Write time: 128448 09:35:52 INFO - Running post-run listener: _upload_blobber_files 09:35:52 INFO - Blob upload gear active. 09:35:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:35:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:35:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:35:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:35:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:57 INFO - (blobuploader) - INFO - Done attempting. 09:35:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:35:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:35:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:57 INFO - (blobuploader) - INFO - Done attempting. 09:35:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:35:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:58 INFO - (blobuploader) - INFO - Done attempting. 09:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:59 INFO - (blobuploader) - INFO - Done attempting. 09:35:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:59 INFO - Return code: 0 09:35:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:35:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e713a7c6841f43f32347bd21cb9f0d74700278d2ecad8ca51e7d8f080e4cf4085e2846186b8603145b0a338d2c93867631008ec60f33582fe52020e15b1ff6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f98d0d1b13b227f090721214a3a4223ebada1879233d059370af42d95c3a81d48e61d1b1c1b7de82500b0740a1a671992f43a7f2ab4121b96a004ca118c26", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87fdef7d8f5e653486d71345f9a1338b2cfd0c7c7fb270e62c6c376c346bc3fa0bb414be8945b8badef872d4925465dc51407cff5712d6a7fda49454da3bd48b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/040a532e5c25222c8fc0efd1c31d90098552c5c3ce541105f0eef747e2b0e80eb81a4ac35fe5fb9dc205c718d247a0a36d9195b8521405a5286d14aa8c37f90e"} 09:35:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:35:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:35:59 INFO - Contents: 09:35:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e713a7c6841f43f32347bd21cb9f0d74700278d2ecad8ca51e7d8f080e4cf4085e2846186b8603145b0a338d2c93867631008ec60f33582fe52020e15b1ff6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f98d0d1b13b227f090721214a3a4223ebada1879233d059370af42d95c3a81d48e61d1b1c1b7de82500b0740a1a671992f43a7f2ab4121b96a004ca118c26", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87fdef7d8f5e653486d71345f9a1338b2cfd0c7c7fb270e62c6c376c346bc3fa0bb414be8945b8badef872d4925465dc51407cff5712d6a7fda49454da3bd48b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/040a532e5c25222c8fc0efd1c31d90098552c5c3ce541105f0eef747e2b0e80eb81a4ac35fe5fb9dc205c718d247a0a36d9195b8521405a5286d14aa8c37f90e"} 09:35:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:59 INFO - Copying logs to upload dir... 09:35:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:35:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.878638 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-05 09:35:59.442542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 09:35:59.445980) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e713a7c6841f43f32347bd21cb9f0d74700278d2ecad8ca51e7d8f080e4cf4085e2846186b8603145b0a338d2c93867631008ec60f33582fe52020e15b1ff6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f98d0d1b13b227f090721214a3a4223ebada1879233d059370af42d95c3a81d48e61d1b1c1b7de82500b0740a1a671992f43a7f2ab4121b96a004ca118c26", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87fdef7d8f5e653486d71345f9a1338b2cfd0c7c7fb270e62c6c376c346bc3fa0bb414be8945b8badef872d4925465dc51407cff5712d6a7fda49454da3bd48b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/040a532e5c25222c8fc0efd1c31d90098552c5c3ce541105f0eef747e2b0e80eb81a4ac35fe5fb9dc205c718d247a0a36d9195b8521405a5286d14aa8c37f90e"} build_url:https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/LomcT0IJShO75ulxeABkJg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e713a7c6841f43f32347bd21cb9f0d74700278d2ecad8ca51e7d8f080e4cf4085e2846186b8603145b0a338d2c93867631008ec60f33582fe52020e15b1ff6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f98d0d1b13b227f090721214a3a4223ebada1879233d059370af42d95c3a81d48e61d1b1c1b7de82500b0740a1a671992f43a7f2ab4121b96a004ca118c26", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87fdef7d8f5e653486d71345f9a1338b2cfd0c7c7fb270e62c6c376c346bc3fa0bb414be8945b8badef872d4925465dc51407cff5712d6a7fda49454da3bd48b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/040a532e5c25222c8fc0efd1c31d90098552c5c3ce541105f0eef747e2b0e80eb81a4ac35fe5fb9dc205c718d247a0a36d9195b8521405a5286d14aa8c37f90e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 09:35:59.471139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:35:59.471443) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1491408902.416811-694173540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:35:59.556472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 09:35:59.556795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 09:35:59.557068) ========= ========= Total master_lag: 0.16 =========