builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1490014970.4 results: success (0) revision: cb4e80abb488f37ec67c4760a128ae177697667b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:50.401176) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:50.401691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:50.401993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:50.416657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:50.416967) ========= 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=eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-20 06:02:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-03-20 06:02:50 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117513 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:50.550489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:50.550855) ========= 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=eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019604 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:50.600451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 06:02:50.600878) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb4e80abb488f37ec67c4760a128ae177697667b --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 cb4e80abb488f37ec67c4760a128ae177697667b --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=eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-20 06:02:51,066 truncating revision to first 12 chars 2017-03-20 06:02:51,066 Setting DEBUG logging. 2017-03-20 06:02:51,066 attempt 1/10 2017-03-20 06:02:51,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb4e80abb488?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 06:02:52,336 unpacking tar archive at: mozilla-central-cb4e80abb488/testing/mozharness/ program finished with exit code 0 elapsedTime=1.640257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 06:02:52.257111) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:52.257923) ========= script_repo_revision: cb4e80abb488f37ec67c4760a128ae177697667b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:52.258902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:52.259546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 06:02:52.270865) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-20 06:02:52.271415) ========= /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=eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:02:52 INFO - MultiFileLogger online at 20170320 06:02:52 in /builds/slave/test 06:02:52 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 06:02:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:02:52 INFO - {'append_to_log': False, 06:02:52 INFO - 'base_work_dir': '/builds/slave/test', 06:02:52 INFO - 'blob_upload_branch': 'Firefox', 06:02:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:02:52 INFO - 'branch': 'Firefox', 06:02:52 INFO - 'buildbot_json_path': 'buildprops.json', 06:02:52 INFO - 'config_files': ('talos/linux_config.py',), 06:02:52 INFO - 'default_actions': ('clobber', 06:02:52 INFO - 'read-buildbot-config', 06:02:52 INFO - 'download-and-extract', 06:02:52 INFO - 'populate-webroot', 06:02:52 INFO - 'create-virtualenv', 06:02:52 INFO - 'install', 06:02:52 INFO - 'run-tests'), 06:02:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:02:52 INFO - 'download_minidump_stackwalk': True, 06:02:52 INFO - 'download_symbols': 'ondemand', 06:02:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:02:52 INFO - 'tooltool.py': '/tools/tooltool.py', 06:02:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:02:52 INFO - '/tools/misc-python/virtualenv.py')}, 06:02:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:02:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:02:52 INFO - 'gecko_profile': False, 06:02:52 INFO - 'gecko_profile_interval': 0, 06:02:52 INFO - 'installer_path': 'installer.exe', 06:02:52 INFO - 'log_level': 'info', 06:02:52 INFO - 'log_name': 'talos', 06:02:52 INFO - 'log_to_console': True, 06:02:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:02:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:02:52 INFO - 'opt_config_files': (), 06:02:52 INFO - 'pip_index': False, 06:02:52 INFO - 'suite': 'dromaeojs', 06:02:52 INFO - 'system_bits': '32', 06:02:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:02:52 INFO - 'title': 'talos-linux64-ix-010', 06:02:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:02:52 INFO - 'use_talos_json': True, 06:02:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:02:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:02:52 INFO - 'work_dir': 'build'} 06:02:52 INFO - [mozharness: 2017-03-20 13:02:52.838097Z] Running clobber step. 06:02:52 INFO - Running pre-action listener: _resource_record_pre_action 06:02:52 INFO - Running main action method: clobber 06:02:52 INFO - rmtree: /builds/slave/test/build 06:02:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:02:53 INFO - Running post-action listener: _resource_record_post_action 06:02:53 INFO - [mozharness: 2017-03-20 13:02:53.780613Z] Finished clobber step (success) 06:02:53 INFO - [mozharness: 2017-03-20 13:02:53.780714Z] Running read-buildbot-config step. 06:02:53 INFO - Running pre-action listener: _resource_record_pre_action 06:02:53 INFO - Running main action method: read_buildbot_config 06:02:53 INFO - Using buildbot properties: 06:02:53 INFO - { 06:02:53 INFO - "project": "", 06:02:53 INFO - "product": "firefox", 06:02:53 INFO - "who": "cbook@mozilla.com", 06:02:53 INFO - "installer_path": "public/build/target.tar.bz2", 06:02:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:02:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:02:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:02:53 INFO - "stage_platform": "linux64-pgo", 06:02:53 INFO - "basedir": "/builds/slave/test", 06:02:53 INFO - "buildnumber": 84, 06:02:53 INFO - "platform": "ubuntu64_hw", 06:02:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:02:53 INFO - "slavebuilddir": "test", 06:02:53 INFO - "taskId": "VvQpxh9vShuaSX-L5HeBPw", 06:02:53 INFO - "branch": "mozilla-central", 06:02:53 INFO - "script_repo_revision": "production", 06:02:53 INFO - "revision": "cb4e80abb488f37ec67c4760a128ae177697667b", 06:02:53 INFO - "slavename": "talos-linux64-ix-010", 06:02:53 INFO - "repo_path": "mozilla-central" 06:02:53 INFO - } 06:02:53 INFO - Finding installer, test and symbols from parent task. 06:02:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VvQpxh9vShuaSX-L5HeBPw'}, attempt #1 06:02:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VvQpxh9vShuaSX-L5HeBPw'}, attempt #1 06:02:54 INFO - Task dependencies: KRMwHafiQCWNBfiGv-Av1Q 06:02:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q'}, attempt #1 06:02:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.tar.bz2 06:02:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/test_packages.json 06:02:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.crashreporter-symbols.zip 06:02:55 INFO - Running post-action listener: _resource_record_post_action 06:02:55 INFO - [mozharness: 2017-03-20 13:02:55.164182Z] Finished read-buildbot-config step (success) 06:02:55 INFO - [mozharness: 2017-03-20 13:02:55.164404Z] Running download-and-extract step. 06:02:55 INFO - Running pre-action listener: _resource_record_pre_action 06:02:55 INFO - Running main action method: download_and_extract 06:02:55 INFO - mkdir: /builds/slave/test/build/tests 06:02: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')]} 06:02:55 INFO - trying https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.test_packages.json 06:02:55 INFO - Downloading https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:02:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:02:55 INFO - Downloaded 986 bytes. 06:02:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:02:55 INFO - Using the following test package requirements: 06:02:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:02:55 INFO - u'common': [u'target.common.tests.zip'], 06:02:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:02:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:02:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:02:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:02:55 INFO - u'mozbase': [u'target.common.tests.zip'], 06:02:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:02:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:02:55 INFO - u'web-platform': [u'target.common.tests.zip', 06:02:55 INFO - u'target.web-platform.tests.zip'], 06:02:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:02:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:02:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.common.tests.zip 06:02:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:02:55 INFO - Fetch https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.common.tests.zip into memory 06:02:56 INFO - Expected file size: 60312708 06:02:56 INFO - Obtained file size: 60312708 06:03:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:03:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.common.tests.zip 06:03:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:03:06 INFO - Fetch https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.common.tests.zip into memory 06:03:07 INFO - Expected file size: 60312708 06:03:07 INFO - Obtained file size: 60312708 06:03:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.talos.tests.zip 06:03:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:03:18 INFO - Fetch https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.talos.tests.zip into memory 06:03:19 INFO - Expected file size: 14404171 06:03:19 INFO - Obtained file size: 14404171 06:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:20 INFO - trying https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.tar.bz2 06:03:20 INFO - Downloading https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:03:21 INFO - Downloaded 67270327 bytes. 06:03:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.tar.bz2 06:03:21 INFO - mkdir: /builds/slave/test/properties 06:03:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:03:21 INFO - Writing to file /builds/slave/test/properties/build_url 06:03:21 INFO - Contents: 06:03:21 INFO - build_url:https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.tar.bz2 06:03:21 INFO - Running post-action listener: _resource_record_post_action 06:03:21 INFO - Running post-action listener: set_extra_try_arguments 06:03:21 INFO - [mozharness: 2017-03-20 13:03:21.224763Z] Finished download-and-extract step (success) 06:03:21 INFO - [mozharness: 2017-03-20 13:03:21.224860Z] Running populate-webroot step. 06:03:21 INFO - Running pre-action listener: _resource_record_pre_action 06:03:21 INFO - Running main action method: populate_webroot 06:03:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:03:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:03:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:03:21 INFO - '--tppagecycles', 06:03:21 INFO - '7'], 06:03:21 INFO - 'tests': ['tsvgm']}}, 06:03:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:03:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:03:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:03:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:03:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:03:21 INFO - 'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:03:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:03:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:03:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:03:21 INFO - 'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['damp', 'tps']}, 06:03:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:03:21 INFO - 'tests': ['damp', 'tps']}, 06:03:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['dromaeo_dom']}, 06:03:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:03:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['basic_compositor_video']}, 06:03:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:03:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['a11yr', 06:03:21 INFO - 'ts_paint', 06:03:21 INFO - 'tpaint', 06:03:21 INFO - 'sessionrestore', 06:03:21 INFO - 'sessionrestore_no_auto_restore', 06:03:21 INFO - 'tabpaint']}, 06:03:21 INFO - 'other-e10s': {'tests': ['a11yr', 06:03:21 INFO - 'ts_paint', 06:03:21 INFO - 'tpaint', 06:03:21 INFO - 'sessionrestore', 06:03:21 INFO - 'sessionrestore_no_auto_restore', 06:03:21 INFO - 'tabpaint']}, 06:03:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:03:21 INFO - 'ts_paint', 06:03:21 INFO - 'tpaint', 06:03:21 INFO - 'sessionrestore', 06:03:21 INFO - 'sessionrestore_no_auto_restore', 06:03:21 INFO - 'tabpaint']}, 06:03:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:03:21 INFO - 'ts_paint', 06:03:21 INFO - 'tpaint', 06:03:21 INFO - 'sessionrestore', 06:03:21 INFO - 'sessionrestore_no_auto_restore', 06:03:21 INFO - 'tabpaint']}, 06:03:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['a11yr', 06:03:21 INFO - 'ts_paint', 06:03:21 INFO - 'tpaint', 06:03:21 INFO - 'sessionrestore', 06:03:21 INFO - 'sessionrestore_no_auto_restore', 06:03:21 INFO - 'tabpaint']}, 06:03:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['a11yr', 06:03:21 INFO - 'ts_paint', 06:03:21 INFO - 'tpaint', 06:03:21 INFO - 'sessionrestore', 06:03:21 INFO - 'sessionrestore_no_auto_restore', 06:03:21 INFO - 'tabpaint']}, 06:03:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['tsvgx', 06:03:21 INFO - 'tsvgr_opacity', 06:03:21 INFO - 'tart', 06:03:21 INFO - 'tscrollx', 06:03:21 INFO - 'cart', 06:03:21 INFO - 'tsvg_static']}, 06:03:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:03:21 INFO - 'tsvgr_opacity', 06:03:21 INFO - 'tart', 06:03:21 INFO - 'tscrollx', 06:03:21 INFO - 'cart', 06:03:21 INFO - 'tsvg_static']}, 06:03:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:03:21 INFO - 'talos_options': ['--disable-e10s'], 06:03:21 INFO - 'tests': ['tp5o']}, 06:03:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:03:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:03:21 INFO - 'talos_options': ['--disable-e10s', 06:03:21 INFO - '--xperf_path', 06:03:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:03:21 INFO - 'tests': ['tp5n']}, 06:03:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:03:21 INFO - 'talos_options': ['--xperf_path', 06:03:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:03:21 INFO - 'tests': ['tp5n']}}, 06:03:21 INFO - 'talos.zip': {'path': '', 06:03:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:03:21 INFO - Running post-action listener: _resource_record_post_action 06:03:21 INFO - [mozharness: 2017-03-20 13:03:21.238095Z] Finished populate-webroot step (success) 06:03:21 INFO - [mozharness: 2017-03-20 13:03:21.238186Z] Running create-virtualenv step. 06:03:21 INFO - Running pre-action listener: _resource_record_pre_action 06:03:21 INFO - Running main action method: create_virtualenv 06:03:21 INFO - Creating virtualenv /builds/slave/test/build/venv 06:03:21 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 06:03:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:03:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:03:21 INFO - Using real prefix '/usr' 06:03:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:03:21 INFO - Installing distribute.............................................................................................................................................................................................done. 06:03:23 INFO - Installing pip.................done. 06:03:23 INFO - Return code: 0 06:03:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:03:23 INFO - Reading from file tmpfile_stdout 06:03:23 INFO - Output received: 06:03:23 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) 06:03:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:03:23 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')]} 06:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:23 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')]} 06:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:03:24 INFO - Using env: {'DISPLAY': ':0', 06:03:24 INFO - 'HOME': '/home/cltbld', 06:03:24 INFO - 'LANG': 'en_US.UTF-8', 06:03:24 INFO - 'LANGUAGE': 'en_US:en', 06:03:24 INFO - 'LOGNAME': 'cltbld', 06:03:24 INFO - 'MAIL': '/var/mail/cltbld', 06:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:24 INFO - 'MOZ_NO_REMOTE': '1', 06:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:24 INFO - 'NO_EM_RESTART': '1', 06:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:24 INFO - 'PWD': '/builds/slave/test', 06:03:24 INFO - 'SHELL': '/bin/bash', 06:03:24 INFO - 'SHLVL': '1', 06:03:24 INFO - 'TERM': 'linux', 06:03:24 INFO - 'TMOUT': '86400', 06:03:24 INFO - 'USER': 'cltbld', 06:03:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:24 INFO - '_': '/tools/buildbot/bin/python'} 06:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:24 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 06:03:24 INFO - Cleaning up... 06:03:24 INFO - Return code: 0 06:03:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:03:24 INFO - Using env: {'DISPLAY': ':0', 06:03:24 INFO - 'HOME': '/home/cltbld', 06:03:24 INFO - 'LANG': 'en_US.UTF-8', 06:03:24 INFO - 'LANGUAGE': 'en_US:en', 06:03:24 INFO - 'LOGNAME': 'cltbld', 06:03:24 INFO - 'MAIL': '/var/mail/cltbld', 06:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:24 INFO - 'MOZ_NO_REMOTE': '1', 06:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:24 INFO - 'NO_EM_RESTART': '1', 06:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:24 INFO - 'PWD': '/builds/slave/test', 06:03:24 INFO - 'SHELL': '/bin/bash', 06:03:24 INFO - 'SHLVL': '1', 06:03:24 INFO - 'TERM': 'linux', 06:03:24 INFO - 'TMOUT': '86400', 06:03:24 INFO - 'USER': 'cltbld', 06:03:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:24 INFO - '_': '/tools/buildbot/bin/python'} 06:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:24 INFO - Downloading/unpacking psutil>=3.1.1 06:03:24 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 06:03:24 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 06:03:24 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 06:03:24 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 06:03:24 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 06:03:24 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 06:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:03:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:03:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:03:26 INFO - Installing collected packages: psutil 06:03:26 INFO - Running setup.py install for psutil 06:03:26 INFO - building 'psutil._psutil_linux' extension 06:03:26 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 06:03:26 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 06:03:26 INFO - building 'psutil._psutil_posix' extension 06:03:26 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 06:03:26 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 06:03:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:03:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:03:27 INFO - Successfully installed psutil 06:03:27 INFO - Cleaning up... 06:03:27 INFO - Return code: 0 06:03:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:03:27 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')]} 06:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:27 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')]} 06:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:27 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 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:27 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 06:03:27 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 06:03:27 INFO - Using env: {'DISPLAY': ':0', 06:03:27 INFO - 'HOME': '/home/cltbld', 06:03:27 INFO - 'LANG': 'en_US.UTF-8', 06:03:27 INFO - 'LANGUAGE': 'en_US:en', 06:03:27 INFO - 'LOGNAME': 'cltbld', 06:03:27 INFO - 'MAIL': '/var/mail/cltbld', 06:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:27 INFO - 'MOZ_NO_REMOTE': '1', 06:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:27 INFO - 'NO_EM_RESTART': '1', 06:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:27 INFO - 'PWD': '/builds/slave/test', 06:03:27 INFO - 'SHELL': '/bin/bash', 06:03:27 INFO - 'SHLVL': '1', 06:03:27 INFO - 'TERM': 'linux', 06:03:27 INFO - 'TMOUT': '86400', 06:03:27 INFO - 'USER': 'cltbld', 06:03:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:27 INFO - '_': '/tools/buildbot/bin/python'} 06:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:03:27 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 06:03:27 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 06:03:27 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 06:03:27 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 06:03:27 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 06:03:27 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 06:03:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:03:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:03:29 INFO - Installing collected packages: mozsystemmonitor 06:03:29 INFO - Running setup.py install for mozsystemmonitor 06:03:29 INFO - Successfully installed mozsystemmonitor 06:03:29 INFO - Cleaning up... 06:03:29 INFO - Return code: 0 06:03:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:29 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 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:29 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 06:03:29 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 06:03:29 INFO - Using env: {'DISPLAY': ':0', 06:03:29 INFO - 'HOME': '/home/cltbld', 06:03:29 INFO - 'LANG': 'en_US.UTF-8', 06:03:29 INFO - 'LANGUAGE': 'en_US:en', 06:03:29 INFO - 'LOGNAME': 'cltbld', 06:03:29 INFO - 'MAIL': '/var/mail/cltbld', 06:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:29 INFO - 'MOZ_NO_REMOTE': '1', 06:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:29 INFO - 'NO_EM_RESTART': '1', 06:03:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:29 INFO - 'PWD': '/builds/slave/test', 06:03:29 INFO - 'SHELL': '/bin/bash', 06:03:29 INFO - 'SHLVL': '1', 06:03:29 INFO - 'TERM': 'linux', 06:03:29 INFO - 'TMOUT': '86400', 06:03:29 INFO - 'USER': 'cltbld', 06:03:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:29 INFO - '_': '/tools/buildbot/bin/python'} 06:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:29 INFO - Downloading/unpacking jsonschema==2.5.1 06:03:29 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 06:03:29 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 06:03:29 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 06:03:29 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 06:03:29 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 06:03:29 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 06:03:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:03:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:03:31 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 06:03:31 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 06:03:31 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 06:03:31 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 06:03:31 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 06:03:31 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 06:03:32 INFO - Downloading functools32-3.2.3-2.tar.gz 06:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:03:32 INFO - warning: no files found matching '*.txt' 06:03:32 INFO - no previously-included directories found matching 'build' 06:03:32 INFO - no previously-included directories found matching 'dist' 06:03:32 INFO - no previously-included directories found matching '.git*' 06:03:32 INFO - Installing collected packages: jsonschema, functools32 06:03:32 INFO - Running setup.py install for functools32 06:03:32 INFO - warning: no files found matching '*.txt' 06:03:32 INFO - no previously-included directories found matching 'build' 06:03:32 INFO - no previously-included directories found matching 'dist' 06:03:32 INFO - no previously-included directories found matching '.git*' 06:03:32 INFO - Successfully installed jsonschema functools32 06:03:32 INFO - Cleaning up... 06:03:32 INFO - Return code: 0 06:03:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:03: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')]} 06:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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')]} 06:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:32 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 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:32 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 06:03:32 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 06:03:32 INFO - Using env: {'DISPLAY': ':0', 06:03:32 INFO - 'HOME': '/home/cltbld', 06:03:32 INFO - 'LANG': 'en_US.UTF-8', 06:03:32 INFO - 'LANGUAGE': 'en_US:en', 06:03:32 INFO - 'LOGNAME': 'cltbld', 06:03:32 INFO - 'MAIL': '/var/mail/cltbld', 06:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:32 INFO - 'MOZ_NO_REMOTE': '1', 06:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:32 INFO - 'NO_EM_RESTART': '1', 06:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:32 INFO - 'PWD': '/builds/slave/test', 06:03:32 INFO - 'SHELL': '/bin/bash', 06:03:32 INFO - 'SHLVL': '1', 06:03:32 INFO - 'TERM': 'linux', 06:03:32 INFO - 'TMOUT': '86400', 06:03:32 INFO - 'USER': 'cltbld', 06:03:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:32 INFO - '_': '/tools/buildbot/bin/python'} 06:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:03:32 INFO - Cleaning up... 06:03:32 INFO - Return code: 0 06:03:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:03: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')]} 06:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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')]} 06:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:32 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 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:32 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 06:03:32 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 06:03:32 INFO - Using env: {'DISPLAY': ':0', 06:03:32 INFO - 'HOME': '/home/cltbld', 06:03:32 INFO - 'LANG': 'en_US.UTF-8', 06:03:32 INFO - 'LANGUAGE': 'en_US:en', 06:03:32 INFO - 'LOGNAME': 'cltbld', 06:03:32 INFO - 'MAIL': '/var/mail/cltbld', 06:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:32 INFO - 'MOZ_NO_REMOTE': '1', 06:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:32 INFO - 'NO_EM_RESTART': '1', 06:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:32 INFO - 'PWD': '/builds/slave/test', 06:03:32 INFO - 'SHELL': '/bin/bash', 06:03:32 INFO - 'SHLVL': '1', 06:03:32 INFO - 'TERM': 'linux', 06:03:32 INFO - 'TMOUT': '86400', 06:03:32 INFO - 'USER': 'cltbld', 06:03:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:32 INFO - '_': '/tools/buildbot/bin/python'} 06:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:03:32 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 06:03:32 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 06:03:32 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 06:03:32 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 06:03:32 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 06:03:32 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 06:03:34 INFO - Downloading blobuploader-1.2.4.tar.gz 06:03:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:03:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:03:34 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 06:03:34 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 06:03:34 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 06:03:34 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 06:03:34 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 06:03:34 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 06:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:03:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:35 INFO - Downloading docopt-0.6.1.tar.gz 06:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:03:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:03:35 INFO - Running setup.py install for blobuploader 06:03:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:03:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:03:35 INFO - Running setup.py install for requests 06:03:36 INFO - Running setup.py install for docopt 06:03:36 INFO - Successfully installed blobuploader requests docopt 06:03:36 INFO - Cleaning up... 06:03:36 INFO - Return code: 0 06:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03: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')]} 06:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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')]} 06:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:36 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 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:36 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 06:03:36 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 06:03:36 INFO - Using env: {'DISPLAY': ':0', 06:03:36 INFO - 'HOME': '/home/cltbld', 06:03:36 INFO - 'LANG': 'en_US.UTF-8', 06:03:36 INFO - 'LANGUAGE': 'en_US:en', 06:03:36 INFO - 'LOGNAME': 'cltbld', 06:03:36 INFO - 'MAIL': '/var/mail/cltbld', 06:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:36 INFO - 'MOZ_NO_REMOTE': '1', 06:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:36 INFO - 'NO_EM_RESTART': '1', 06:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:36 INFO - 'PWD': '/builds/slave/test', 06:03:36 INFO - 'SHELL': '/bin/bash', 06:03:36 INFO - 'SHLVL': '1', 06:03:36 INFO - 'TERM': 'linux', 06:03:36 INFO - 'TMOUT': '86400', 06:03:36 INFO - 'USER': 'cltbld', 06:03:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:36 INFO - '_': '/tools/buildbot/bin/python'} 06:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:36 INFO - Running setup.py (path:/tmp/pip-tlktq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:36 INFO - Running setup.py (path:/tmp/pip-KIxjbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:36 INFO - Running setup.py (path:/tmp/pip-oDZZ2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:36 INFO - Running setup.py (path:/tmp/pip-_S8QWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:36 INFO - Running setup.py (path:/tmp/pip-eAHxxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:36 INFO - Running setup.py (path:/tmp/pip-uW1Ac7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:36 INFO - Running setup.py (path:/tmp/pip-ZRdQYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:36 INFO - Running setup.py (path:/tmp/pip-1tnHo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:36 INFO - Running setup.py (path:/tmp/pip-IreeTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:37 INFO - Running setup.py (path:/tmp/pip-ADK57t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:37 INFO - Running setup.py (path:/tmp/pip-PdjzG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:37 INFO - Running setup.py (path:/tmp/pip-RJj1oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:37 INFO - Running setup.py (path:/tmp/pip-W8t0ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:37 INFO - Running setup.py (path:/tmp/pip-q6pfgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:37 INFO - Running setup.py (path:/tmp/pip-i2VB6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:37 INFO - Running setup.py (path:/tmp/pip-Y2XLD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:37 INFO - Running setup.py (path:/tmp/pip-cnbpuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:03:37 INFO - Running setup.py install for manifestparser 06:03:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:03:37 INFO - Running setup.py install for mozcrash 06:03:37 INFO - Running setup.py install for mozdebug 06:03:37 INFO - Running setup.py install for mozdevice 06:03:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Running setup.py install for mozfile 06:03:38 INFO - Running setup.py install for mozhttpd 06:03:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Running setup.py install for mozinfo 06:03:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Running setup.py install for mozInstall 06:03:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Running setup.py install for mozleak 06:03:38 INFO - Running setup.py install for mozlog 06:03:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Running setup.py install for moznetwork 06:03:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Running setup.py install for mozprocess 06:03:38 INFO - Running setup.py install for mozprofile 06:03:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:03:38 INFO - Running setup.py install for mozrunner 06:03:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:03:39 INFO - Running setup.py install for mozscreenshot 06:03:39 INFO - Running setup.py install for moztest 06:03:39 INFO - Running setup.py install for mozversion 06:03:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:03:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:03:39 INFO - Cleaning up... 06:03:39 INFO - Return code: 0 06:03:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03: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')]} 06:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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')]} 06:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:39 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 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:39 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 06:03:39 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 06:03:39 INFO - Using env: {'DISPLAY': ':0', 06:03:39 INFO - 'HOME': '/home/cltbld', 06:03:39 INFO - 'LANG': 'en_US.UTF-8', 06:03:39 INFO - 'LANGUAGE': 'en_US:en', 06:03:39 INFO - 'LOGNAME': 'cltbld', 06:03:39 INFO - 'MAIL': '/var/mail/cltbld', 06:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:39 INFO - 'MOZ_NO_REMOTE': '1', 06:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:39 INFO - 'NO_EM_RESTART': '1', 06:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:39 INFO - 'PWD': '/builds/slave/test', 06:03:39 INFO - 'SHELL': '/bin/bash', 06:03:39 INFO - 'SHLVL': '1', 06:03:39 INFO - 'TERM': 'linux', 06:03:39 INFO - 'TMOUT': '86400', 06:03:39 INFO - 'USER': 'cltbld', 06:03:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:39 INFO - '_': '/tools/buildbot/bin/python'} 06:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:39 INFO - Running setup.py (path:/tmp/pip-76P0LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:39 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)) 06:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:39 INFO - Running setup.py (path:/tmp/pip-xar861-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:39 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)) 06:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:39 INFO - Running setup.py (path:/tmp/pip-XTiYQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:39 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)) 06:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:39 INFO - Running setup.py (path:/tmp/pip-AlLKuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:39 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)) 06:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:39 INFO - Running setup.py (path:/tmp/pip-dxF7lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:40 INFO - Running setup.py (path:/tmp/pip-YDzCgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:40 INFO - Running setup.py (path:/tmp/pip-NsdGp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:40 INFO - Running setup.py (path:/tmp/pip-maKHa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:40 INFO - Running setup.py (path:/tmp/pip-Pv5zxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:40 INFO - Running setup.py (path:/tmp/pip-wtZkmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:40 INFO - Running setup.py (path:/tmp/pip-4Q5QEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:40 INFO - Running setup.py (path:/tmp/pip-ybMNmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:40 INFO - Running setup.py (path:/tmp/pip-UWudPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:40 INFO - Running setup.py (path:/tmp/pip-SAXLxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:40 INFO - Running setup.py (path:/tmp/pip-qPkhpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:40 INFO - Running setup.py (path:/tmp/pip-KRslk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:40 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)) 06:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:40 INFO - Running setup.py (path:/tmp/pip-0UoYck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:40 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)) 06:03:40 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)) 06:03:40 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)) 06:03:40 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)) 06:03:40 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)) 06:03:40 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)) 06:03:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:42 INFO - Downloading blessings-1.6.tar.gz 06:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:03:43 INFO - Installing collected packages: blessings 06:03:43 INFO - Running setup.py install for blessings 06:03:43 INFO - Successfully installed blessings 06:03:43 INFO - Cleaning up... 06:03:43 INFO - Return code: 0 06:03:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:03:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:03:43 INFO - Reading from file tmpfile_stdout 06:03:43 INFO - Current package versions: 06:03:43 INFO - argparse == 1.2.1 06:03:43 INFO - blessings == 1.6 06:03:43 INFO - blobuploader == 1.2.4 06:03:43 INFO - docopt == 0.6.1 06:03:43 INFO - functools32 == 3.2.3-2 06:03:43 INFO - jsonschema == 2.5.1 06:03:43 INFO - manifestparser == 1.1 06:03:43 INFO - mozInstall == 1.12 06:03:43 INFO - mozcrash == 1.0 06:03:43 INFO - mozdebug == 0.1 06:03:43 INFO - mozdevice == 0.49 06:03:43 INFO - mozfile == 1.2 06:03:43 INFO - mozhttpd == 0.7 06:03:43 INFO - mozinfo == 0.9 06:03:43 INFO - mozleak == 0.1 06:03:43 INFO - mozlog == 3.4 06:03:43 INFO - moznetwork == 0.27 06:03:43 INFO - mozprocess == 0.25 06:03:43 INFO - mozprofile == 0.28 06:03:43 INFO - mozrunner == 6.13 06:03:43 INFO - mozscreenshot == 0.1 06:03:43 INFO - mozsystemmonitor == 0.3 06:03:43 INFO - moztest == 0.8 06:03:43 INFO - mozversion == 1.4 06:03:43 INFO - psutil == 3.1.1 06:03:43 INFO - requests == 1.2.3 06:03:43 INFO - wsgiref == 0.1.2 06:03:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:43 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 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:43 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 06:03:43 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 06:03:43 INFO - Using env: {'DISPLAY': ':0', 06:03:43 INFO - 'HOME': '/home/cltbld', 06:03:43 INFO - 'LANG': 'en_US.UTF-8', 06:03:43 INFO - 'LANGUAGE': 'en_US:en', 06:03:43 INFO - 'LOGNAME': 'cltbld', 06:03:43 INFO - 'MAIL': '/var/mail/cltbld', 06:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:43 INFO - 'MOZ_NO_REMOTE': '1', 06:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:43 INFO - 'NO_EM_RESTART': '1', 06:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:43 INFO - 'PWD': '/builds/slave/test', 06:03:43 INFO - 'SHELL': '/bin/bash', 06:03:43 INFO - 'SHLVL': '1', 06:03:43 INFO - 'TERM': 'linux', 06:03:43 INFO - 'TMOUT': '86400', 06:03:43 INFO - 'USER': 'cltbld', 06:03:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:43 INFO - '_': '/tools/buildbot/bin/python'} 06:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 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)) 06:03:43 INFO - Cleaning up... 06:03:43 INFO - Return code: 0 06:03:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, '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': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', '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 06:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:03:43 INFO - Using env: {'DISPLAY': ':0', 06:03:43 INFO - 'HOME': '/home/cltbld', 06:03:43 INFO - 'LANG': 'en_US.UTF-8', 06:03:43 INFO - 'LANGUAGE': 'en_US:en', 06:03:43 INFO - 'LOGNAME': 'cltbld', 06:03:43 INFO - 'MAIL': '/var/mail/cltbld', 06:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:43 INFO - 'MOZ_NO_REMOTE': '1', 06:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:43 INFO - 'NO_EM_RESTART': '1', 06:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:43 INFO - 'PWD': '/builds/slave/test', 06:03:43 INFO - 'SHELL': '/bin/bash', 06:03:43 INFO - 'SHLVL': '1', 06:03:43 INFO - 'TERM': 'linux', 06:03:43 INFO - 'TMOUT': '86400', 06:03:43 INFO - 'USER': 'cltbld', 06:03:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:43 INFO - '_': '/tools/buildbot/bin/python'} 06:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:03:43 INFO - Cleaning up... 06:03:43 INFO - Return code: 0 06:03:43 INFO - Running post-action listener: _resource_record_post_action 06:03:43 INFO - Running post-action listener: _start_resource_monitoring 06:03:43 INFO - Starting resource monitoring. 06:03:43 INFO - [mozharness: 2017-03-20 13:03:43.953961Z] Finished create-virtualenv step (success) 06:03:43 INFO - [mozharness: 2017-03-20 13:03:43.954488Z] Running install step. 06:03:43 INFO - Running pre-action listener: _resource_record_pre_action 06:03:43 INFO - Running main action method: install 06:03:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:03:44 INFO - Reading from file tmpfile_stdout 06:03:44 INFO - Detecting whether we're running mozinstall >=1.0... 06:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:03:44 INFO - Reading from file tmpfile_stdout 06:03:44 INFO - Output received: 06:03:44 INFO - Usage: mozinstall [options] installer 06:03:44 INFO - Options: 06:03:44 INFO - -h, --help show this help message and exit 06:03:44 INFO - -d DEST, --destination=DEST 06:03:44 INFO - Directory to install application into. [default: 06:03:44 INFO - "/builds/slave/test"] 06:03:44 INFO - --app=APP Application being installed. [default: firefox] 06:03:44 INFO - mkdir: /builds/slave/test/build/application 06:03:44 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'] 06:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:04:00 INFO - Reading from file tmpfile_stdout 06:04:00 INFO - Output received: 06:04:00 INFO - /builds/slave/test/build/application/firefox/firefox 06:04:00 INFO - Running post-action listener: _resource_record_post_action 06:04:00 INFO - [mozharness: 2017-03-20 13:04:00.968174Z] Finished install step (success) 06:04:00 INFO - [mozharness: 2017-03-20 13:04:00.968448Z] Running run-tests step. 06:04:00 INFO - Running pre-action listener: _resource_record_pre_action 06:04:00 INFO - Running main action method: run_tests 06:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:04:00 INFO - Python 2.7.3 06:04:00 INFO - Return code: 0 06:04:00 INFO - grabbing minidump binary from tooltool 06:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:00 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 0x10de400>, '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 0x10df3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:04:00 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 06:04:00 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 06:04:00 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 06:04:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:04:01 INFO - Return code: 0 06:04:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:04:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:04:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:04:01 INFO - ENV: RUST_BACKTRACE is now 1 06:04:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:04:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:04:01 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/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 06:04:01 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/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 06:04:01 INFO - Using env: {'DISPLAY': ':0', 06:04:01 INFO - 'HOME': '/home/cltbld', 06:04:01 INFO - 'LANG': 'en_US.UTF-8', 06:04:01 INFO - 'LANGUAGE': 'en_US:en', 06:04:01 INFO - 'LOGNAME': 'cltbld', 06:04:01 INFO - 'MAIL': '/var/mail/cltbld', 06:04:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:04:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:01 INFO - 'MOZ_NO_REMOTE': '1', 06:04:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:01 INFO - 'NO_EM_RESTART': '1', 06:04:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:01 INFO - 'PWD': '/builds/slave/test', 06:04:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:04:01 INFO - 'RUST_BACKTRACE': '1', 06:04:01 INFO - 'SHELL': '/bin/bash', 06:04:01 INFO - 'SHLVL': '1', 06:04:01 INFO - 'TERM': 'linux', 06:04:01 INFO - 'TMOUT': '86400', 06:04:01 INFO - 'USER': 'cltbld', 06:04:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156', 06:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:01 INFO - '_': '/tools/buildbot/bin/python'} 06:04:01 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/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 06:04:01 INFO - mozversion application_buildid: 20170320120919 06:04:01 INFO - mozversion application_changeset: cb4e80abb488f37ec67c4760a128ae177697667b 06:04:01 INFO - mozversion application_display_name: Nightly 06:04:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:04:01 INFO - mozversion application_name: Firefox 06:04:01 INFO - mozversion application_remotingname: firefox 06:04:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:04:01 INFO - mozversion application_vendor: Mozilla 06:04:01 INFO - mozversion application_version: 55.0a1 06:04:01 INFO - mozversion platform_buildid: 20170320120919 06:04:01 INFO - mozversion platform_changeset: cb4e80abb488f37ec67c4760a128ae177697667b 06:04:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:04:01 INFO - mozversion platform_version: 55.0a1 06:04:01 INFO - using testdate: 1490015041 06:04:01 INFO - actual date: 1490015041 06:04:01 INFO - starting webserver on 'localhost:46387' 06:04:01 INFO - SUITE-START | Running 2 tests 06:04:01 INFO - TEST-START | dromaeo_css 06:04:01 INFO - operating with platform_type : linux_ 06:04:01 INFO - Initialising browser for dromaeo_css test... 06:04:01 INFO - TEST-INFO | started process 12059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd8gCKZ/profile http://localhost:46387/getInfo.html) 06:04:05 INFO - PID 12059 | __metrics Screen width/height:1600/1200 06:04:05 INFO - PID 12059 | colorDepth:24 06:04:05 INFO - PID 12059 | Browser inner width/height: 1024/697 06:04:05 INFO - PID 12059 | __metrics 06:04:06 INFO - PID 12059 | 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" 06:04:06 INFO - PID 12059 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:04:07 INFO - TEST-INFO | 12059: exit 0 06:04:07 INFO - Browser initialized. 06:04:07 INFO - Running cycle 1/1 for dromaeo_css test... 06:04:07 INFO - TEST-INFO | started process 12152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd8gCKZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:19 INFO - PID 12152 | RSS: Main: 145285120 06:04:19 INFO - PID 12152 | 06:07:22 INFO - PID 12152 | Cycle 1(1): loaded http://localhost:46387/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46387/tests/dromaeo/cssquery-ext.html) 06:07:24 INFO - PID 12152 | RSS: Main: 300412928 06:07:24 INFO - PID 12152 | 06:09:09 INFO - PID 12152 | ************************* 06:09:09 INFO - PID 12152 | A coding exception was thrown and uncaught in a Task. 06:09:09 INFO - PID 12152 | 06:09:09 ERROR - PID 12152 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:09:09 INFO - PID 12152 | Full stack: 06:09:09 INFO - PID 12152 | ************************* 06:10:26 INFO - PID 12152 | Cycle 1(1): loaded http://localhost:46387/tests/dromaeo/cssquery-ext.html (next: http://localhost:46387/tests/dromaeo/cssquery-jquery.html) 06:10:26 INFO - PID 12152 | RSS: Main: 232480768 06:10:26 INFO - PID 12152 | 06:13:28 INFO - PID 12152 | Cycle 1(1): loaded http://localhost:46387/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46387/tests/dromaeo/cssquery-mootools.html) 06:13:29 INFO - PID 12152 | RSS: Main: 210386944 06:13:29 INFO - PID 12152 | 06:16:31 INFO - PID 12152 | Cycle 1(1): loaded http://localhost:46387/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46387/tests/dromaeo/cssquery-prototype.html) 06:16:31 INFO - PID 12152 | RSS: Main: 177803264 06:16:31 INFO - PID 12152 | 06:19:34 INFO - PID 12152 | Cycle 1(1): loaded http://localhost:46387/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46387/tests/dromaeo/cssquery-yui.html) 06:19:35 INFO - PID 12152 | RSS: Main: 184250368 06:19:35 INFO - PID 12152 | 06:22:37 INFO - PID 12152 | Cycle 1(1): loaded http://localhost:46387/tests/dromaeo/cssquery-yui.html (next: http://localhost:46387/tests/dromaeo/cssquery-dojo.html) 06:22:38 INFO - PID 12152 | RSS: Main: 276680704 06:22:38 INFO - PID 12152 | 06:22:38 INFO - PID 12152 | __start_tp_report 06:22:38 INFO - PID 12152 | _x_x_mozilla_page_load 06:22:38 INFO - PID 12152 | _x_x_mozilla_page_load_details 06:22:38 INFO - PID 12152 | |i|pagename|runs| 06:22:38 INFO - PID 12152 | |0;dojo.html;3214.292855571774;3256.837158142094;3282.934341313175;3285.7864238824473;3295.9505607415886;5513.145462453316;5604.327480702322;5612.775488980441;5639.182318563811;5643.858903527409;5541.196526503654;5617.4382561743805;5622.409646987058;5639.68981706006;5699.173619825123;5025.84922452327;5055.696658200502;5062.645614806965;5077.720725360104;5084.339035925324;5031.32077169581;5072.061668591323;5100.132977393852;5112.846614601568;5122.871928201787;5005.399352077738;5063.518965698289;5070.29015937769;5108.080545501808;5178.5339319461245;5029.2958985742025;5041.470645582234;5060.1903695408555;5064.11378008847;5090.160123579605;5008.574271186953;5017.598592112622;5017.9247311290355;5034.572061374787;5059.519345662156;5552.361478429992;5573.164025396182;5602.60781745278;5604.635698679614;5607.102863541813;5735.684537350444;5875.823725288248;5929.080992446177;5929.555283353766;6004.399560044004;5831.446012628793;6042.909356359658;6058.030715085565;6113;6123.663198524079;5640.576956728261;5650.378458369576;5650.491455768959;5656.745446454878;5660.094384898396;5994.310654274727;6141.201643786279;6190.783322583778;6197.411245931719;6205.100260462208;5833.7083145842535;5865.266841644794;5881.206037184926;5885.646861188342;5886.087656413263;5979.671118088547;5995.040793473024;6046.697665116727;6066.666333351708;6067.362926892701;6000.309964354068;6005.099235114681;6009.218801555857;6012.188354572164;6015.007523758531;6005.549583781234;6010.519158467312;6014.879702405928;6015.157877897098;6017.849553761191;4533.342665313511;4587.6788624795945;4587.816487340469;4625.4911959684405;4627.583517483443;4089.8568550100604;4090.550039495653;4096.856610018635;4126.154138401621;4127.6491498222385;5642.548596112301;5644.181593668895;5682;5696.1455781633085;5738.885222295531;5909.2908850938165;6005.519558435315;6018.368071352533;6066.241719785027;6104.053871649901;5690.260266165372;5699.344575373802;5699.658020518782;5722.341930678025;5751.769929202868;5148.124818780816;5155.922661160085;5157.974210128926;5160.716160611128;5197.558207552324;6130.642739936431;6131.315499379051;6143.447089761943;6283.434490895841;6290.087937249074;6022.367651396716;6052.969735151296;6080.331163572092;6092.9086063709965;6093.542984276109;6155.538334625011;6156.661383623944;6168.5758929905;6208.81373558794;6229.221347331583;5803.187553742564;5828;5835.912461312999;5870.677112758839;5879.735411906389;5970.701464926649;6097.403692570384;6108.281362586102;6109.374301064966;6114.206128133634;5840.123981402823;5841.50347220491;5861.3845546217035;5918.17145599625;5939.406059394026;5871.588988770745;5888.528917686661;5891.293044834647;5900.1149827526215;5903.468687818117;5895.056790913433;5901.822945311647;5902.557308201816;5903.704814759159;5907.468327850343;5839.270091238595;5914.881702366015;5917.289925209003;5942.019566771434;5962.731677074629;5802.187693722966;5804.506616937439;5815.912761308499;5824.679642619527;5852.209951656472 06:22:38 INFO - PID 12152 | |1;ext.html;670.2761018100449;744.6872313628277;762.131170465669;822.3667775812628;833.720703564306;29033.56449653254;39678.60321396785;39850.80074599623;39871;39912;42608;42976.785116074454;42984.35523467143;42989;43041.35437968425;7101.609411482366;7202.891956620629;8523.062463129067;8759.95620021899;8763.56182190891;9790.706278811647;9975.401475911432;9982.35114717541;9983.800323993552;9985;10268.127209187229;10400.323978941382;10411;10420.791584168312;10422.89577104227;10225.539850706737;10242.231832612546;10243.79512409755;10249.487525623688;10258.384496930208;9939.80120397588;10316.48417579118;10326.225533084973;10329.948350258275;10331.638392656296;39915.60084399148;40188;40196.39705404421;40208;40240.79879600612;3689.760165589255;3726.441033844918;3734;3777.9811100944594;3787.242551489713;27932.58101128485;28044.298892527648;28390.290242744097;28415.431691366262;29143.125706228846;3995.20095980805;4046.089629833293;4057.97971010146;4072.6131017553284;4077.245709543744;220730;221983;222187;222344;222785;50127.498725013014;50275.74862125666;50396;50425.747871260406;50472;52673;52765.736171319666;52792;52829.47170528323;52951;13792;14045.578632641038;14071;14118.85881141196;14129.293535323193;9777.315587908779;9922.80154396908;10328.122109620615;11095.72260693489;11117.944410277896;12986.35068246584;13012.544560940321;13074.215547067206;13090.541831035867;13096;5168.586513078944;5305.867353316121;5325.707086110224;5347.545458636059;5394.865128371822;930.8743319651895;935.504182783126;945.3146468810195;950.3585080070925;957.3155194036298;23979.160729374387;25575.74424255771;25879.22362329133;26054.86972565125;26074.478510430064;996.8704068471052;1003.4430890855499;1009.8889122196553;1012.1295685710284;1029.7528593137592;12993.090483666052;13394.129381590166;13421.030474426298;13510.93244533771;13721.862781372258;280584;281567;281639;281780;281893;50119.74940125276;50412;50455.49544504582;50474.49525504772;50567.74716126396;1397.3711829676686;1406.8030475733406;1411.5254642782404;1417.6172433442912;1533.4326299269119;24038;24159.75840241575;24957.001719931;25003;25031.499370012134;37392.25215495729;37405.43891841679;37448.438273426465;37489.625103748614;37515.6248437523;260384;260548;261145;262258;266460;32501.674983249864;33655.495167572015;33861.830690846386;34196;34197;42929.75394177009;43116;43239;44156.558434415245;44715.55284447114;35410.46884296686;35421.46867796934;35504.644953551164;35628.82185589056;35663.68894376595;35107.29785404226;35298;35678.64321356857;35817.641823582475;36198.63801361953;36791.44812827863;36946;36990.26019479542;37093.62906370902;37279.44080838844;30085.699143009166;30218.395632087675;31566.210844729067;31708.207294817814;31749.99875039355;23769.881150594138;24037.51924961526;24110.51778964446;24268.393290167885;24444.511109777348 06:22:38 INFO - PID 12152 | |2;jquery.html;398.18968399307414;423.8528922748593;430.28621451993405;448.40810130627574;455.01510093784776;16953.576160595974;19269.903650481745;20944.685829712565;21213.363599092052;21429.67855482169;19237.23051077955;20069.698954515694;20190.596188076266;21136.15455381783;21183.894080529575;6182.258129024523;6405.19935008124;6476.514261430388;6483.675816209195;6486.124373209604;6217.316095229521;6496.545241833073;6503.219613646345;6507.967460162693;6534.24856141545;6297.716602752887;6299.118123462719;6344.509040375531;6511.088447617338;6523.869522609545;6377.968110159442;6443.130177426081;6491.8052458425855;6496.740130394802;6497.5126865485045;6929.688164032631;7151.713931442736;7175.677094530759;7186.532875363085;7198.136223653143;24483.510329793306;24862.627060594106;24976.375590610198;24989.250322490356;25434.618480722806;3204.19777840958;3244.740420766333;3253.381857447101;3273.7872038317673;3289.342131573695;15472.381104755796;15725.764113538306;15734.527964161094;15793.131377774218;16235.918820405941;2142.3572928121503;2174.836887233448;2196.890155492219;2199.7030400895997;2199.8900054997184;103988;104996.47501762518;106376;106630;108898;14748.89383296257;18720.438386848415;18870.528236793914;18935.621287574173;19139.521511962033;28539.004539364505;29148.708512915022;29211.7078829209;29294.414111718073;29435;8356.665733370719;8701.608427620773;8776.473411595198;8826.169342774534;8973.461592304482;7263.25681836366;7316.719574074516;7442.813929651694;7463.888041679379;7463.925360746432;9686.75783105414;9689.176420004238;9942.80114397708;10021.549030293509;10065.899341006643;3613.584437789688;3790.298794722985;3792.810359482015;3954.7937878946623;4002.139539998914;890.1587999340561;905.1265528764774;918.150710592699;919.7102912582515;936.7423958411491;21735;22809;22853.657195142085;22936.4265893354;23012.309630711105;918.5774543709834;924.3206243411088;930.8277968575835;939.2392162348519;940.6096469965024;11782.764344713229;12368.75262494745;12528.109539753099;13679.86320136786;13930.164190148624;601549;616331;621143;623573;625119;80192.59903700445;83037.16962830295;106895;113130;113577.58082012241;1245.2466257914014;1279.328352614866;1308.4242933109401;1328.647908304281;1332.2938842413537;19569.21723131116;19798.40604781801;20508.589828203054;20557.177712891316;20562;50008.74995625144;50817.745911270205;51306.74346628243;51514.22728658998;51687;65137;66579.33420665924;66759;68249.97625035529;69822.30177698362;11922.940385298018;11998.940005299917;12094.334811585448;12151.513939442677;12255.325957072446;14142.78785818193;14328.14031158134;14457.783133252799;14568.927155364156;14643.19462429534;11574.594889178838;12013.63959081229;12295.9385203077;12617.558385456465;12645.494180232688;12085.15403921717;12252.264864108181;12284.262944223017;12499.250044997329;12965.740685186054;12079.818802717791;12238.388080595756;12642.2414655121;12704.745905081661;13083.280419577015;12226.44980975876;12439.014636486996;12457.501699932263;12710.936445317715;12774;12405.317707526172;12449.190802597803;12503.124781265224;12826.98565837009;12829.294388808705 06:22:38 INFO - PID 12152 | |3;mootools.html;1502.842201568836;1515.51503518874;1518.491305412686;1542.421591903036;1586.8889177757555;9679.903200967989;10076.445795481246;10078.546465409056;10079.596816127365;10083.798324033523;9945.254105942047;10271.024252696001;10279.331843430171;10285.588576456932;10287.63993260236;1942.2522328903367;1961.1567026178736;1975.456749393921;1980.6632872411724;1982.603479304145;2070.0581235537793;2098.842586805988;2103.842211834111;2108.8734675919495;2110.3774386555924;2062.2060506704875;2067.059487932994;2088.5092003379195;2089.3209706845337;2090.916363345472;1871.9064046797673;1874.6531891600098;1878.690016147334;1881.0594702648675;1883.896385698786;2033.3188381892085;2041.6120937022067;2047.2732180076157;2079.563291708728;2080.8023237792386;10356.275060745751;10401.063904248578;10413.583456661725;10457.68626941193;10464.476776161162;4982.252662100677;5160.458151894035;5162.845114646567;5169.870753231162;5174.275601415805;3067.877284908601;3216.244182617083;3275.3613045456145;3367.0908854609365;3377.155711072232;1142.4687520303098;1212.5452955141823;1264.6206138158607;1270.6442196185083;1286.7876800327936;12820.35898205086;13251.469941202437;13259.46962121514;15258;15440;3435.49793396261;4134.111166099303;4243.066525364477;4325.048489332342;4330.069035157393;11033.172512061628;11065.170112241614;11070.778584428428;11076.944615276872;11080.39057851826;5305.124654432053;5319.255304257407;5319.654222475527;5320.068987927175;5327.09439395296;4732.337472753818;4845.5881250094135;4850.733209673502;4855.635827312965;4858.4898585648;3434.4161492546327;3562.5546806649168;3595.496630471736;3631.1829838286703;3631.782093074424;929.1916033051289;934.4206591912922;935.8081593273363;937.2642475656713;942.6794889737522;745.1579714922103;808.1030056637128;885.371386315723;906.5331354352513;925.2690374604122;6293.716782744787;6316.8420789479715;6330.240371155491;6471.158749362553;6513.576617519846;982.6511588386163;987.7728122531857;998.825205589019;1010.1918465227935;1012.0739523336213;4135.255653982312;4231.682623803227;4233.25917964355;4287.699861009762;4406.757628330409;12175.208611440405;12463.18989265713;12464.750704985849;12493.93753031229;12588.496460141674;12151.63545093631;12370.257784532956;12373.62879113628;12392.31842248685;12393.256404615751;8204.466709663971;8429.662813487392;8953.776155596031;9115.179633832988;9339.991901741023;5910.763569457174;5975.940240597538;5976.282846058501;6078.057901025348;6187.84530386744;11195.944020279847;11276.379799111128;11335.489902954221;11353.205275630957;11441;11823.82264266054;11909.404529773303;12030.63908082759;12040.518379264731;12040.879591204326;8547.102554231964;8687.39188256816;8727.519986400808;8847;8859.202671759314;9736.075072868067;9742.9025709742;9822.75443113928;9861.161801246973;9874.901250987397;8310.293625041939;8353.20644538768;8376.204260595234;8469.237768600855;8485.236328730443;8418.326533877153;8435.704750333955;8438.240558349778;8570.657173712982;8776.78058048554;7689.50018248812;7754.922450775645;7756.457048006585;7761.805954851174;7769.067711874612;5562.749676264497;5565.16522521625;5586.916196257141;5684.005299072728;5771.451712087345;5624.184493248375;5627.071533196977;5653.462921022497;5691.089425692035;5748.712564371681 06:22:38 INFO - PID 12152 | |4;prototype.html;406.74946805878574;409.6338710400813;410.4151583992813;418.0593664255427;420.5311078147864;5750.856228594287;5796.565257605681;5804.883902321962;5831.737571809268;5844.678542680156;5495.505404513593;5554.1946417769395;5634.436556344363;5642.633228840123;5658.377578466376;4484.103179364124;4486.416765820447;4495.617872480843;4504.279315309551;4510.819567217307;4519.186546421643;4522.525134860842;4524.09518096382;4536.455625324966;4545;4354.869353919372;4430.911381772363;4460.30865215892;4464.776761161945;4509.255972764507;4435.68950173488;4448.5773851484055;4451.799669014902;4455.710378825366;4484.125595508877;4056.837726490937;4063.3904914262803;4074.6332830045144;4081.3673880548563;4089.6114869087387;5308.840734777924;5559.444055594408;5582.204101211175;5608.775648974077;5621.662700237958;5225.843224703265;5241.895162096736;5242.16125419931;5250.789968401259;5310.415854256029;5833.416658334175;5997.160397544304;6014.12795144706;6021.939780602182;6022.09668549721;4494.280915053609;4509.098180363941;4515.532451953129;4516.503184649686;4538.3873177120995;5937.70311484424;6183.381661833826;6308.653024083674;6321.905171422432;6333.588316759396;5278;5382.273393091882;5382.542483888835;5396.493927570523;5396.757145928443;5467.1799230115;5477.4796394342475;5479.342478902558;5481.671099734029;5535.418781028015;5506.174073888948;5668.206451096849;5669.886602267931;5694.857628559319;5726.513246374105;6009.429104235091;6038.215032045806;6040.426159514839;6043.305019922677;6051.485623721945;1904.2668572599648;1910.216811107467;1914.550080731027;1934.9032548372525;1943.5821298420908;1521.773839460329;1535.9155246461553;1550.3101120001716;1571.3793051744497;1590.7909988408662;5809.796657116981;5810.6513609183585;5817.94182058174;5833.241678581757;5845.444682755132;6199.597026193283;6201.573638063181;6210.875782484325;6213.1922850029205;6230.096635987847;5526.226328314039;5773.797917072882;5825.126231065374;5833.416658334133;5842;3240.951385729216;3275.852586633607;3284.687954644305;3290.588676415448;3294.341131773655;6324.778632747832;6430.292667806538;6454.32229615893;6475.902861457082;6508.284088750233;6393.904091438632;6399.008153736178;6425.1968503937005;6439.58142720731;6449.516286278454;6358.713857876407;6430.131932189094;6525.347465253437;6534.117894084237;6535.803925882231;6220.440160385587;6239.908016097255;6248.125262463168;6248.4688801452385;6260.968695156495;5806.883862322646;6053.061775424816;6148.661823599566;6169.598976066542;6186.164867742978;6216.7824126155365;6438.90341644885;6442.549021568445;6455.709493072729;6456.515761317826;5044.344235249394;5072.416672082758;5082.085224659597;5084.51697088776;5092.8472145835685;6032.849178770566;6134.478569321657;6195.659238741912;6198.752049918133;6254.718537665907;6035.969820151046;6047.395260473917;6049.546284028627;6053.576249662481;6056.152138700498;5774.7690092397515;6033.939660603338;6044.455998960115;6064.818055458343;6097.085437184458;6030.547708921936;6098.207233059674;6106.877862442638;6120.693965301628;6121.296050954197;5937.940620593911;6100.420460056288;6111.297200821785;6173.166622505904;6180.598261113013;5894.557908156819;5902.085176797603;5925.703714814328;5968.104784282219;5971.58198926071 06:22:38 INFO - PID 12152 | |5;yui.html;693.2028167607255;739.6523633892069;829.9618197754746;832.6378025558879;852.7740148860549;14563.56309310721;15077;15170.696586068272;15195.240237988084;15209.619759506004;14253.07355021923;14451.277436128177;14475.059121157117;14489.78265326021;15001.924990375033;796.0924546017544;801.5070731500143;822.3626689315769;824.826786374859;831.4387788242942;788.2629741192004;789.2462698123308;790.1111249843925;798.636620337745;832.014063334947;821.2977903892175;821.593311310902;821.7945513621595;826.5660528222671;861.4400639584258;814.3932770086265;816.8815521749314;816.8897198878135;823.8311146215011;859.9871001934945;596.4065754574183;598.868248985227;599.0176111177672;617;629.7355110853453;14229;14332.713345733027;14379.928100359431;14819.703605927822;15657;14458.204798736066;16109.19454027294;16386.262618182092;16729.330826766916;16821.83178168227;11440.828387574193;11740.236884602473;11822.467988940518;11939.985101266402;12436.378181091;3671.118931456458;3761.4545890845948;3768.171002379472;3833.463315135883;3871;84696;85137;86036.56981715115;86058.56970715107;88090;11631.76736465283;11798.587049453228;11954.52181912731;12497.625071247878;13045.086843921024;25030;25064.624030639556;25417.491650167263;25865.74134258671;25982.74017259803;7576.792830175588;7773.572453515111;7788.532688038736;7812.414068944852;7988.760337189894;4277.978610106992;4330.566943305645;4419.0940857124215;4426.9778651106535;4469.061497085583;3408.454647256427;3464.9653503465147;3484.059303987909;3484.790912545255;3490.3542844573835;579.8521377048826;580.0718849840306;587.6532845621105;601.9729112189962;602.16299343912;673.71367168953;694.9131358580178;696.864111498253;710.4281053751677;720.8518614528733;9223.677171298972;10001.799964000826;10257.74355641115;10318.27772055964;10399.324043937271;662.9602223866583;689.2005273882272;690.81348036031;691.312144416309;693.8473535822111;4487.214737420938;4766.880827979328;4799.3041009053495;4831.275308703653;4840.491748366441;74504;74816.25183748093;74837.62581187168;78115.2188478108;78420.60789696129;65714;67159.32840671531;67443.32556674468;67755;67786.66106669533;59389.40610593839;60080;61195;61324;61557.69221153955;9187.770305742142;9518.904810951803;9561.330706850455;9573.952130239304;9585.808283834423;41021.58978410178;41960.90195490152;41985.58014419817;42715.78642106769;43458.78270608627;39410.21179576335;44779.552204477535;46094.76952615215;46590.30114548217;46670.76664616655;11118.944405278246;11213.271137376045;11488.94255528717;11519.42402879836;11625.534978600761;12346.259224446561;12379.69050773738;12407.317597532223;12755.234685918875;13205.075644704779;12310.630681079581;12328.938355308166;12330.876691232972;12344.197627154206;12487.438065287266;11993;12145.39273036327;12179.39103044862;12284.754304913673;12350;12246.203996740183;12897.742045159232;13009.284489352798;13116.606501804961;13235.40440680191;12121.575744848888;12151.96163689233;12275.263484190977;12488.188267762567;13257.80113298282;11956.42405663673;12161.81757273624;12213.511459541518;12380.566680166152;12407.985337098062 06:22:38 INFO - PID 12152 | __end_tp_report 06:22:38 INFO - PID 12152 | __start_cc_report 06:22:38 INFO - PID 12152 | _x_x_mozilla_cycle_collect,1645 06:22:38 INFO - PID 12152 | __end_cc_report 06:22:38 INFO - PID 12152 | __startTimestamp1490016158224__endTimestamp 06:22:38 INFO - PID 12152 | 06:22:38 INFO - PID 12152 | ------- Summary: start ------- 06:22:38 INFO - PID 12152 | Number of tests: 6 06:22:38 INFO - PID 12152 | 06:22:38 INFO - PID 12152 | [#0] dojo.html Cycles:165 Average:5578.97 Median:5831.45 stddev:637.78 (10.9%) stddev-sans-first:612.16 06:22:38 INFO - PID 12152 | Values: 3214.3 3256.8 3282.9 3285.8 3296.0 5513.1 5604.3 5612.8 5639.2 5643.9 5541.2 5617.4 5622.4 5639.7 5699.2 5025.8 5055.7 5062.6 5077.7 5084.3 5031.3 5072.1 5100.1 5112.8 5122.9 5005.4 5063.5 5070.3 5108.1 5178.5 5029.3 5041.5 5060.2 5064.1 5090.2 5008.6 5017.6 5017.9 5034.6 5059.5 5552.4 5573.2 5602.6 5604.6 5607.1 5735.7 5875.8 5929.1 5929.6 6004.4 5831.4 6042.9 6058.0 6113.0 6123.7 5640.6 5650.4 5650.5 5656.7 5660.1 5994.3 6141.2 6190.8 6197.4 6205.1 5833.7 5865.3 5881.2 5885.6 5886.1 5979.7 5995.0 6046.7 6066.7 6067.4 6000.3 6005.1 6009.2 6012.2 6015.0 6005.5 6010.5 6014.9 6015.2 6017.8 4533.3 4587.7 4587.8 4625.5 4627.6 4089.9 4090.6 4096.9 4126.2 4127.6 5642.5 5644.2 5682.0 5696.1 5738.9 5909.3 6005.5 6018.4 6066.2 6104.1 5690.3 5699.3 5699.7 5722.3 5751.8 5148.1 5155.9 5158.0 5160.7 5197.6 6130.6 6131.3 6143.4 6283.4 6290.1 6022.4 6053.0 6080.3 6092.9 6093.5 6155.5 6156.7 6168.6 6208.8 6229.2 5803.2 5828.0 5835.9 5870.7 5879.7 5970.7 6097.4 6108.3 6109.4 6114.2 5840.1 5841.5 5861.4 5918.2 5939.4 5871.6 5888.5 5891.3 5900.1 5903.5 5895.1 5901.8 5902.6 5903.7 5907.5 5839.3 5914.9 5917.3 5942.0 5962.7 5802.2 5804.5 5815.9 5824.7 5852.2 06:22:38 INFO - PID 12152 | 06:22:38 INFO - PID 12152 | [#1] ext.html Cycles:180 Average:42046.89 Median:35463.06 stddev:66753.17 (188.2%) stddev-sans-first:66868.13 06:22:38 INFO - PID 12152 | Values: 670.3 744.7 762.1 822.4 833.7 29033.6 39678.6 39850.8 39871.0 39912.0 42608.0 42976.8 42984.4 42989.0 43041.4 7101.6 7202.9 8523.1 8760.0 8763.6 9790.7 9975.4 9982.4 9983.8 9985.0 10268.1 10400.3 10411.0 10420.8 10422.9 10225.5 10242.2 10243.8 10249.5 10258.4 9939.8 10316.5 10326.2 10329.9 10331.6 39915.6 40188.0 40196.4 40208.0 40240.8 3689.8 3726.4 3734.0 3778.0 3787.2 27932.6 28044.3 28390.3 28415.4 29143.1 3995.2 4046.1 4058.0 4072.6 4077.2 220730.0 221983.0 222187.0 222344.0 222785.0 50127.5 50275.7 50396.0 50425.7 50472.0 52673.0 52765.7 52792.0 52829.5 52951.0 13792.0 14045.6 14071.0 14118.9 14129.3 9777.3 9922.8 10328.1 11095.7 11117.9 12986.4 13012.5 13074.2 13090.5 13096.0 5168.6 5305.9 5325.7 5347.5 5394.9 930.9 935.5 945.3 950.4 957.3 23979.2 25575.7 25879.2 26054.9 26074.5 996.9 1003.4 1009.9 1012.1 1029.8 12993.1 13394.1 13421.0 13510.9 13721.9 280584.0 281567.0 281639.0 281780.0 281893.0 50119.7 50412.0 50455.5 50474.5 50567.7 1397.4 1406.8 1411.5 1417.6 1533.4 24038.0 24159.8 24957.0 25003.0 25031.5 37392.3 37405.4 37448.4 37489.6 37515.6 260384.0 260548.0 261145.0 262258.0 266460.0 32501.7 33655.5 33861.8 34196.0 34197.0 42929.8 43116.0 43239.0 44156.6 44715.6 35410.5 35421.5 35504.6 35628.8 35663.7 35107.3 35298.0 35678.6 35817.6 36198.6 36791.4 36946.0 36990.3 37093.6 37279.4 30085.7 30218.4 31566.2 31708.2 31750.0 23769.9 24037.5 24110.5 24268.4 24444.5 06:22:38 INFO - PID 12152 | 06:22:38 INFO - PID 12152 | [#2] jquery.html Cycles:180 Average:35721.74 Median:24673.07 stddev:101602.73 (411.8%) stddev-sans-first:101853.13 06:22:38 INFO - PID 12152 | Values: 398.2 423.9 430.3 448.4 455.0 16953.6 19269.9 20944.7 21213.4 21429.7 19237.2 20069.7 20190.6 21136.2 21183.9 6182.3 6405.2 6476.5 6483.7 6486.1 6217.3 6496.5 6503.2 6508.0 6534.2 6297.7 6299.1 6344.5 6511.1 6523.9 6378.0 6443.1 6491.8 6496.7 6497.5 6929.7 7151.7 7175.7 7186.5 7198.1 24483.5 24862.6 24976.4 24989.3 25434.6 3204.2 3244.7 3253.4 3273.8 3289.3 15472.4 15725.8 15734.5 15793.1 16235.9 2142.4 2174.8 2196.9 2199.7 2199.9 103988.0 104996.5 106376.0 106630.0 108898.0 14748.9 18720.4 18870.5 18935.6 19139.5 28539.0 29148.7 29211.7 29294.4 29435.0 8356.7 8701.6 8776.5 8826.2 8973.5 7263.3 7316.7 7442.8 7463.9 7463.9 9686.8 9689.2 9942.8 10021.5 10065.9 3613.6 3790.3 3792.8 3954.8 4002.1 890.2 905.1 918.2 919.7 936.7 21735.0 22809.0 22853.7 22936.4 23012.3 918.6 924.3 930.8 939.2 940.6 11782.8 12368.8 12528.1 13679.9 13930.2 601549.0 616331.0 621143.0 623573.0 625119.0 80192.6 83037.2 106895.0 113130.0 113577.6 1245.2 1279.3 1308.4 1328.6 1332.3 19569.2 19798.4 20508.6 20557.2 20562.0 50008.7 50817.7 51306.7 51514.2 51687.0 65137.0 66579.3 66759.0 68250.0 69822.3 11922.9 11998.9 12094.3 12151.5 12255.3 14142.8 14328.1 14457.8 14568.9 14643.2 11574.6 12013.6 12295.9 12617.6 12645.5 12085.2 12252.3 12284.3 12499.3 12965.7 12079.8 12238.4 12642.2 12704.7 13083.3 12226.4 12439.0 12457.5 12710.9 12774.0 12405.3 12449.2 12503.1 12827.0 12829.3 06:22:38 INFO - PID 12152 | 06:22:38 INFO - PID 12152 | [#3] mootools.html Cycles:180 Average:6266.71 Median:3882.95 stddev:3937.37 (101.4%) stddev-sans-first:3932.15 06:22:38 INFO - PID 12152 | Values: 1502.8 1515.5 1518.5 1542.4 1586.9 9679.9 10076.4 10078.5 10079.6 10083.8 9945.3 10271.0 10279.3 10285.6 10287.6 1942.3 1961.2 1975.5 1980.7 1982.6 2070.1 2098.8 2103.8 2108.9 2110.4 2062.2 2067.1 2088.5 2089.3 2090.9 1871.9 1874.7 1878.7 1881.1 1883.9 2033.3 2041.6 2047.3 2079.6 2080.8 10356.3 10401.1 10413.6 10457.7 10464.5 4982.3 5160.5 5162.8 5169.9 5174.3 3067.9 3216.2 3275.4 3367.1 3377.2 1142.5 1212.5 1264.6 1270.6 1286.8 12820.4 13251.5 13259.5 15258.0 15440.0 3435.5 4134.1 4243.1 4325.0 4330.1 11033.2 11065.2 11070.8 11076.9 11080.4 5305.1 5319.3 5319.7 5320.1 5327.1 4732.3 4845.6 4850.7 4855.6 4858.5 3434.4 3562.6 3595.5 3631.2 3631.8 929.2 934.4 935.8 937.3 942.7 745.2 808.1 885.4 906.5 925.3 6293.7 6316.8 6330.2 6471.2 6513.6 982.7 987.8 998.8 1010.2 1012.1 4135.3 4231.7 4233.3 4287.7 4406.8 12175.2 12463.2 12464.8 12493.9 12588.5 12151.6 12370.3 12373.6 12392.3 12393.3 8204.5 8429.7 8953.8 9115.2 9340.0 5910.8 5975.9 5976.3 6078.1 6187.8 11195.9 11276.4 11335.5 11353.2 11441.0 11823.8 11909.4 12030.6 12040.5 12040.9 8547.1 8687.4 8727.5 8847.0 8859.2 9736.1 9742.9 9822.8 9861.2 9874.9 8310.3 8353.2 8376.2 8469.2 8485.2 8418.3 8435.7 8438.2 8570.7 8776.8 7689.5 7754.9 7756.5 7761.8 7769.1 5562.7 5565.2 5586.9 5684.0 5771.5 5624.2 5627.1 5653.5 5691.1 5748.7 06:22:38 INFO - PID 12152 | 06:22:38 INFO - PID 12152 | [#4] prototype.html Cycles:180 Average:5218.91 Median:5805.88 stddev:1418.39 (24.4%) stddev-sans-first:1375.62 06:22:38 INFO - PID 12152 | Values: 406.7 409.6 410.4 418.1 420.5 5750.9 5796.6 5804.9 5831.7 5844.7 5495.5 5554.2 5634.4 5642.6 5658.4 4484.1 4486.4 4495.6 4504.3 4510.8 4519.2 4522.5 4524.1 4536.5 4545.0 4354.9 4430.9 4460.3 4464.8 4509.3 4435.7 4448.6 4451.8 4455.7 4484.1 4056.8 4063.4 4074.6 4081.4 4089.6 5308.8 5559.4 5582.2 5608.8 5621.7 5225.8 5241.9 5242.2 5250.8 5310.4 5833.4 5997.2 6014.1 6021.9 6022.1 4494.3 4509.1 4515.5 4516.5 4538.4 5937.7 6183.4 6308.7 6321.9 6333.6 5278.0 5382.3 5382.5 5396.5 5396.8 5467.2 5477.5 5479.3 5481.7 5535.4 5506.2 5668.2 5669.9 5694.9 5726.5 6009.4 6038.2 6040.4 6043.3 6051.5 1904.3 1910.2 1914.6 1934.9 1943.6 1521.8 1535.9 1550.3 1571.4 1590.8 5809.8 5810.7 5817.9 5833.2 5845.4 6199.6 6201.6 6210.9 6213.2 6230.1 5526.2 5773.8 5825.1 5833.4 5842.0 3241.0 3275.9 3284.7 3290.6 3294.3 6324.8 6430.3 6454.3 6475.9 6508.3 6393.9 6399.0 6425.2 6439.6 6449.5 6358.7 6430.1 6525.3 6534.1 6535.8 6220.4 6239.9 6248.1 6248.5 6261.0 5806.9 6053.1 6148.7 6169.6 6186.2 6216.8 6438.9 6442.5 6455.7 6456.5 5044.3 5072.4 5082.1 5084.5 5092.8 6032.8 6134.5 6195.7 6198.8 6254.7 6036.0 6047.4 6049.5 6053.6 6056.2 5774.8 6033.9 6044.5 6064.8 6097.1 6030.5 6098.2 6106.9 6120.7 6121.3 5937.9 6100.4 6111.3 6173.2 6180.6 5894.6 5902.1 5925.7 5968.1 5971.6 06:22:38 INFO - PID 12152 | 06:22:38 INFO - PID 12152 | [#5] yui.html Cycles:180 Average:17314.99 Median:23894.67 stddev:22193.53 (92.9%) stddev-sans-first:22220.69 06:22:38 INFO - PID 12152 | Values: 693.2 739.7 830.0 832.6 852.8 14563.6 15077.0 15170.7 15195.2 15209.6 14253.1 14451.3 14475.1 14489.8 15001.9 796.1 801.5 822.4 824.8 831.4 788.3 789.2 790.1 798.6 832.0 821.3 821.6 821.8 826.6 861.4 814.4 816.9 816.9 823.8 860.0 596.4 598.9 599.0 617.0 629.7 14229.0 14332.7 14379.9 14819.7 15657.0 14458.2 16109.2 16386.3 16729.3 16821.8 11440.8 11740.2 11822.5 11940.0 12436.4 3671.1 3761.5 3768.2 3833.5 3871.0 84696.0 85137.0 86036.6 86058.6 88090.0 11631.8 11798.6 11954.5 12497.6 13045.1 25030.0 25064.6 25417.5 25865.7 25982.7 7576.8 7773.6 7788.5 7812.4 7988.8 4278.0 4330.6 4419.1 4427.0 4469.1 3408.5 3465.0 3484.1 3484.8 3490.4 579.9 580.1 587.7 602.0 602.2 673.7 694.9 696.9 710.4 720.9 9223.7 10001.8 10257.7 10318.3 10399.3 663.0 689.2 690.8 691.3 693.8 4487.2 4766.9 4799.3 4831.3 4840.5 74504.0 74816.3 74837.6 78115.2 78420.6 65714.0 67159.3 67443.3 67755.0 67786.7 59389.4 60080.0 61195.0 61324.0 61557.7 9187.8 9518.9 9561.3 9574.0 9585.8 41021.6 41960.9 41985.6 42715.8 43458.8 39410.2 44779.6 46094.8 46590.3 46670.8 11118.9 11213.3 11488.9 11519.4 11625.5 12346.3 12379.7 12407.3 12755.2 13205.1 12310.6 12328.9 12330.9 12344.2 12487.4 11993.0 12145.4 12179.4 12284.8 12350.0 12246.2 12897.7 13009.3 13116.6 13235.4 12121.6 12152.0 12275.3 12488.2 13257.8 11956.4 12161.8 12213.5 12380.6 12408.0 06:22:38 INFO - PID 12152 | -------- Summary: end -------- 06:22:38 INFO - PID 12152 | 06:22:39 INFO - TEST-INFO | 12152: exit 0 06:22:39 INFO - TEST-OK | dromaeo_css | took 1117869ms 06:22:39 INFO - TEST-START | kraken 06:22:39 INFO - operating with platform_type : linux_ 06:22:39 INFO - Initialising browser for kraken test... 06:22:39 INFO - TEST-INFO | started process 12476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5p2zp/profile http://localhost:46387/getInfo.html) 06:22:43 INFO - PID 12476 | __metrics Screen width/height:1600/1200 06:22:43 INFO - PID 12476 | colorDepth:24 06:22:43 INFO - PID 12476 | Browser inner width/height: 1024/697 06:22:43 INFO - PID 12476 | __metrics 06:22:44 INFO - PID 12476 | 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" 06:22:44 INFO - PID 12476 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:22:45 INFO - TEST-INFO | 12476: exit 0 06:22:45 INFO - Browser initialized. 06:22:45 INFO - Running cycle 1/1 for kraken test... 06:22:45 INFO - TEST-INFO | started process 12572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5p2zp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:57 INFO - PID 12572 | RSS: Main: 144674816 06:22:57 INFO - PID 12572 | 06:23:00 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46387/tests/kraken/driver.html?testName=audio-beat-detection) 06:23:01 INFO - PID 12572 | RSS: Main: 198975488 06:23:01 INFO - PID 12572 | 06:23:03 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46387/tests/kraken/driver.html?testName=audio-dft) 06:23:04 INFO - PID 12572 | RSS: Main: 179425280 06:23:04 INFO - PID 12572 | 06:23:07 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46387/tests/kraken/driver.html?testName=audio-fft) 06:23:07 INFO - PID 12572 | RSS: Main: 261066752 06:23:07 INFO - PID 12572 | 06:23:09 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46387/tests/kraken/driver.html?testName=audio-oscillator) 06:23:10 INFO - PID 12572 | RSS: Main: 173039616 06:23:10 INFO - PID 12572 | 06:23:12 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46387/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:23:13 INFO - PID 12572 | RSS: Main: 176132096 06:23:13 INFO - PID 12572 | 06:23:16 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46387/tests/kraken/driver.html?testName=imaging-darkroom) 06:23:16 INFO - PID 12572 | RSS: Main: 214519808 06:23:16 INFO - PID 12572 | 06:23:20 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46387/tests/kraken/driver.html?testName=imaging-desaturate) 06:23:20 INFO - PID 12572 | RSS: Main: 223518720 06:23:20 INFO - PID 12572 | 06:23:23 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46387/tests/kraken/driver.html?testName=json-parse-financial) 06:23:24 INFO - PID 12572 | RSS: Main: 229122048 06:23:24 INFO - PID 12572 | 06:23:25 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46387/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:23:26 INFO - PID 12572 | RSS: Main: 178479104 06:23:26 INFO - PID 12572 | 06:23:28 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46387/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:23:28 INFO - PID 12572 | RSS: Main: 183279616 06:23:28 INFO - PID 12572 | 06:23:30 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46387/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:23:31 INFO - PID 12572 | RSS: Main: 193654784 06:23:31 INFO - PID 12572 | 06:23:33 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:23:34 INFO - PID 12572 | RSS: Main: 203378688 06:23:34 INFO - PID 12572 | 06:23:37 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:23:38 INFO - PID 12572 | RSS: Main: 199757824 06:23:38 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | Cycle 1(1): loaded http://localhost:46387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46387/tests/kraken/driver.html?testName=ai-astar) 06:23:40 INFO - PID 12572 | RSS: Main: 268140544 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | __start_tp_report 06:23:40 INFO - PID 12572 | _x_x_mozilla_page_load 06:23:40 INFO - PID 12572 | _x_x_mozilla_page_load_details 06:23:40 INFO - PID 12572 | |i|pagename|runs| 06:23:40 INFO - PID 12572 | |0;ai-astar;108;113;113;113;113;112;112;112;113;112 06:23:40 INFO - PID 12572 | |1;audio-beat-detection;144;121;119;179;119;124;118;119;139;119 06:23:40 INFO - PID 12572 | |2;audio-dft;161;162;161;161;162;161;161;162;161;161 06:23:40 INFO - PID 12572 | |3;audio-fft;75;73;77;107;75;75;75;74;90;75 06:23:40 INFO - PID 12572 | |4;audio-oscillator;83;83;108;84;84;82;96;85;84;112 06:23:40 INFO - PID 12572 | |5;imaging-gaussian-blur;114;112;113;113;113;113;112;113;113;113 06:23:40 INFO - PID 12572 | |6;imaging-darkroom;147;146;146;146;147;147;147;147;146;146 06:23:40 INFO - PID 12572 | |7;imaging-desaturate;94;94;94;94;94;93;94;94;93;93 06:23:40 INFO - PID 12572 | |8;json-parse-financial;57;57;57;56;56;58;59;58;58;58 06:23:40 INFO - PID 12572 | |9;json-stringify-tinderbox;55;55;55;53;55;54;55;55;55;57 06:23:40 INFO - PID 12572 | |10;stanford-crypto-aes;80;79;79;80;80;80;86;80;78;79 06:23:40 INFO - PID 12572 | |11;stanford-crypto-ccm;124;136;125;125;126;123;124;124;168;125 06:23:40 INFO - PID 12572 | |12;stanford-crypto-pbkdf2;188;188;178;189;182;186;190;177;185;186 06:23:40 INFO - PID 12572 | |13;stanford-crypto-sha256-iterative;67;66;63;64;66;65;66;66;63;63 06:23:40 INFO - PID 12572 | __end_tp_report 06:23:40 INFO - PID 12572 | __start_cc_report 06:23:40 INFO - PID 12572 | _x_x_mozilla_cycle_collect,1750 06:23:40 INFO - PID 12572 | __end_cc_report 06:23:40 INFO - PID 12572 | __startTimestamp1490016220274__endTimestamp 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | ------- Summary: start ------- 06:23:40 INFO - PID 12572 | Number of tests: 14 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:1.52 (1.3%) stddev-sans-first:0.53 06:23:40 INFO - PID 12572 | Values: 108.0 113.0 113.0 113.0 113.0 112.0 112.0 112.0 113.0 112.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:122.50 stddev:19.50 (15.9%) stddev-sans-first:20.03 06:23:40 INFO - PID 12572 | Values: 144.0 121.0 119.0 179.0 119.0 124.0 118.0 119.0 139.0 119.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:23:40 INFO - PID 12572 | Values: 161.0 162.0 161.0 161.0 162.0 161.0 161.0 162.0 161.0 161.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#3] audio-fft Cycles:10 Average:79.60 Median:75.00 stddev:10.78 (14.4%) stddev-sans-first:11.31 06:23:40 INFO - PID 12572 | Values: 75.0 73.0 77.0 107.0 75.0 75.0 75.0 74.0 90.0 75.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:11.25 (13.4%) stddev-sans-first:11.63 06:23:40 INFO - PID 12572 | Values: 83.0 83.0 108.0 84.0 84.0 82.0 96.0 85.0 84.0 112.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 06:23:40 INFO - PID 12572 | Values: 114.0 112.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:23:40 INFO - PID 12572 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:23:40 INFO - PID 12572 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 93.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:0.97 (1.7%) stddev-sans-first:1.01 06:23:40 INFO - PID 12572 | Values: 57.0 57.0 57.0 56.0 56.0 58.0 59.0 58.0 58.0 58.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 06:23:40 INFO - PID 12572 | Values: 55.0 55.0 55.0 53.0 55.0 54.0 55.0 55.0 55.0 57.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:2.18 (2.7%) stddev-sans-first:2.32 06:23:40 INFO - PID 12572 | Values: 80.0 79.0 79.0 80.0 80.0 80.0 86.0 80.0 78.0 79.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:125.00 stddev:13.86 (11.1%) stddev-sans-first:14.53 06:23:40 INFO - PID 12572 | Values: 124.0 136.0 125.0 125.0 126.0 123.0 124.0 124.0 168.0 125.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.90 Median:187.00 stddev:4.51 (2.4%) stddev-sans-first:4.64 06:23:40 INFO - PID 12572 | Values: 188.0 188.0 178.0 189.0 182.0 186.0 190.0 177.0 185.0 186.0 06:23:40 INFO - PID 12572 | 06:23:40 INFO - PID 12572 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.41 06:23:40 INFO - PID 12572 | Values: 67.0 66.0 63.0 64.0 66.0 65.0 66.0 66.0 63.0 63.0 06:23:40 INFO - PID 12572 | -------- Summary: end -------- 06:23:40 INFO - PID 12572 | 06:23:41 INFO - TEST-INFO | 12572: exit 0 06:23:41 INFO - TEST-OK | kraken | took 62209ms 06:23:41 INFO - SUITE-END | took 1180s 06:23:41 INFO - Completed test suite (00:19:40) 06:23:41 INFO - javascript benchmark 06:23:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7509.6446149368985, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.292855571774, 3256.837158142094, 3282.934341313175, 3285.7864238824473, 3295.9505607415886, 5513.145462453316, 5604.327480702322, 5612.775488980441, 5639.182318563811, 5643.858903527409, 5541.196526503654, 5617.4382561743805, 5622.409646987058, 5639.68981706006, 5699.173619825123, 5025.84922452327, 5055.696658200502, 5062.645614806965, 5077.720725360104, 5084.339035925324, 5031.32077169581, 5072.061668591323, 5100.132977393852, 5112.846614601568, 5122.871928201787, 5005.399352077738, 5063.518965698289, 5070.29015937769, 5108.080545501808, 5178.5339319461245, 5029.2958985742025, 5041.470645582234, 5060.1903695408555, 5064.11378008847, 5090.160123579605, 5008.574271186953, 5017.598592112622, 5017.9247311290355, 5034.572061374787, 5059.519345662156, 5552.361478429992, 5573.164025396182, 5602.60781745278, 5604.635698679614, 5607.102863541813, 5735.684537350444, 5875.823725288248, 5929.080992446177, 5929.555283353766, 6004.399560044004, 5831.446012628793, 6042.909356359658, 6058.030715085565, 6113.0, 6123.663198524079, 5640.576956728261, 5650.378458369576, 5650.491455768959, 5656.745446454878, 5660.094384898396, 5994.310654274727, 6141.201643786279, 6190.783322583778, 6197.411245931719, 6205.100260462208, 5833.7083145842535, 5865.266841644794, 5881.206037184926, 5885.646861188342, 5886.087656413263, 5979.671118088547, 5995.040793473024, 6046.697665116727, 6066.666333351708, 6067.362926892701, 6000.309964354068, 6005.099235114681, 6009.218801555857, 6012.188354572164, 6015.007523758531, 6005.549583781234, 6010.519158467312, 6014.879702405928, 6015.157877897098, 6017.849553761191, 4533.342665313511, 4587.6788624795945, 4587.816487340469, 4625.4911959684405, 4627.583517483443, 4089.8568550100604, 4090.550039495653, 4096.856610018635, 4126.154138401621, 4127.6491498222385, 5642.548596112301, 5644.181593668895, 5682.0, 5696.1455781633085, 5738.885222295531, 5909.2908850938165, 6005.519558435315, 6018.368071352533, 6066.241719785027, 6104.053871649901, 5690.260266165372, 5699.344575373802, 5699.658020518782, 5722.341930678025, 5751.769929202868, 5148.124818780816, 5155.922661160085, 5157.974210128926, 5160.716160611128, 5197.558207552324, 6130.642739936431, 6131.315499379051, 6143.447089761943, 6283.434490895841, 6290.087937249074, 6022.367651396716, 6052.969735151296, 6080.331163572092, 6092.9086063709965, 6093.542984276109, 6155.538334625011, 6156.661383623944, 6168.5758929905, 6208.81373558794, 6229.221347331583, 5803.187553742564, 5828.0, 5835.912461312999, 5870.677112758839, 5879.735411906389, 5970.701464926649, 6097.403692570384, 6108.281362586102, 6109.374301064966, 6114.206128133634, 5840.123981402823, 5841.50347220491, 5861.3845546217035, 5918.17145599625, 5939.406059394026, 5871.588988770745, 5888.528917686661, 5891.293044834647, 5900.1149827526215, 5903.468687818117, 5895.056790913433, 5901.822945311647, 5902.557308201816, 5903.704814759159, 5907.468327850343, 5839.270091238595, 5914.881702366015, 5917.289925209003, 5942.019566771434, 5962.731677074629, 5802.187693722966, 5804.506616937439, 5815.912761308499, 5824.679642619527, 5852.209951656472], "value": 5535.739087011752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.2761018100449, 744.6872313628277, 762.131170465669, 822.3667775812628, 833.720703564306, 29033.56449653254, 39678.60321396785, 39850.80074599623, 39871.0, 39912.0, 42608.0, 42976.785116074454, 42984.35523467143, 42989.0, 43041.35437968425, 7101.609411482366, 7202.891956620629, 8523.062463129067, 8759.95620021899, 8763.56182190891, 9790.706278811647, 9975.401475911432, 9982.35114717541, 9983.800323993552, 9985.0, 10268.127209187229, 10400.323978941382, 10411.0, 10420.791584168312, 10422.89577104227, 10225.539850706737, 10242.231832612546, 10243.79512409755, 10249.487525623688, 10258.384496930208, 9939.80120397588, 10316.48417579118, 10326.225533084973, 10329.948350258275, 10331.638392656296, 39915.60084399148, 40188.0, 40196.39705404421, 40208.0, 40240.79879600612, 3689.760165589255, 3726.441033844918, 3734.0, 3777.9811100944594, 3787.242551489713, 27932.58101128485, 28044.298892527648, 28390.290242744097, 28415.431691366262, 29143.125706228846, 3995.20095980805, 4046.089629833293, 4057.97971010146, 4072.6131017553284, 4077.245709543744, 220730.0, 221983.0, 222187.0, 222344.0, 222785.0, 50127.498725013014, 50275.74862125666, 50396.0, 50425.747871260406, 50472.0, 52673.0, 52765.736171319666, 52792.0, 52829.47170528323, 52951.0, 13792.0, 14045.578632641038, 14071.0, 14118.85881141196, 14129.293535323193, 9777.315587908779, 9922.80154396908, 10328.122109620615, 11095.72260693489, 11117.944410277896, 12986.35068246584, 13012.544560940321, 13074.215547067206, 13090.541831035867, 13096.0, 5168.586513078944, 5305.867353316121, 5325.707086110224, 5347.545458636059, 5394.865128371822, 930.8743319651895, 935.504182783126, 945.3146468810195, 950.3585080070925, 957.3155194036298, 23979.160729374387, 25575.74424255771, 25879.22362329133, 26054.86972565125, 26074.478510430064, 996.8704068471052, 1003.4430890855499, 1009.8889122196553, 1012.1295685710284, 1029.7528593137592, 12993.090483666052, 13394.129381590166, 13421.030474426298, 13510.93244533771, 13721.862781372258, 280584.0, 281567.0, 281639.0, 281780.0, 281893.0, 50119.74940125276, 50412.0, 50455.49544504582, 50474.49525504772, 50567.74716126396, 1397.3711829676686, 1406.8030475733406, 1411.5254642782404, 1417.6172433442912, 1533.4326299269119, 24038.0, 24159.75840241575, 24957.001719931, 25003.0, 25031.499370012134, 37392.25215495729, 37405.43891841679, 37448.438273426465, 37489.625103748614, 37515.6248437523, 260384.0, 260548.0, 261145.0, 262258.0, 266460.0, 32501.674983249864, 33655.495167572015, 33861.830690846386, 34196.0, 34197.0, 42929.75394177009, 43116.0, 43239.0, 44156.558434415245, 44715.55284447114, 35410.46884296686, 35421.46867796934, 35504.644953551164, 35628.82185589056, 35663.68894376595, 35107.29785404226, 35298.0, 35678.64321356857, 35817.641823582475, 36198.63801361953, 36791.44812827863, 36946.0, 36990.26019479542, 37093.62906370902, 37279.44080838844, 30085.699143009166, 30218.395632087675, 31566.210844729067, 31708.207294817814, 31749.99875039355, 23769.881150594138, 24037.51924961526, 24110.51778964446, 24268.393290167885, 24444.511109777348], "value": 17748.955364360732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.18968399307414, 423.8528922748593, 430.28621451993405, 448.40810130627574, 455.01510093784776, 16953.576160595974, 19269.903650481745, 20944.685829712565, 21213.363599092052, 21429.67855482169, 19237.23051077955, 20069.698954515694, 20190.596188076266, 21136.15455381783, 21183.894080529575, 6182.258129024523, 6405.19935008124, 6476.514261430388, 6483.675816209195, 6486.124373209604, 6217.316095229521, 6496.545241833073, 6503.219613646345, 6507.967460162693, 6534.24856141545, 6297.716602752887, 6299.118123462719, 6344.509040375531, 6511.088447617338, 6523.869522609545, 6377.968110159442, 6443.130177426081, 6491.8052458425855, 6496.740130394802, 6497.5126865485045, 6929.688164032631, 7151.713931442736, 7175.677094530759, 7186.532875363085, 7198.136223653143, 24483.510329793306, 24862.627060594106, 24976.375590610198, 24989.250322490356, 25434.618480722806, 3204.19777840958, 3244.740420766333, 3253.381857447101, 3273.7872038317673, 3289.342131573695, 15472.381104755796, 15725.764113538306, 15734.527964161094, 15793.131377774218, 16235.918820405941, 2142.3572928121503, 2174.836887233448, 2196.890155492219, 2199.7030400895997, 2199.8900054997184, 103988.0, 104996.47501762518, 106376.0, 106630.0, 108898.0, 14748.89383296257, 18720.438386848415, 18870.528236793914, 18935.621287574173, 19139.521511962033, 28539.004539364505, 29148.708512915022, 29211.7078829209, 29294.414111718073, 29435.0, 8356.665733370719, 8701.608427620773, 8776.473411595198, 8826.169342774534, 8973.461592304482, 7263.25681836366, 7316.719574074516, 7442.813929651694, 7463.888041679379, 7463.925360746432, 9686.75783105414, 9689.176420004238, 9942.80114397708, 10021.549030293509, 10065.899341006643, 3613.584437789688, 3790.298794722985, 3792.810359482015, 3954.7937878946623, 4002.139539998914, 890.1587999340561, 905.1265528764774, 918.150710592699, 919.7102912582515, 936.7423958411491, 21735.0, 22809.0, 22853.657195142085, 22936.4265893354, 23012.309630711105, 918.5774543709834, 924.3206243411088, 930.8277968575835, 939.2392162348519, 940.6096469965024, 11782.764344713229, 12368.75262494745, 12528.109539753099, 13679.86320136786, 13930.164190148624, 601549.0, 616331.0, 621143.0, 623573.0, 625119.0, 80192.59903700445, 83037.16962830295, 106895.0, 113130.0, 113577.58082012241, 1245.2466257914014, 1279.328352614866, 1308.4242933109401, 1328.647908304281, 1332.2938842413537, 19569.21723131116, 19798.40604781801, 20508.589828203054, 20557.177712891316, 20562.0, 50008.74995625144, 50817.745911270205, 51306.74346628243, 51514.22728658998, 51687.0, 65137.0, 66579.33420665924, 66759.0, 68249.97625035529, 69822.30177698362, 11922.940385298018, 11998.940005299917, 12094.334811585448, 12151.513939442677, 12255.325957072446, 14142.78785818193, 14328.14031158134, 14457.783133252799, 14568.927155364156, 14643.19462429534, 11574.594889178838, 12013.63959081229, 12295.9385203077, 12617.558385456465, 12645.494180232688, 12085.15403921717, 12252.264864108181, 12284.262944223017, 12499.250044997329, 12965.740685186054, 12079.818802717791, 12238.388080595756, 12642.2414655121, 12704.745905081661, 13083.280419577015, 12226.44980975876, 12439.014636486996, 12457.501699932263, 12710.936445317715, 12774.0, 12405.317707526172, 12449.190802597803, 12503.124781265224, 12826.98565837009, 12829.294388808705], "value": 11198.996398641595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.842201568836, 1515.51503518874, 1518.491305412686, 1542.421591903036, 1586.8889177757555, 9679.903200967989, 10076.445795481246, 10078.546465409056, 10079.596816127365, 10083.798324033523, 9945.254105942047, 10271.024252696001, 10279.331843430171, 10285.588576456932, 10287.63993260236, 1942.2522328903367, 1961.1567026178736, 1975.456749393921, 1980.6632872411724, 1982.603479304145, 2070.0581235537793, 2098.842586805988, 2103.842211834111, 2108.8734675919495, 2110.3774386555924, 2062.2060506704875, 2067.059487932994, 2088.5092003379195, 2089.3209706845337, 2090.916363345472, 1871.9064046797673, 1874.6531891600098, 1878.690016147334, 1881.0594702648675, 1883.896385698786, 2033.3188381892085, 2041.6120937022067, 2047.2732180076157, 2079.563291708728, 2080.8023237792386, 10356.275060745751, 10401.063904248578, 10413.583456661725, 10457.68626941193, 10464.476776161162, 4982.252662100677, 5160.458151894035, 5162.845114646567, 5169.870753231162, 5174.275601415805, 3067.877284908601, 3216.244182617083, 3275.3613045456145, 3367.0908854609365, 3377.155711072232, 1142.4687520303098, 1212.5452955141823, 1264.6206138158607, 1270.6442196185083, 1286.7876800327936, 12820.35898205086, 13251.469941202437, 13259.46962121514, 15258.0, 15440.0, 3435.49793396261, 4134.111166099303, 4243.066525364477, 4325.048489332342, 4330.069035157393, 11033.172512061628, 11065.170112241614, 11070.778584428428, 11076.944615276872, 11080.39057851826, 5305.124654432053, 5319.255304257407, 5319.654222475527, 5320.068987927175, 5327.09439395296, 4732.337472753818, 4845.5881250094135, 4850.733209673502, 4855.635827312965, 4858.4898585648, 3434.4161492546327, 3562.5546806649168, 3595.496630471736, 3631.1829838286703, 3631.782093074424, 929.1916033051289, 934.4206591912922, 935.8081593273363, 937.2642475656713, 942.6794889737522, 745.1579714922103, 808.1030056637128, 885.371386315723, 906.5331354352513, 925.2690374604122, 6293.716782744787, 6316.8420789479715, 6330.240371155491, 6471.158749362553, 6513.576617519846, 982.6511588386163, 987.7728122531857, 998.825205589019, 1010.1918465227935, 1012.0739523336213, 4135.255653982312, 4231.682623803227, 4233.25917964355, 4287.699861009762, 4406.757628330409, 12175.208611440405, 12463.18989265713, 12464.750704985849, 12493.93753031229, 12588.496460141674, 12151.63545093631, 12370.257784532956, 12373.62879113628, 12392.31842248685, 12393.256404615751, 8204.466709663971, 8429.662813487392, 8953.776155596031, 9115.179633832988, 9339.991901741023, 5910.763569457174, 5975.940240597538, 5976.282846058501, 6078.057901025348, 6187.84530386744, 11195.944020279847, 11276.379799111128, 11335.489902954221, 11353.205275630957, 11441.0, 11823.82264266054, 11909.404529773303, 12030.63908082759, 12040.518379264731, 12040.879591204326, 8547.102554231964, 8687.39188256816, 8727.519986400808, 8847.0, 8859.202671759314, 9736.075072868067, 9742.9025709742, 9822.75443113928, 9861.161801246973, 9874.901250987397, 8310.293625041939, 8353.20644538768, 8376.204260595234, 8469.237768600855, 8485.236328730443, 8418.326533877153, 8435.704750333955, 8438.240558349778, 8570.657173712982, 8776.78058048554, 7689.50018248812, 7754.922450775645, 7756.457048006585, 7761.805954851174, 7769.067711874612, 5562.749676264497, 5565.16522521625, 5586.916196257141, 5684.005299072728, 5771.451712087345, 5624.184493248375, 5627.071533196977, 5653.462921022497, 5691.089425692035, 5748.712564371681], "value": 4754.366296401021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.74946805878574, 409.6338710400813, 410.4151583992813, 418.0593664255427, 420.5311078147864, 5750.856228594287, 5796.565257605681, 5804.883902321962, 5831.737571809268, 5844.678542680156, 5495.505404513593, 5554.1946417769395, 5634.436556344363, 5642.633228840123, 5658.377578466376, 4484.103179364124, 4486.416765820447, 4495.617872480843, 4504.279315309551, 4510.819567217307, 4519.186546421643, 4522.525134860842, 4524.09518096382, 4536.455625324966, 4545.0, 4354.869353919372, 4430.911381772363, 4460.30865215892, 4464.776761161945, 4509.255972764507, 4435.68950173488, 4448.5773851484055, 4451.799669014902, 4455.710378825366, 4484.125595508877, 4056.837726490937, 4063.3904914262803, 4074.6332830045144, 4081.3673880548563, 4089.6114869087387, 5308.840734777924, 5559.444055594408, 5582.204101211175, 5608.775648974077, 5621.662700237958, 5225.843224703265, 5241.895162096736, 5242.16125419931, 5250.789968401259, 5310.415854256029, 5833.416658334175, 5997.160397544304, 6014.12795144706, 6021.939780602182, 6022.09668549721, 4494.280915053609, 4509.098180363941, 4515.532451953129, 4516.503184649686, 4538.3873177120995, 5937.70311484424, 6183.381661833826, 6308.653024083674, 6321.905171422432, 6333.588316759396, 5278.0, 5382.273393091882, 5382.542483888835, 5396.493927570523, 5396.757145928443, 5467.1799230115, 5477.4796394342475, 5479.342478902558, 5481.671099734029, 5535.418781028015, 5506.174073888948, 5668.206451096849, 5669.886602267931, 5694.857628559319, 5726.513246374105, 6009.429104235091, 6038.215032045806, 6040.426159514839, 6043.305019922677, 6051.485623721945, 1904.2668572599648, 1910.216811107467, 1914.550080731027, 1934.9032548372525, 1943.5821298420908, 1521.773839460329, 1535.9155246461553, 1550.3101120001716, 1571.3793051744497, 1590.7909988408662, 5809.796657116981, 5810.6513609183585, 5817.94182058174, 5833.241678581757, 5845.444682755132, 6199.597026193283, 6201.573638063181, 6210.875782484325, 6213.1922850029205, 6230.096635987847, 5526.226328314039, 5773.797917072882, 5825.126231065374, 5833.416658334133, 5842.0, 3240.951385729216, 3275.852586633607, 3284.687954644305, 3290.588676415448, 3294.341131773655, 6324.778632747832, 6430.292667806538, 6454.32229615893, 6475.902861457082, 6508.284088750233, 6393.904091438632, 6399.008153736178, 6425.1968503937005, 6439.58142720731, 6449.516286278454, 6358.713857876407, 6430.131932189094, 6525.347465253437, 6534.117894084237, 6535.803925882231, 6220.440160385587, 6239.908016097255, 6248.125262463168, 6248.4688801452385, 6260.968695156495, 5806.883862322646, 6053.061775424816, 6148.661823599566, 6169.598976066542, 6186.164867742978, 6216.7824126155365, 6438.90341644885, 6442.549021568445, 6455.709493072729, 6456.515761317826, 5044.344235249394, 5072.416672082758, 5082.085224659597, 5084.51697088776, 5092.8472145835685, 6032.849178770566, 6134.478569321657, 6195.659238741912, 6198.752049918133, 6254.718537665907, 6035.969820151046, 6047.395260473917, 6049.546284028627, 6053.576249662481, 6056.152138700498, 5774.7690092397515, 6033.939660603338, 6044.455998960115, 6064.818055458343, 6097.085437184458, 6030.547708921936, 6098.207233059674, 6106.877862442638, 6120.693965301628, 6121.296050954197, 5937.940620593911, 6100.420460056288, 6111.297200821785, 6173.166622505904, 6180.598261113013, 5894.557908156819, 5902.085176797603, 5925.703714814328, 5968.104784282219, 5971.58198926071], "value": 4809.6962710528815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.2028167607255, 739.6523633892069, 829.9618197754746, 832.6378025558879, 852.7740148860549, 14563.56309310721, 15077.0, 15170.696586068272, 15195.240237988084, 15209.619759506004, 14253.07355021923, 14451.277436128177, 14475.059121157117, 14489.78265326021, 15001.924990375033, 796.0924546017544, 801.5070731500143, 822.3626689315769, 824.826786374859, 831.4387788242942, 788.2629741192004, 789.2462698123308, 790.1111249843925, 798.636620337745, 832.014063334947, 821.2977903892175, 821.593311310902, 821.7945513621595, 826.5660528222671, 861.4400639584258, 814.3932770086265, 816.8815521749314, 816.8897198878135, 823.8311146215011, 859.9871001934945, 596.4065754574183, 598.868248985227, 599.0176111177672, 617.0, 629.7355110853453, 14229.0, 14332.713345733027, 14379.928100359431, 14819.703605927822, 15657.0, 14458.204798736066, 16109.19454027294, 16386.262618182092, 16729.330826766916, 16821.83178168227, 11440.828387574193, 11740.236884602473, 11822.467988940518, 11939.985101266402, 12436.378181091, 3671.118931456458, 3761.4545890845948, 3768.171002379472, 3833.463315135883, 3871.0, 84696.0, 85137.0, 86036.56981715115, 86058.56970715107, 88090.0, 11631.76736465283, 11798.587049453228, 11954.52181912731, 12497.625071247878, 13045.086843921024, 25030.0, 25064.624030639556, 25417.491650167263, 25865.74134258671, 25982.74017259803, 7576.792830175588, 7773.572453515111, 7788.532688038736, 7812.414068944852, 7988.760337189894, 4277.978610106992, 4330.566943305645, 4419.0940857124215, 4426.9778651106535, 4469.061497085583, 3408.454647256427, 3464.9653503465147, 3484.059303987909, 3484.790912545255, 3490.3542844573835, 579.8521377048826, 580.0718849840306, 587.6532845621105, 601.9729112189962, 602.16299343912, 673.71367168953, 694.9131358580178, 696.864111498253, 710.4281053751677, 720.8518614528733, 9223.677171298972, 10001.799964000826, 10257.74355641115, 10318.27772055964, 10399.324043937271, 662.9602223866583, 689.2005273882272, 690.81348036031, 691.312144416309, 693.8473535822111, 4487.214737420938, 4766.880827979328, 4799.3041009053495, 4831.275308703653, 4840.491748366441, 74504.0, 74816.25183748093, 74837.62581187168, 78115.2188478108, 78420.60789696129, 65714.0, 67159.32840671531, 67443.32556674468, 67755.0, 67786.66106669533, 59389.40610593839, 60080.0, 61195.0, 61324.0, 61557.69221153955, 9187.770305742142, 9518.904810951803, 9561.330706850455, 9573.952130239304, 9585.808283834423, 41021.58978410178, 41960.90195490152, 41985.58014419817, 42715.78642106769, 43458.78270608627, 39410.21179576335, 44779.552204477535, 46094.76952615215, 46590.30114548217, 46670.76664616655, 11118.944405278246, 11213.271137376045, 11488.94255528717, 11519.42402879836, 11625.534978600761, 12346.259224446561, 12379.69050773738, 12407.317597532223, 12755.234685918875, 13205.075644704779, 12310.630681079581, 12328.938355308166, 12330.876691232972, 12344.197627154206, 12487.438065287266, 11993.0, 12145.39273036327, 12179.39103044862, 12284.754304913673, 12350.0, 12246.203996740183, 12897.742045159232, 13009.284489352798, 13116.606501804961, 13235.40440680191, 12121.575744848888, 12151.96163689233, 12275.263484190977, 12488.188267762567, 13257.80113298282, 11956.42405663673, 12161.81757273624, 12213.511459541518, 12380.566680166152, 12407.985337098062], "value": 7127.565694528034, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 119.0, 179.0, 119.0, 124.0, 118.0, 119.0, 139.0, 119.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 77.0, 107.0, 75.0, 75.0, 75.0, 74.0, 90.0, 75.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 84.0, 84.0, 82.0, 96.0, 85.0, 84.0, 112.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 56.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 53.0, 55.0, 54.0, 55.0, 55.0, 55.0, 57.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 80.0, 80.0, 86.0, 80.0, 78.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 136.0, 125.0, 125.0, 126.0, 123.0, 124.0, 124.0, 168.0, 125.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 188.0, 178.0, 189.0, 182.0, 186.0, 190.0, 177.0, 185.0, 186.0], "value": 184.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 63.0, 64.0, 66.0, 65.0, 66.0, 66.0, 63.0, 63.0], "value": 64.9, "unit": "score"}]}]} 06:23:41 INFO - Return code: 0 06:23:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:23:41 ERROR - # TBPL SUCCESS # 06:23:41 INFO - Running post-action listener: _resource_record_post_action 06:23:41 INFO - [mozharness: 2017-03-20 13:23:41.567351Z] Finished run-tests step (success) 06:23:41 INFO - Running post-run listener: _resource_record_post_run 06:23:41 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 367554560; Read time: 4; Write time: 406512 06:23:41 INFO - TinderboxPrint: CPU usage
12.9% 06:23:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:23:41 INFO - TinderboxPrint: I/O write bytes / time
367,554,560 / 406,512 06:23:41 INFO - TinderboxPrint: CPU idle
8,316.3 (87.0%) 06:23:41 INFO - TinderboxPrint: CPU user
1,189.0 (12.4%) 06:23:41 INFO - TinderboxPrint: Swap in / out
0 / 0 06:23:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110596096; Read time: 0; Write time: 171788 06:23:41 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254058496; Read time: 4; Write time: 234568 06:23:42 INFO - Running post-run listener: _upload_blobber_files 06:23:42 INFO - Blob upload gear active. 06:23:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:23:42 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 06:23:42 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'] 06:23:42 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 06:23:42 INFO - (blobuploader) - INFO - Open directory for files ... 06:23:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:23:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:23:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:43 INFO - (blobuploader) - INFO - Done attempting. 06:23:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:23:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:23:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:47 INFO - (blobuploader) - INFO - Done attempting. 06:23:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:23:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:23:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:48 INFO - (blobuploader) - INFO - Done attempting. 06:23:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:23:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:23:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:48 INFO - (blobuploader) - INFO - Done attempting. 06:23:48 INFO - (blobuploader) - INFO - Iteration through files over. 06:23:48 INFO - Return code: 0 06:23:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:23:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:23:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da535098262ccdc50e505f72bb7e88ff20a99585c8ced5a48789dd2f88d45389f7c239f2bbb8ec52964888e838fbaae0775a86863711ae40ee0cb49cc80e6d43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04b5d4c323d2be411c5e4b596e2d0b5961cdf7647c6637fe74a01bcf233335640fb40dfe12c38b33a2ccb4cdb8a27ab2fcbfd9a4746a34821bb80368693236e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29577c5b57f847f0539594129d2569b0bc5b8dcc1d2f8206149f59e59b79e2739bfcc0f38548900be5daa813ec8f54ffd55e87bde381b0b9c8a7f6ae64a90c0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e1bf02c08b91f316826949ba76b25ce594985a379cee2c7d96f7b25a0c815c8ea9580ac8d31ecc30ce14bb6a2c91884bab5c7f694ce8ee2fcbd95d5bcf8425e"} 06:23:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:23:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:23:48 INFO - Contents: 06:23:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da535098262ccdc50e505f72bb7e88ff20a99585c8ced5a48789dd2f88d45389f7c239f2bbb8ec52964888e838fbaae0775a86863711ae40ee0cb49cc80e6d43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04b5d4c323d2be411c5e4b596e2d0b5961cdf7647c6637fe74a01bcf233335640fb40dfe12c38b33a2ccb4cdb8a27ab2fcbfd9a4746a34821bb80368693236e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29577c5b57f847f0539594129d2569b0bc5b8dcc1d2f8206149f59e59b79e2739bfcc0f38548900be5daa813ec8f54ffd55e87bde381b0b9c8a7f6ae64a90c0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e1bf02c08b91f316826949ba76b25ce594985a379cee2c7d96f7b25a0c815c8ea9580ac8d31ecc30ce14bb6a2c91884bab5c7f694ce8ee2fcbd95d5bcf8425e"} 06:23:48 INFO - Running post-run listener: copy_logs_to_upload_dir 06:23:48 INFO - Copying logs to upload dir... 06:23:48 INFO - mkdir: /builds/slave/test/build/upload/logs 06:23:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.224555 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-20 06:23:48.518784) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 06:23:48.524152) ========= 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=eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da535098262ccdc50e505f72bb7e88ff20a99585c8ced5a48789dd2f88d45389f7c239f2bbb8ec52964888e838fbaae0775a86863711ae40ee0cb49cc80e6d43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04b5d4c323d2be411c5e4b596e2d0b5961cdf7647c6637fe74a01bcf233335640fb40dfe12c38b33a2ccb4cdb8a27ab2fcbfd9a4746a34821bb80368693236e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29577c5b57f847f0539594129d2569b0bc5b8dcc1d2f8206149f59e59b79e2739bfcc0f38548900be5daa813ec8f54ffd55e87bde381b0b9c8a7f6ae64a90c0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e1bf02c08b91f316826949ba76b25ce594985a379cee2c7d96f7b25a0c815c8ea9580ac8d31ecc30ce14bb6a2c91884bab5c7f694ce8ee2fcbd95d5bcf8425e"} build_url:https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/KRMwHafiQCWNBfiGv-Av1Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da535098262ccdc50e505f72bb7e88ff20a99585c8ced5a48789dd2f88d45389f7c239f2bbb8ec52964888e838fbaae0775a86863711ae40ee0cb49cc80e6d43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04b5d4c323d2be411c5e4b596e2d0b5961cdf7647c6637fe74a01bcf233335640fb40dfe12c38b33a2ccb4cdb8a27ab2fcbfd9a4746a34821bb80368693236e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29577c5b57f847f0539594129d2569b0bc5b8dcc1d2f8206149f59e59b79e2739bfcc0f38548900be5daa813ec8f54ffd55e87bde381b0b9c8a7f6ae64a90c0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e1bf02c08b91f316826949ba76b25ce594985a379cee2c7d96f7b25a0c815c8ea9580ac8d31ecc30ce14bb6a2c91884bab5c7f694ce8ee2fcbd95d5bcf8425e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 06:23:48.552380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:23:48.552991) ========= 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=eca2ab57546de7b41f256b19000001ef-1490014970.230293-1616299156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:23:48.634854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 06:23:48.635161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 06:23:48.635466) ========= ========= Total master_lag: 0.18 =========