builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1475112354.69 results: success (0) buildid: 20160928153004 builduid: 8cb253427ce8499792aba616ffde2151 revision: 51a0d74d0b05d882d18e96cc3bcec6dcae1cd261 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.686558) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.687031) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.687328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.701773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.702071) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 18:25:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-09-28 18:25:55 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110988 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.827945) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.828304) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.878062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:54.878460) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 51a0d74d0b05d882d18e96cc3bcec6dcae1cd261 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 51a0d74d0b05d882d18e96cc3bcec6dcae1cd261 --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=97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 18:25:55,145 truncating revision to first 12 chars 2016-09-28 18:25:55,146 Setting DEBUG logging. 2016-09-28 18:25:55,146 attempt 1/10 2016-09-28 18:25:55,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/51a0d74d0b05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 18:25:55,651 unpacking tar archive at: fx-team-51a0d74d0b05/testing/mozharness/ program finished with exit code 0 elapsedTime=0.822719 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:55.715292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:55.715693) ========= script_repo_revision: 51a0d74d0b05d882d18e96cc3bcec6dcae1cd261 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:55.716234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:55.716596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 18:25:55.726074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-28 18:25:55.726530) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:25:56 INFO - MultiFileLogger online at 20160928 18:25:56 in /builds/slave/test 18:25:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:25:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:25:56 INFO - {'append_to_log': False, 18:25:56 INFO - 'base_work_dir': '/builds/slave/test', 18:25:56 INFO - 'blob_upload_branch': 'Fx-Team', 18:25:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:25:56 INFO - 'branch': 'Fx-Team', 18:25:56 INFO - 'buildbot_json_path': 'buildprops.json', 18:25:56 INFO - 'config_files': ('talos/linux_config.py',), 18:25:56 INFO - 'default_actions': ('clobber', 18:25:56 INFO - 'read-buildbot-config', 18:25:56 INFO - 'download-and-extract', 18:25:56 INFO - 'populate-webroot', 18:25:56 INFO - 'create-virtualenv', 18:25:56 INFO - 'install', 18:25:56 INFO - 'run-tests'), 18:25:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:25:56 INFO - 'download_minidump_stackwalk': True, 18:25:56 INFO - 'download_symbols': 'ondemand', 18:25:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:25:56 INFO - 'tooltool.py': '/tools/tooltool.py', 18:25:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:25:56 INFO - '/tools/misc-python/virtualenv.py')}, 18:25:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:25:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:25:56 INFO - 'installer_path': 'installer.exe', 18:25:56 INFO - 'log_level': 'info', 18:25:56 INFO - 'log_name': 'talos', 18:25:56 INFO - 'log_to_console': True, 18:25:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:25:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:25:56 INFO - 'opt_config_files': (), 18:25:56 INFO - 'pip_index': False, 18:25:56 INFO - 'sps_profile': False, 18:25:56 INFO - 'sps_profile_interval': 0, 18:25:56 INFO - 'suite': 'dromaeojs', 18:25:56 INFO - 'system_bits': '32', 18:25:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:25:56 INFO - 'title': 'talos-linux64-ix-068', 18:25:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:25:56 INFO - 'use_talos_json': True, 18:25:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:25:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:25:56 INFO - 'work_dir': 'build'} 18:25:56 INFO - [mozharness: 2016-09-29 01:25:56.097293Z] Running clobber step. 18:25:56 INFO - Running pre-action listener: _resource_record_pre_action 18:25:56 INFO - Running main action method: clobber 18:25:56 INFO - rmtree: /builds/slave/test/build 18:25:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:25:56 INFO - Running post-action listener: _resource_record_post_action 18:25:56 INFO - [mozharness: 2016-09-29 01:25:56.558119Z] Finished clobber step (success) 18:25:56 INFO - [mozharness: 2016-09-29 01:25:56.558218Z] Running read-buildbot-config step. 18:25:56 INFO - Running pre-action listener: _resource_record_pre_action 18:25:56 INFO - Running main action method: read_buildbot_config 18:25:56 INFO - Using buildbot properties: 18:25:56 INFO - { 18:25:56 INFO - "project": "", 18:25:56 INFO - "product": "firefox", 18:25:56 INFO - "script_repo_revision": "production", 18:25:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:25:56 INFO - "repository": "", 18:25:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:25:56 INFO - "buildid": "20160928153004", 18:25:56 INFO - "pgo_build": "True", 18:25:56 INFO - "basedir": "/builds/slave/test", 18:25:56 INFO - "buildnumber": 487, 18:25:56 INFO - "slavename": "talos-linux64-ix-068", 18:25:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:25:56 INFO - "platform": "ubuntu64_hw", 18:25:56 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:25:56 INFO - "branch": "fx-team", 18:25:56 INFO - "repo_path": "integration/fx-team", 18:25:56 INFO - "revision": "51a0d74d0b05d882d18e96cc3bcec6dcae1cd261", 18:25:56 INFO - "stage_platform": "linux64-pgo", 18:25:56 INFO - "builduid": "8cb253427ce8499792aba616ffde2151", 18:25:56 INFO - "slavebuilddir": "test" 18:25:56 INFO - } 18:25:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:25:56 INFO - Running post-action listener: _resource_record_post_action 18:25:56 INFO - [mozharness: 2016-09-29 01:25:56.560687Z] Finished read-buildbot-config step (success) 18:25:56 INFO - [mozharness: 2016-09-29 01:25:56.560776Z] Running download-and-extract step. 18:25:56 INFO - Running pre-action listener: _resource_record_pre_action 18:25:56 INFO - Running main action method: download_and_extract 18:25:56 INFO - mkdir: /builds/slave/test/build/tests 18:25:56 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')]} 18:25:56 INFO - trying https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:25:56 INFO - Downloading https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:25:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:25:57 INFO - Downloaded 1361 bytes. 18:25:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:25:57 INFO - Using the following test package requirements: 18:25:57 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:25:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:25:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'jsshell-linux-x86_64.zip'], 18:25:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:25:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:25:57 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:25:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:25:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:25:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:25:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:25:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:25:57 INFO - Fetch https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:25:57 INFO - Expected file size: 21987076 18:25:57 INFO - Content-Encoding None 18:25:57 INFO - Content-Type application/zip 18:25:57 INFO - Http code 200 18:26:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:26:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:26:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:26:02 INFO - Fetch https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:26:02 INFO - Expected file size: 21987076 18:26:02 INFO - Content-Encoding None 18:26:02 INFO - Content-Type application/zip 18:26:02 INFO - Http code 200 18:26:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:26:07 INFO - Fetch https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:26:07 INFO - Expected file size: 14414067 18:26:07 INFO - Content-Encoding None 18:26:07 INFO - Content-Type application/zip 18:26:07 INFO - Http code 200 18:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:08 INFO - trying https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:08 INFO - Downloading https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:26:09 INFO - Downloaded 59739925 bytes. 18:26:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:09 INFO - mkdir: /builds/slave/test/properties 18:26:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:26:09 INFO - Writing to file /builds/slave/test/properties/build_url 18:26:09 INFO - Contents: 18:26:09 INFO - build_url:https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:10 INFO - Running post-action listener: _resource_record_post_action 18:26:10 INFO - Running post-action listener: set_extra_try_arguments 18:26:10 INFO - [mozharness: 2016-09-29 01:26:10.149072Z] Finished download-and-extract step (success) 18:26:10 INFO - [mozharness: 2016-09-29 01:26:10.149298Z] Running populate-webroot step. 18:26:10 INFO - Running pre-action listener: _resource_record_pre_action 18:26:10 INFO - Running main action method: populate_webroot 18:26:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:26:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:26:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:26:10 INFO - '--tppagecycles', 18:26:10 INFO - '7'], 18:26:10 INFO - 'tests': ['tsvgm']}}, 18:26:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:26:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:26:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:26:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:26:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:10 INFO - 'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:10 INFO - 'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['damp', 'tps']}, 18:26:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:10 INFO - 'tests': ['damp', 'tps']}, 18:26:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['dromaeo_dom']}, 18:26:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:26:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['basic_compositor_video']}, 18:26:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:26:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['a11yr', 18:26:10 INFO - 'ts_paint', 18:26:10 INFO - 'tpaint', 18:26:10 INFO - 'sessionrestore', 18:26:10 INFO - 'sessionrestore_no_auto_restore', 18:26:10 INFO - 'tabpaint']}, 18:26:10 INFO - 'other-e10s': {'tests': ['a11yr', 18:26:10 INFO - 'ts_paint', 18:26:10 INFO - 'tpaint', 18:26:10 INFO - 'sessionrestore', 18:26:10 INFO - 'sessionrestore_no_auto_restore', 18:26:10 INFO - 'tabpaint']}, 18:26:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:26:10 INFO - 'ts_paint', 18:26:10 INFO - 'tpaint', 18:26:10 INFO - 'sessionrestore', 18:26:10 INFO - 'sessionrestore_no_auto_restore', 18:26:10 INFO - 'tabpaint']}, 18:26:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:26:10 INFO - 'ts_paint', 18:26:10 INFO - 'tpaint', 18:26:10 INFO - 'sessionrestore', 18:26:10 INFO - 'sessionrestore_no_auto_restore', 18:26:10 INFO - 'tabpaint']}, 18:26:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['a11yr', 18:26:10 INFO - 'ts_paint', 18:26:10 INFO - 'tpaint', 18:26:10 INFO - 'sessionrestore', 18:26:10 INFO - 'sessionrestore_no_auto_restore', 18:26:10 INFO - 'tabpaint']}, 18:26:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['a11yr', 18:26:10 INFO - 'ts_paint', 18:26:10 INFO - 'tpaint', 18:26:10 INFO - 'sessionrestore', 18:26:10 INFO - 'sessionrestore_no_auto_restore', 18:26:10 INFO - 'tabpaint']}, 18:26:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['tsvgx', 18:26:10 INFO - 'tsvgr_opacity', 18:26:10 INFO - 'tart', 18:26:10 INFO - 'tscrollx', 18:26:10 INFO - 'cart']}, 18:26:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:26:10 INFO - 'tsvgr_opacity', 18:26:10 INFO - 'tart', 18:26:10 INFO - 'tscrollx', 18:26:10 INFO - 'cart']}, 18:26:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:10 INFO - 'talos_options': ['--disable-e10s'], 18:26:10 INFO - 'tests': ['tp5o']}, 18:26:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:10 INFO - 'tests': ['tp5o']}, 18:26:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:10 INFO - 'talos_options': ['--disable-e10s', 18:26:10 INFO - '--xperf_path', 18:26:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:10 INFO - 'tests': ['tp5n']}, 18:26:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:10 INFO - 'talos_options': ['--xperf_path', 18:26:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:10 INFO - 'tests': ['tp5n']}}, 18:26:10 INFO - 'talos.zip': {'path': '', 18:26:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:26:10 INFO - Running post-action listener: _resource_record_post_action 18:26:10 INFO - [mozharness: 2016-09-29 01:26:10.167864Z] Finished populate-webroot step (success) 18:26:10 INFO - [mozharness: 2016-09-29 01:26:10.167951Z] Running create-virtualenv step. 18:26:10 INFO - Running pre-action listener: _resource_record_pre_action 18:26:10 INFO - Running main action method: create_virtualenv 18:26:10 INFO - Creating virtualenv /builds/slave/test/build/venv 18:26:10 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 18:26:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:26:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:26:10 INFO - Using real prefix '/usr' 18:26:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:26:10 INFO - Installing distribute.............................................................................................................................................................................................done. 18:26:12 INFO - Installing pip.................done. 18:26:12 INFO - Return code: 0 18:26:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:26:12 INFO - Reading from file tmpfile_stdout 18:26:12 INFO - Output received: 18:26:12 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) 18:26:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:12 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:12 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 18:26:12 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 18:26:12 INFO - Using env: {'DISPLAY': ':0', 18:26:12 INFO - 'HOME': '/home/cltbld', 18:26:12 INFO - 'LANG': 'en_US.UTF-8', 18:26:12 INFO - 'LANGUAGE': 'en_US:en', 18:26:12 INFO - 'LOGNAME': 'cltbld', 18:26:12 INFO - 'MAIL': '/var/mail/cltbld', 18:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:12 INFO - 'MOZ_NO_REMOTE': '1', 18:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:12 INFO - 'NO_EM_RESTART': '1', 18:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:12 INFO - 'PWD': '/builds/slave/test', 18:26:12 INFO - 'SHELL': '/bin/bash', 18:26:12 INFO - 'SHLVL': '1', 18:26:12 INFO - 'TERM': 'linux', 18:26:12 INFO - 'TMOUT': '86400', 18:26:12 INFO - 'USER': 'cltbld', 18:26:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:12 INFO - '_': '/tools/buildbot/bin/python'} 18:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:13 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 18:26:13 INFO - Cleaning up... 18:26:13 INFO - Return code: 0 18:26:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:26:13 INFO - Using env: {'DISPLAY': ':0', 18:26:13 INFO - 'HOME': '/home/cltbld', 18:26:13 INFO - 'LANG': 'en_US.UTF-8', 18:26:13 INFO - 'LANGUAGE': 'en_US:en', 18:26:13 INFO - 'LOGNAME': 'cltbld', 18:26:13 INFO - 'MAIL': '/var/mail/cltbld', 18:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:13 INFO - 'MOZ_NO_REMOTE': '1', 18:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:13 INFO - 'NO_EM_RESTART': '1', 18:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:13 INFO - 'PWD': '/builds/slave/test', 18:26:13 INFO - 'SHELL': '/bin/bash', 18:26:13 INFO - 'SHLVL': '1', 18:26:13 INFO - 'TERM': 'linux', 18:26:13 INFO - 'TMOUT': '86400', 18:26:13 INFO - 'USER': 'cltbld', 18:26:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:13 INFO - '_': '/tools/buildbot/bin/python'} 18:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:13 INFO - Downloading/unpacking psutil>=3.1.1 18:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:26:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:15 INFO - Installing collected packages: psutil 18:26:15 INFO - Running setup.py install for psutil 18:26:15 INFO - building 'psutil._psutil_linux' extension 18:26:15 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 18:26:15 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 18:26:15 INFO - building 'psutil._psutil_posix' extension 18:26:15 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 18:26:15 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 18:26:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:15 INFO - Successfully installed psutil 18:26:15 INFO - Cleaning up... 18:26:15 INFO - Return code: 0 18:26:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:26:15 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')]} 18:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:15 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')]} 18:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:15 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:15 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 18:26:15 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 18:26:15 INFO - Using env: {'DISPLAY': ':0', 18:26:15 INFO - 'HOME': '/home/cltbld', 18:26:15 INFO - 'LANG': 'en_US.UTF-8', 18:26:15 INFO - 'LANGUAGE': 'en_US:en', 18:26:15 INFO - 'LOGNAME': 'cltbld', 18:26:15 INFO - 'MAIL': '/var/mail/cltbld', 18:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:15 INFO - 'MOZ_NO_REMOTE': '1', 18:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:15 INFO - 'NO_EM_RESTART': '1', 18:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:15 INFO - 'PWD': '/builds/slave/test', 18:26:15 INFO - 'SHELL': '/bin/bash', 18:26:15 INFO - 'SHLVL': '1', 18:26:15 INFO - 'TERM': 'linux', 18:26:15 INFO - 'TMOUT': '86400', 18:26:15 INFO - 'USER': 'cltbld', 18:26:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:15 INFO - '_': '/tools/buildbot/bin/python'} 18:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:26:18 INFO - Installing collected packages: mozsystemmonitor 18:26:18 INFO - Running setup.py install for mozsystemmonitor 18:26:18 INFO - Successfully installed mozsystemmonitor 18:26:18 INFO - Cleaning up... 18:26:18 INFO - Return code: 0 18:26:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:26:18 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')]} 18:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:18 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')]} 18:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:18 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:18 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 18:26:18 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 18:26:18 INFO - Using env: {'DISPLAY': ':0', 18:26:18 INFO - 'HOME': '/home/cltbld', 18:26:18 INFO - 'LANG': 'en_US.UTF-8', 18:26:18 INFO - 'LANGUAGE': 'en_US:en', 18:26:18 INFO - 'LOGNAME': 'cltbld', 18:26:18 INFO - 'MAIL': '/var/mail/cltbld', 18:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:18 INFO - 'MOZ_NO_REMOTE': '1', 18:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:18 INFO - 'NO_EM_RESTART': '1', 18:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:18 INFO - 'PWD': '/builds/slave/test', 18:26:18 INFO - 'SHELL': '/bin/bash', 18:26:18 INFO - 'SHLVL': '1', 18:26:18 INFO - 'TERM': 'linux', 18:26:18 INFO - 'TMOUT': '86400', 18:26:18 INFO - 'USER': 'cltbld', 18:26:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:18 INFO - '_': '/tools/buildbot/bin/python'} 18:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:18 INFO - Downloading/unpacking jsonschema==2.5.1 18:26:18 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 18:26:18 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 18:26:18 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 18:26:18 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 18:26:18 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 18:26:18 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 18:26:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:26:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:26:20 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 18:26:20 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 18:26:20 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 18:26:20 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 18:26:20 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 18:26:20 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 18:26:20 INFO - Downloading functools32-3.2.3-2.tar.gz 18:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:26:20 INFO - warning: no files found matching '*.txt' 18:26:20 INFO - no previously-included directories found matching 'build' 18:26:20 INFO - no previously-included directories found matching 'dist' 18:26:20 INFO - no previously-included directories found matching '.git*' 18:26:20 INFO - Installing collected packages: jsonschema, functools32 18:26:20 INFO - Running setup.py install for functools32 18:26:20 INFO - warning: no files found matching '*.txt' 18:26:20 INFO - no previously-included directories found matching 'build' 18:26:20 INFO - no previously-included directories found matching 'dist' 18:26:20 INFO - no previously-included directories found matching '.git*' 18:26:20 INFO - Successfully installed jsonschema functools32 18:26:20 INFO - Cleaning up... 18:26:20 INFO - Return code: 0 18:26:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:20 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:20 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 18:26:20 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 18:26:20 INFO - Using env: {'DISPLAY': ':0', 18:26:20 INFO - 'HOME': '/home/cltbld', 18:26:20 INFO - 'LANG': 'en_US.UTF-8', 18:26:20 INFO - 'LANGUAGE': 'en_US:en', 18:26:20 INFO - 'LOGNAME': 'cltbld', 18:26:20 INFO - 'MAIL': '/var/mail/cltbld', 18:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:20 INFO - 'MOZ_NO_REMOTE': '1', 18:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:20 INFO - 'NO_EM_RESTART': '1', 18:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:20 INFO - 'PWD': '/builds/slave/test', 18:26:20 INFO - 'SHELL': '/bin/bash', 18:26:20 INFO - 'SHLVL': '1', 18:26:20 INFO - 'TERM': 'linux', 18:26:20 INFO - 'TMOUT': '86400', 18:26:20 INFO - 'USER': 'cltbld', 18:26:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:20 INFO - '_': '/tools/buildbot/bin/python'} 18:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:26:21 INFO - Cleaning up... 18:26:21 INFO - Return code: 0 18:26:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:26:21 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')]} 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:21 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')]} 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:21 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:21 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 18:26:21 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 18:26:21 INFO - Using env: {'DISPLAY': ':0', 18:26:21 INFO - 'HOME': '/home/cltbld', 18:26:21 INFO - 'LANG': 'en_US.UTF-8', 18:26:21 INFO - 'LANGUAGE': 'en_US:en', 18:26:21 INFO - 'LOGNAME': 'cltbld', 18:26:21 INFO - 'MAIL': '/var/mail/cltbld', 18:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:21 INFO - 'MOZ_NO_REMOTE': '1', 18:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:21 INFO - 'NO_EM_RESTART': '1', 18:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:21 INFO - 'PWD': '/builds/slave/test', 18:26:21 INFO - 'SHELL': '/bin/bash', 18:26:21 INFO - 'SHLVL': '1', 18:26:21 INFO - 'TERM': 'linux', 18:26:21 INFO - 'TMOUT': '86400', 18:26:21 INFO - 'USER': 'cltbld', 18:26:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:21 INFO - '_': '/tools/buildbot/bin/python'} 18:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:21 INFO - Downloading/unpacking blobuploader==1.2.4 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:23 INFO - Downloading blobuploader-1.2.4.tar.gz 18:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:26:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:26:23 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 18:26:23 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 18:26:23 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 18:26:23 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 18:26:23 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 18:26:23 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 18:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:26:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:26:23 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 18:26:23 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 18:26:23 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 18:26:23 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 18:26:23 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 18:26:23 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 18:26:23 INFO - Downloading docopt-0.6.1.tar.gz 18:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:26:23 INFO - Installing collected packages: blobuploader, requests, docopt 18:26:23 INFO - Running setup.py install for blobuploader 18:26:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:26:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:26:24 INFO - Running setup.py install for requests 18:26:24 INFO - Running setup.py install for docopt 18:26:24 INFO - Successfully installed blobuploader requests docopt 18:26:24 INFO - Cleaning up... 18:26:24 INFO - Return code: 0 18:26:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:24 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:24 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 18:26:24 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 18:26:24 INFO - Using env: {'DISPLAY': ':0', 18:26:24 INFO - 'HOME': '/home/cltbld', 18:26:24 INFO - 'LANG': 'en_US.UTF-8', 18:26:24 INFO - 'LANGUAGE': 'en_US:en', 18:26:24 INFO - 'LOGNAME': 'cltbld', 18:26:24 INFO - 'MAIL': '/var/mail/cltbld', 18:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:24 INFO - 'MOZ_NO_REMOTE': '1', 18:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:24 INFO - 'NO_EM_RESTART': '1', 18:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:24 INFO - 'PWD': '/builds/slave/test', 18:26:24 INFO - 'SHELL': '/bin/bash', 18:26:24 INFO - 'SHLVL': '1', 18:26:24 INFO - 'TERM': 'linux', 18:26:24 INFO - 'TMOUT': '86400', 18:26:24 INFO - 'USER': 'cltbld', 18:26:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:24 INFO - '_': '/tools/buildbot/bin/python'} 18:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:24 INFO - Running setup.py (path:/tmp/pip-kyhLMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:24 INFO - Running setup.py (path:/tmp/pip-XOt5kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:24 INFO - Running setup.py (path:/tmp/pip-kTijBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:24 INFO - Running setup.py (path:/tmp/pip-QjgROI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:25 INFO - Running setup.py (path:/tmp/pip-8I1Bjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:25 INFO - Running setup.py (path:/tmp/pip-HkZZZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:25 INFO - Running setup.py (path:/tmp/pip-9FXzYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:25 INFO - Running setup.py (path:/tmp/pip-O7rWbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:25 INFO - Running setup.py (path:/tmp/pip-T6f646-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:25 INFO - Running setup.py (path:/tmp/pip-i1lD3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:25 INFO - Running setup.py (path:/tmp/pip-2984Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:25 INFO - Running setup.py (path:/tmp/pip-uHkU9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:25 INFO - Running setup.py (path:/tmp/pip-o7_7hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:25 INFO - Running setup.py (path:/tmp/pip-QQnYxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:25 INFO - Running setup.py (path:/tmp/pip-Q7yLUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:25 INFO - Running setup.py (path:/tmp/pip-C8uSO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:25 INFO - Running setup.py (path:/tmp/pip-b4VtKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:26:25 INFO - Running setup.py install for manifestparser 18:26:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Running setup.py install for mozcrash 18:26:26 INFO - Running setup.py install for mozdebug 18:26:26 INFO - Running setup.py install for mozdevice 18:26:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Running setup.py install for mozfile 18:26:26 INFO - Running setup.py install for mozhttpd 18:26:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Running setup.py install for mozinfo 18:26:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Running setup.py install for mozInstall 18:26:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:26:26 INFO - Running setup.py install for mozleak 18:26:26 INFO - Running setup.py install for mozlog 18:26:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:26:27 INFO - Running setup.py install for moznetwork 18:26:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:26:27 INFO - Running setup.py install for mozprocess 18:26:27 INFO - Running setup.py install for mozprofile 18:26:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:26:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:26:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:26:27 INFO - Running setup.py install for mozrunner 18:26:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:26:27 INFO - Running setup.py install for mozscreenshot 18:26:27 INFO - Running setup.py install for moztest 18:26:27 INFO - Running setup.py install for mozversion 18:26:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:26:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:26:27 INFO - Cleaning up... 18:26:27 INFO - Return code: 0 18:26:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:27 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:27 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 18:26:27 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 18:26:27 INFO - Using env: {'DISPLAY': ':0', 18:26:27 INFO - 'HOME': '/home/cltbld', 18:26:27 INFO - 'LANG': 'en_US.UTF-8', 18:26:27 INFO - 'LANGUAGE': 'en_US:en', 18:26:27 INFO - 'LOGNAME': 'cltbld', 18:26:27 INFO - 'MAIL': '/var/mail/cltbld', 18:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:27 INFO - 'MOZ_NO_REMOTE': '1', 18:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:27 INFO - 'NO_EM_RESTART': '1', 18:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:27 INFO - 'PWD': '/builds/slave/test', 18:26:27 INFO - 'SHELL': '/bin/bash', 18:26:27 INFO - 'SHLVL': '1', 18:26:27 INFO - 'TERM': 'linux', 18:26:27 INFO - 'TMOUT': '86400', 18:26:27 INFO - 'USER': 'cltbld', 18:26:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:27 INFO - '_': '/tools/buildbot/bin/python'} 18:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:28 INFO - Running setup.py (path:/tmp/pip-a3vlP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:28 INFO - Running setup.py (path:/tmp/pip-Ntp2hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:28 INFO - Running setup.py (path:/tmp/pip-E8PNKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:28 INFO - Running setup.py (path:/tmp/pip-0XMbNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:28 INFO - Running setup.py (path:/tmp/pip-cwQLbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:28 INFO - Running setup.py (path:/tmp/pip-kD_05_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:28 INFO - Running setup.py (path:/tmp/pip-Tskr7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:28 INFO - Running setup.py (path:/tmp/pip-hcFBJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:28 INFO - Running setup.py (path:/tmp/pip-CBQ0Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:28 INFO - Running setup.py (path:/tmp/pip-VkdXZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:28 INFO - Running setup.py (path:/tmp/pip-_KNzh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:28 INFO - Running setup.py (path:/tmp/pip-9kpB7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:28 INFO - Running setup.py (path:/tmp/pip-FZSiaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:28 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)) 18:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:28 INFO - Running setup.py (path:/tmp/pip-BZXzm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:29 INFO - Running setup.py (path:/tmp/pip-HVd_If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:29 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)) 18:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:29 INFO - Running setup.py (path:/tmp/pip-_eM7ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 18:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:29 INFO - Running setup.py (path:/tmp/pip-ETkFU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:29 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)) 18:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:26:29 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)) 18:26:29 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:26:29 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:26:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:31 INFO - Downloading blessings-1.6.tar.gz 18:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:26:31 INFO - Installing collected packages: blessings 18:26:31 INFO - Running setup.py install for blessings 18:26:31 INFO - Successfully installed blessings 18:26:31 INFO - Cleaning up... 18:26:31 INFO - Return code: 0 18:26:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:26:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:31 INFO - Reading from file tmpfile_stdout 18:26:31 INFO - Current package versions: 18:26:31 INFO - argparse == 1.2.1 18:26:31 INFO - blessings == 1.6 18:26:31 INFO - blobuploader == 1.2.4 18:26:31 INFO - docopt == 0.6.1 18:26:31 INFO - functools32 == 3.2.3-2 18:26:31 INFO - jsonschema == 2.5.1 18:26:31 INFO - manifestparser == 1.1 18:26:31 INFO - mozInstall == 1.12 18:26:31 INFO - mozcrash == 0.17 18:26:31 INFO - mozdebug == 0.1 18:26:31 INFO - mozdevice == 0.48 18:26:31 INFO - mozfile == 1.2 18:26:31 INFO - mozhttpd == 0.7 18:26:31 INFO - mozinfo == 0.9 18:26:31 INFO - mozleak == 0.1 18:26:31 INFO - mozlog == 3.4 18:26:31 INFO - moznetwork == 0.27 18:26:31 INFO - mozprocess == 0.23 18:26:31 INFO - mozprofile == 0.28 18:26:31 INFO - mozrunner == 6.12 18:26:31 INFO - mozscreenshot == 0.1 18:26:31 INFO - mozsystemmonitor == 0.3 18:26:31 INFO - moztest == 0.7 18:26:31 INFO - mozversion == 1.4 18:26:31 INFO - psutil == 3.1.1 18:26:31 INFO - requests == 1.2.3 18:26:31 INFO - wsgiref == 0.1.2 18:26:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:31 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:31 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 18:26:31 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 18:26:31 INFO - Using env: {'DISPLAY': ':0', 18:26:31 INFO - 'HOME': '/home/cltbld', 18:26:31 INFO - 'LANG': 'en_US.UTF-8', 18:26:31 INFO - 'LANGUAGE': 'en_US:en', 18:26:31 INFO - 'LOGNAME': 'cltbld', 18:26:31 INFO - 'MAIL': '/var/mail/cltbld', 18:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:31 INFO - 'MOZ_NO_REMOTE': '1', 18:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:31 INFO - 'NO_EM_RESTART': '1', 18:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:31 INFO - 'PWD': '/builds/slave/test', 18:26:31 INFO - 'SHELL': '/bin/bash', 18:26:31 INFO - 'SHLVL': '1', 18:26:31 INFO - 'TERM': 'linux', 18:26:31 INFO - 'TMOUT': '86400', 18:26:31 INFO - 'USER': 'cltbld', 18:26:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:31 INFO - '_': '/tools/buildbot/bin/python'} 18:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 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)) 18:26:31 INFO - Cleaning up... 18:26:31 INFO - Return code: 0 18:26:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:31 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 0x7f337bf1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', '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 18:26:31 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 18:26:31 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 18:26:31 INFO - Using env: {'DISPLAY': ':0', 18:26:31 INFO - 'HOME': '/home/cltbld', 18:26:31 INFO - 'LANG': 'en_US.UTF-8', 18:26:31 INFO - 'LANGUAGE': 'en_US:en', 18:26:31 INFO - 'LOGNAME': 'cltbld', 18:26:31 INFO - 'MAIL': '/var/mail/cltbld', 18:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:31 INFO - 'MOZ_NO_REMOTE': '1', 18:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:31 INFO - 'NO_EM_RESTART': '1', 18:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:31 INFO - 'PWD': '/builds/slave/test', 18:26:31 INFO - 'SHELL': '/bin/bash', 18:26:31 INFO - 'SHLVL': '1', 18:26:31 INFO - 'TERM': 'linux', 18:26:31 INFO - 'TMOUT': '86400', 18:26:31 INFO - 'USER': 'cltbld', 18:26:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:31 INFO - '_': '/tools/buildbot/bin/python'} 18:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:26:32 INFO - Cleaning up... 18:26:32 INFO - Return code: 0 18:26:32 INFO - Running post-action listener: _resource_record_post_action 18:26:32 INFO - Running post-action listener: _start_resource_monitoring 18:26:32 INFO - Starting resource monitoring. 18:26:32 INFO - [mozharness: 2016-09-29 01:26:32.095684Z] Finished create-virtualenv step (success) 18:26:32 INFO - [mozharness: 2016-09-29 01:26:32.096270Z] Running install step. 18:26:32 INFO - Running pre-action listener: _resource_record_pre_action 18:26:32 INFO - Running main action method: install 18:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:32 INFO - Reading from file tmpfile_stdout 18:26:32 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:32 INFO - Reading from file tmpfile_stdout 18:26:32 INFO - Output received: 18:26:32 INFO - Usage: mozinstall [options] installer 18:26:32 INFO - Options: 18:26:32 INFO - -h, --help show this help message and exit 18:26:32 INFO - -d DEST, --destination=DEST 18:26:32 INFO - Directory to install application into. [default: 18:26:32 INFO - "/builds/slave/test"] 18:26:32 INFO - --app=APP Application being installed. [default: firefox] 18:26:32 INFO - mkdir: /builds/slave/test/build/application 18:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:26:49 INFO - Reading from file tmpfile_stdout 18:26:49 INFO - Output received: 18:26:49 INFO - /builds/slave/test/build/application/firefox/firefox 18:26:49 INFO - Running post-action listener: _resource_record_post_action 18:26:49 INFO - [mozharness: 2016-09-29 01:26:49.411480Z] Finished install step (success) 18:26:49 INFO - [mozharness: 2016-09-29 01:26:49.411724Z] Running run-tests step. 18:26:49 INFO - Running pre-action listener: _resource_record_pre_action 18:26:49 INFO - Running main action method: run_tests 18:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:49 INFO - Python 2.7.3 18:26:49 INFO - Return code: 0 18:26:49 INFO - grabbing minidump binary from tooltool 18:26:49 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')]} 18:26:49 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 0x17df790>, '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 0x17e0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:49 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 18:26:49 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 18:26:49 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 18:26:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:49 INFO - Return code: 0 18:26:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:26:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:26:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 18:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 18:26:49 INFO - Using env: {'DISPLAY': ':0', 18:26:49 INFO - 'HOME': '/home/cltbld', 18:26:49 INFO - 'LANG': 'en_US.UTF-8', 18:26:49 INFO - 'LANGUAGE': 'en_US:en', 18:26:49 INFO - 'LOGNAME': 'cltbld', 18:26:49 INFO - 'MAIL': '/var/mail/cltbld', 18:26:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:49 INFO - 'MOZ_NO_REMOTE': '1', 18:26:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:49 INFO - 'NO_EM_RESTART': '1', 18:26:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:49 INFO - 'PWD': '/builds/slave/test', 18:26:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:49 INFO - 'SHELL': '/bin/bash', 18:26:49 INFO - 'SHLVL': '1', 18:26:49 INFO - 'TERM': 'linux', 18:26:49 INFO - 'TMOUT': '86400', 18:26:49 INFO - 'USER': 'cltbld', 18:26:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502', 18:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:49 INFO - '_': '/tools/buildbot/bin/python'} 18:26:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 18:26:49 INFO - mozversion application_buildid: 20160928153004 18:26:49 INFO - mozversion application_changeset: 51a0d74d0b05d882d18e96cc3bcec6dcae1cd261 18:26:49 INFO - mozversion application_display_name: Nightly 18:26:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:26:49 INFO - mozversion application_name: Firefox 18:26:49 INFO - mozversion application_remotingname: firefox 18:26:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:26:49 INFO - mozversion application_vendor: Mozilla 18:26:49 INFO - mozversion application_version: 52.0a1 18:26:49 INFO - mozversion platform_buildid: 20160928153004 18:26:49 INFO - mozversion platform_changeset: 51a0d74d0b05d882d18e96cc3bcec6dcae1cd261 18:26:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:26:49 INFO - mozversion platform_version: 52.0a1 18:26:49 INFO - using testdate: 1475112409 18:26:49 INFO - actual date: 1475112409 18:26:49 INFO - starting webserver on 'localhost:41330' 18:26:49 INFO - SUITE-START | Running 2 tests 18:26:49 INFO - TEST-START | dromaeo_css 18:26:49 INFO - operating with platform_type : linux_ 18:26:49 INFO - Initialising browser for dromaeo_css test... 18:26:49 INFO - TEST-INFO | started process 2797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbDRih_/profile http://localhost:41330/getInfo.html) 18:26:54 INFO - PROCESS | 2797 | __metrics Screen width/height:1600/1200 18:26:54 INFO - PROCESS | 2797 | colorDepth:24 18:26:54 INFO - PROCESS | 2797 | Browser inner width/height: 1024/697 18:26:54 INFO - PROCESS | 2797 | __metrics 18:26:54 INFO - PROCESS | 2797 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:26:54 INFO - PROCESS | 2797 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:26:56 INFO - TEST-INFO | 2797: exit 0 18:26:56 INFO - Browser initialized. 18:26:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:56 INFO - TEST-INFO | started process 2939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbDRih_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:08 INFO - PROCESS | 2939 | RSS: Main: 173789184 18:27:08 INFO - PROCESS | 2939 | 18:27:59 INFO - PROCESS | 2939 | 1475112479640 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:30:09 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:41330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41330/tests/dromaeo/cssquery-ext.html) 18:30:10 INFO - PROCESS | 2939 | RSS: Main: 326266880 18:30:10 INFO - PROCESS | 2939 | 18:33:13 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:41330/tests/dromaeo/cssquery-ext.html (next: http://localhost:41330/tests/dromaeo/cssquery-jquery.html) 18:33:13 INFO - PROCESS | 2939 | RSS: Main: 274526208 18:33:13 INFO - PROCESS | 2939 | 18:36:15 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:41330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41330/tests/dromaeo/cssquery-mootools.html) 18:36:16 INFO - PROCESS | 2939 | RSS: Main: 254963712 18:36:16 INFO - PROCESS | 2939 | 18:39:18 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:41330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41330/tests/dromaeo/cssquery-prototype.html) 18:39:18 INFO - PROCESS | 2939 | RSS: Main: 269488128 18:39:18 INFO - PROCESS | 2939 | 18:42:21 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:41330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41330/tests/dromaeo/cssquery-yui.html) 18:42:22 INFO - PROCESS | 2939 | RSS: Main: 220487680 18:42:22 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:41330/tests/dromaeo/cssquery-yui.html (next: http://localhost:41330/tests/dromaeo/cssquery-dojo.html) 18:45:25 INFO - PROCESS | 2939 | RSS: Main: 310685696 18:45:25 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | __start_tp_report 18:45:25 INFO - PROCESS | 2939 | _x_x_mozilla_page_load 18:45:25 INFO - PROCESS | 2939 | _x_x_mozilla_page_load_details 18:45:25 INFO - PROCESS | 2939 | |i|pagename|runs| 18:45:25 INFO - PROCESS | 2939 | |0;dojo.html;3018.683038280981;3046.0404972433666;3053.5114381698927;3077.2153100959254;3100.5504201890726;5245.763940622672;5272.8154514592;5348.973255133724;5355.143177091666;5380.7309634518315;5293;5303.920441193375;5311.62818602698;5320.866978325544;5351.919721204185;4894;4909;4927.531884470969;4930.556249937505;4942.209246520558;4864.635152363569;4927.3348098006845;4932.901341973158;4952.380952380952;4959;4487.775611219442;4930.605551555867;4939.728314942677;4941.357623508939;4974;4771.761411929389;4929.8028078876805;4935.80256789728;4969.608509617313;4977.42759582649;4745.59662428694;4774.40319960005;4790.856274311742;4795.664303498756;4832.4684284728655;5243.292155558989;5272.367315922113;5282.10204265272;5327.627066105374;5408.405075441738;5772.7113644317615;5780.942190578125;5781.364049954502;5784.82645520635;5787.189793428924;5605.971970140124;5665.206871038058;5665.263515742927;5692.089265717465;5713.857153571153;5327.547158491533;5331.653442526223;5351.973240133774;5353.197020446964;5357.491038351351;5847.44449277318;5860.8534786629825;5865.20819689345;5866.149408335853;5899.085641725539;5506.807261745819;5548.112302031655;5569.081101618188;5625.353084395265;5673.971630141823;5740.397258287903;5741.339745929272;5741.65550066989;5789.565782566325;5803.82588522345;5708.9714551427805;5709.42905709434;5718.485336319751;5720.914186287209;5722.9984752668115;5575.860603484945;5620.325560932714;5729.28383952006;5746.569007324468;5752.28096487939;4404.383386325917;4414.713043652152;4440.977795111004;4445.799939002753;4450.888727781831;3975.5030621172355;3995.3607422812793;4013.7591744495426;4046.069404037088;4070.9592904070582;5448.427915068861;5458.153986132156;5460.34475862891;5462.344518657707;5463.153211252183;5596.776128954796;5670.801521946794;5782.219400380979;5790.855228619318;5807.796727114531;5357.544608708304;5388.164834450667;5405.081136206854;5442.102053161263;5458.4541545845095;4971.751412429364;5014.2979982802435;5018.222175562793;5055.570276526463;5073.264376665363;5952.166696662471;5963.5825492216;5966.552508561788;5969.52243820502;5978.611390259619;5593.860153496195;5663.292088488939;5672.376038635664;5691.8292451226525;5828.562857785768;5944.375840536682;6008.339082700987;6013.789517367046;6022.849428764316;6025.487833534199;5639.295088113986;5647.858803529944;5650.152477128464;5655.179998900054;5659.292588426447;5659.151127330933;5766;5771.451712087345;5772.451617096369;5788.189653448605;5435.347758269033;5488.17677348401;5517.282753242052;5531.363893152178;5561.749721262472;5542.63972841764;5543.9168412474655;5545.112781954868;5548.0845660465575;5607.130894711327;5520.723963801714;5527.44725527444;5538.141588053858;5539.667619942817;5540.556755459473;5409.323834520685;5518.255035570147;5602.047651899105;5636.408177141341;5641.605087643826;5482.369527504388;5527.723613819373;5539.362973257966;5565.332160140809;5588.273524441796 18:45:25 INFO - PROCESS | 2939 | |1;ext.html;556.201850344755;596.153462083841;617.7405489694328;621.8619925536268;624.33508313646;32182;43378;43398;43428.78285608567;43685.99999999996;44698.55301446984;45116.3232551512;45140.548594514046;45205.54794452054;45518.31722524165;8142.267195952363;8973.282137429007;9120.361574689774;9131.817363652723;9132.634694612207;8096.068952070528;10676.733081672981;10913.781724365508;10919.945400272987;11278.15413843961;10709.464526773669;10743.355398676105;10747.83878241827;10749.892501075006;10753.51609177589;10942.288751231185;11017.504212310385;11027.17296202788;11030.338179709242;11031.61389351377;10756.892431075667;10820.891791082146;10834.620788272452;10839.83740243897;10839.891601083968;43141;43450.782746086064;43562;43636.78181609072;44033.55966440326;3334.7832390894514;3367.36020156172;3538;3621.167131559756;3805.140312069117;31243;31694.683053169403;32351.51472727911;32392.514112288336;32520.674793252;4208.362849075613;4313.266744653416;4326.286162783137;4500.977500087064;4532.614727748145;351527;351952;352419.99999999744;352431;352465;56021.71989140028;56336.71831640816;56377;56385;56388.43611563832;58093.70953145207;58245.417545824;58560.70719646374;59293.40706592965;59340.70329648324;14569.344379502947;14737.263136843116;14745.92627036858;14752.409903603735;14753.114813111033;10190.43952582615;10496.160307175407;11302.491387887565;11308.208425410143;11580.420978951019;15139.54581362561;15465.690686186213;15475.458358957383;15582.532524024298;15858.286377113058;5977.581569290195;5978.940210597925;6029.246344206974;6089.130901341085;6136.355682653347;935.1863878425813;1008.369768894441;1084.295208114716;1114.9665510034713;1127.1039523578775;31164.220894477818;31252;31303.686963130076;31376.686233137378;31477.213069673442;1042.7653777899911;1097.4512743628186;1110.3781882146025;1117.7373317270435;1120.966371008871;15876.682466350609;16272.43046493367;16641.583960401087;16667.749983750255;16955.237014334383;538958.0520973935;543188;543374;543426;544212;55968.16047759287;56063;56063.159052614246;56135;56139.43860561424;1158.5713286084203;1228.0421271408138;1266.949322027127;1322.6693326668333;1334.099482849073;28010.85994570014;31923.201919952186;32291;32356;32819.34361312808;48108.518914810404;48529.75735121302;48660.5133948656;48680.5131948676;48736.75631621819;399121;399246;399558;400662;401296;27387.452250955266;27889.44221115607;28296.575551367157;29174.41651167007;39917.600823991386;46099.76950115362;46317;46424;46616.76691616656;47041.05917881692;39083;39431.60568394279;39541;40491.39262911;40891.1821763569;38504.91960643198;38662;38689;39613.60386396215;40896.59103408928;39494.60505394909;39743;40195.1960960785;40661.79669101635;40753.38869916894;32184.83907580447;35856.46215306825;36024.639753602125;36634.63365366419;36685.63314366822;26949.86525067362;27101.86449067742;27446.725532744418;27512.58851887158;27591.31021724473 18:45:25 INFO - PROCESS | 2939 | |2;jquery.html;365.5668033380446;374.23469005882964;383.4152916801877;390.88859674992625;411.04022108376955;14389.42442302308;18082.819171808278;18582.907085464587;19075.236990520396;20395.388138355873;17503.299868005295;19629.50926226845;19704.90147549264;19865.801341986575;19875;5508.228847961289;5779.82660520183;5784;5785.1033089870925;5789.102689083199;5654.575906806986;5695.8576035599235;5733.569982251327;5962.463378295953;5999.460048595647;6066.150738896536;6069.423404776539;6071.089336599523;6071.4232147946095;6072.666003369813;5897.616654917417;5918.289805223358;6030.7889223876955;6037.154798328237;6037.275526936795;5080.745962701887;5838.591298609099;5857.648541087548;5857.970710146422;5861.325947516048;13451.529196478075;14299.49951751694;14307.642308942255;14325.283735813271;16845.494635160965;2168.1219106261988;2258.367657056027;2584.689837219527;2622.2002289301754;2631.8552479613613;9999.500024998793;10000.59997600095;10290.639827606074;10529.157667386591;10652.786944261072;1778.457570441015;1842.8157184281465;1855.5732181598173;1870.4295189967054;1899.3542195653406;82266;83769.58115209384;83917.58041209816;84739.15260847435;87752.56123719341;10729.83905241422;10978.286411383235;11048.668539943814;11182;11187.832182517268;15459.845401545841;15477.5356739298;15484.148371839658;15497.14765687898;15526;7460.962695186489;7603.923960760432;7626.771196863992;7850.646720897574;7915.802104947423;7083.220845706968;7210.242924492853;7335.4131669466315;7440.2931721486375;7448.664810083559;4523.7285762854335;4722.881927951828;4739.099571081483;4805.6155507559315;4879.609631229493;1908.5324095596668;1929.8938558379423;1968.3602829080605;2012.2252932621047;2085.8748475091543;875.6803766625263;912.4890061565412;940.8965013848472;968.5060619084318;992.5335092506655;18058.548536286435;18887.527811804815;18934.242630294633;19114.23543058262;19609.117589708498;917.8210249001514;935.5789894547481;942.8397172480558;986.5730303453441;988.6342053440274;10266.864713446863;10515.211359148094;10608.840867386996;10688.465576721133;10777.676669699922;380301;472387;481190;491461;496192;65918;92839.5358023219;94435.52782236045;98867;102206;992.93545919515;1029.2280789407944;1070.9571617135384;1076.1175835814713;1078.2021304234966;16546.255418505956;16575.41986030483;17317.56706082358;17700.29198832032;17967.640647186723;41985.37021944612;42406.36390454084;43542.16975896557;44377.77811110924;44528.332075018254;57230.42769572251;57297;57395.426045739005;57595;57690.711546442;8332.333413326798;8333;8496.745097647081;8833.602487887933;8839.20447159733;12614.810777838156;12898.548550801052;12926.159799613371;12969.351532423152;13066.738665226452;10800.297980631234;10824.56701731922;11169.664910052712;11292.830607541058;11300.152488563555;7334.559926404433;11189.944050279697;11479.483423246142;11635.360055197045;11697.06423486102;11329.490172942402;11449.313041217554;11663.842189195026;11669.416529173337;11809.409529523662;7510.098788145458;7765.689372425039;7848.960755196187;8113.7565873023905;8637.784055398666;10900.563977440814;11050.723731906766;11144.387058711525;11172.49723762449;11504.53981840717 18:45:25 INFO - PROCESS | 2939 | |3;mootools.html;1445.291807014563;1505.5709122899973;1624.3421414327195;1751.6934536456117;1781.1984606926885;8077.515349079059;8415.116412776662;8811.251043661288;9506.52467376631;9508.334416590833;8773.868391974125;9108.726738197847;9144.679936202234;9377.859332110007;9384.296177786659;2359.079958816063;2375.928722138339;2385.105585405473;2396.341006223294;2399.520095980802;2083.5832833433296;2156.1159924430985;2316.791488766019;2390.4143484846236;2408.7350391456926;2357.0689577616918;2425.0542288507495;2428.8421252618614;2429.331933718224;2435.8782060896974;2292.2435596253194;2349.494858605408;2360.221127028077;2381.8213633977434;2385.2486466763003;2315.9652605210936;2321.721393432782;2352.588297048027;2366.538524987628;2375.0618505690154;9238.445693258358;9304.162625363682;9361.672341468016;9361.672341468084;9389.108034736757;5409.783608655649;5537.335519737658;5552.278203833516;5562.888742225133;5571.8328450146155;3472.2881809229048;3646.1613828819254;3705.555333359987;3750.4186851038135;3762.7366084374103;1117.2067831839404;1170.1867202294409;1203.205884116479;1213.3023511480933;1213.4478812140544;12795.296258705768;12879.356032198446;13000.414981325863;13007.414666340037;13007.86992130076;4741.857744267678;4755.358026666356;4809.519048095162;4859.465458799529;4970.453250142481;11011.28426652265;11027;11039.448027598748;11042.116630669527;11061.778764424667;5482.205080263339;5485.122380419114;5488.259085023471;5489.313835770528;5495.203195536625;4937.802487900443;5007.3240112584335;5017.874553136201;5026.597872170218;5055.595552355802;3973.642372186517;4000.27994960904;4073.796310184538;4097.795110244476;4099.200655872076;1184.5676328140166;1229.164168365502;1248.6066888929959;1294.152330223705;1321.6167311479755;925.2505470568726;937.3355442801675;939.8026414452904;941.9058094190664;980.2843923935567;5787.479126878601;5948.940510594925;5972.104184372379;6024.939750602438;6247.468965137923;872.7556284240422;920.204023519664;926.6525053105086;964.8408012677829;964.9469279189572;4015.3336365408027;4041.7979101045416;4047.534533528623;4063.3904914262507;4090.406891000788;11151.944240278908;11564.248323858923;11567.132465065153;11614.825777613343;11618.186726929034;11471.311721296583;11478.713032174262;11509.251898626562;11524.942375288238;11540.365279909518;8299.29455996247;8393.958030209931;8543.530105844115;8550.657973680984;8564.443311184628;5748.195252664714;5853.94146058551;6047.09293605945;6116.296625887901;6225.097360882737;10292.897071029194;10562.683119506428;10568.313059651098;10639.8936010642;10642.84035739449;10828.187885908746;10877.238593298393;10883.183761217782;10917.563297468012;10921.726956826144;8156.0620528639965;8199.303059240032;8199.467034642728;8218.671253150047;8230.753077407688;8588.441751286146;8824;8943.284537236876;8950.597223124845;8963.462192268486;7927.801804954922;7984.121746607984;8115.188481151838;8144.67421303165;8364.790880228044;7842.686292548234;7910.9604451977375;8058.516489010678;8074.515529068275;8105.148959359182;7006.9649651751415;7089.255628159175;7110.14678238594;7115.217326094022;7120.0387947626405;5314.813981510629;5383.138697808488;5409.269748584048;5482.342118945592;5586.095230480047;5388.811391601275;5427.24018637399;5447.373552041566;5461.399246082849;5587.608867379245 18:45:25 INFO - PROCESS | 2939 | |4;prototype.html;317.9030395729303;320.2586013379028;329.3939151960393;336.12271970157883;336.9460886258199;5150.33045704058;5299.78105035842;5318.282031925689;5395.541378982786;5411.89176216476;5185;5306.416294207634;5321.574274058075;5323.402979106272;5338.439463856297;4174.853880114197;4205.915881682372;4219.092895027568;4225.408442817992;4231.978840105795;4137.586241375853;4151.005228479071;4204.66362690984;4227.323628219486;4256.2764330063965;4152.647025002879;4167.708260421772;4187.434696315989;4195.727277726954;4212.1575684863;4178.477690288714;4188.057687020427;4194.6853985951175;4209.494860616715;4221.493420789525;3745.2509498100217;3756.098536351256;3762.755420897633;3771.264603402338;3776.3195378056776;5013.072581572421;5119.667221630582;5189.143791274435;5206.739663016872;5229.1633338666015;4741.834035808764;4768.189407800647;4810.7835147418455;4812.614990800727;4825.541573550507;5382.515573598395;5536.4186760390385;5545.861353466155;5591.384947655754;5597.216389705403;4060.3300455425115;4076.8165432555606;4078.4290199371817;4089.8364065437645;4116.341385378325;5723.570732195102;5752.597318187729;5759.308882934033;5767.509761670263;5784.537237021028;4208.347706105558;4208.36874468826;4208.579142085767;4219.472565929259;4245.957540424556;4118.299889018874;4257.233248202024;4258.957410425918;4261.10516791471;4283.593058659422;4793.209120495149;4834.758262086882;4844.176489996709;4849.957259189221;4860.513948605182;5589.804356847572;5599.748011339418;5609.523190528851;5631.436856314336;5696.401877802854;1404.8946329025364;1461.3277892169722;1467.8385377608454;1468.9412423503154;1476.859698328657;925.8379783537989;941.5621735892843;942;951.4101257220567;954.9570269337896;4818.349522814376;4833.540813622701;4834.589059929875;4844.491328410466;4857.80568777252;5037.312500312363;5061.215511595708;5066.82266120684;5130.48695130484;5157.974210128926;4872.756362181947;4879.414470263591;4887.951120488749;4937.8271760488215;5195.506426889439;3000.234940090263;3039;3043.7412819910555;3046.1875184265327;3055.4958431858495;5953;5959.970200148971;5962;5964.970175149097;5972.790952316648;5680.204771332017;5822.359540450547;5854.356020837705;5872.11918212263;5901.557383196277;5795.768169273266;5884.823455296348;5910.911336329958;5931.347551769388;5944.6730429826775;5609.419666953084;5673.744681489426;5700.315962084576;5737.397573254748;5767.481836080072;5632.5775566831835;5665.773369065191;5673.347565030074;5689.8862022758485;5699.287589051369;5943.465088142088;5953.553483488669;5958.731857066356;6008.819735407945;6030.6080104793045;4089.4070359798257;4120.093579412524;4126.216018956388;4127.29835927899;4133.8503977931905;5656.519195868397;5721.771129154788;5768.192453056659;5772.076467765138;5791.131330300489;5626.409227031103;5641.971790141023;5643.689597072201;5644.66132032063;5659.745311460912;5387.2727181831515;5560.805371811967;5584.766093562607;5618.69097199658;5619.185218143264;5577.414371490935;5580.581456390868;5589.301337332833;5590.468905454138;5614.157876318585;5448.945510544844;5601.243832082617;5663.688497132697;5712.285964254468;5717.742701578522;5400.729963501888;5400.83797486076;5416.322959630046;5437.619366644297;5443.265159203615 18:45:25 INFO - PROCESS | 2939 | |5;yui.html;655.4520341785563;669.5079116849116;675.4765057080765;759.3811043999141;760.8554374668814;15222.923885380571;16562.66874662506;16586.336546538125;16590.7511387329;16604.750928736063;14783.482578109768;14879.702405951875;14897.180655063967;14940.925295373509;14968.027078239935;777.630625452911;800.9439339246255;803.562058678019;803.907550631676;804.0592506767067;787.708547837301;788.846174995876;789.5223389849144;789.8301865099003;790.119017295714;834.4742812028413;834.7537476444434;835.3776436554775;836.6318819719335;837.1084794693662;829.3945419843548;829.8132920093021;829.8589239829213;829.9543525106117;830.0205757206494;613.9416755408229;614.008376471999;614.4991831657185;614.8155553333982;614.846288427893;13672.863271367358;13947.511837085754;14037.368318425593;14263.928680356532;14271.928640356835;12555;12667.683307917376;12669.619911402673;12776.552820651232;12798.680032999157;10675;10846.349219046882;10880.564777408894;10916;11082.445877706163;3635.5273814404222;3641.9453708194396;3642.526471558707;3698.1863989922176;3762.3792074307707;64063;64993.3500664992;65067.34932650708;72810;73590.26409735941;9988.500574971222;10028;10101.797964040677;10132.138768204784;10748.247622666495;19836.305729299405;19856.90071549633;19869.503262418555;19893;19943.102560384817;6485.967570162119;6629.105070815378;8181.550014749127;8348.081711011784;8705;3770.5098337215986;4083.89790255246;4280.636145927569;4628.352030715702;4639.675222734376;3643.544556930384;3762.228743107711;3779.4141908004303;3785.7917814519915;3786.091338078841;632.193952710298;645.5094128462403;647.391452035095;647.870425914819;652.0642877470844;651.8663673946829;696.5263620737946;720.2318308552595;764.9196834332315;788.0740130346934;9526.476043817656;10213.08082272599;10220.591176353011;10270.897291027144;10532.210084243712;621.1056079245872;685.9279775623488;696.8292768271806;701.7368486817444;751.1511991449627;4765.510176813745;4766.593854812769;4831.154547954094;4858;4897.730624815669;105906;111977;113219;116542;119062;101268;101777;105532.47233763935;106710;107069;56528;57328.71335643295;86171.56914215515;87261.56369218114;88425;9214.953925230599;9233.815323693623;9252.306077044113;9255.67605133844;9449.858252126087;52860;54610.453895462124;54625.36123916289;54946;56518.71740641435;75821.6208918974;75899;77920.493577788;80315;80542;11342.60300889465;11429.885701142883;11458.484368203284;11608.825867611824;11768.52925882955;12782;12893.881553078863;13005.414756335798;13304.467821287428;13534;11381.829272561085;11772.234804737665;11872.584459543874;12341.814872776737;12379.504819807107;12063.21589096706;12284.570040048555;12352.197107188003;12375.814362784386;12907.806382904077;11502.82745758831;11738;11769.588064418047;12344.259344439362;12372.4432400544;9663.613455461702;9799.23613749532;9943.30396872241;9954.601815927283;10106;9775.462349570842;10761.059116869732;10784.784304313713;10793.730156746144;10965.56137754481 18:45:25 INFO - PROCESS | 2939 | __end_tp_report 18:45:25 INFO - PROCESS | 2939 | __start_cc_report 18:45:25 INFO - PROCESS | 2939 | _x_x_mozilla_cycle_collect,1183 18:45:25 INFO - PROCESS | 2939 | __end_cc_report 18:45:25 INFO - PROCESS | 2939 | __startTimestamp1475113525335__endTimestamp 18:45:25 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | ------- Summary: start ------- 18:45:25 INFO - PROCESS | 2939 | Number of tests: 6 18:45:25 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | [#0] dojo.html Cycles:165 Average:5322.98 Median:5520.72 stddev:597.00 (10.8%) stddev-sans-first:570.81 18:45:25 INFO - PROCESS | 2939 | Values: 3018.7 3046.0 3053.5 3077.2 3100.6 5245.8 5272.8 5349.0 5355.1 5380.7 5293.0 5303.9 5311.6 5320.9 5351.9 4894.0 4909.0 4927.5 4930.6 4942.2 4864.6 4927.3 4932.9 4952.4 4959.0 4487.8 4930.6 4939.7 4941.4 4974.0 4771.8 4929.8 4935.8 4969.6 4977.4 4745.6 4774.4 4790.9 4795.7 4832.5 5243.3 5272.4 5282.1 5327.6 5408.4 5772.7 5780.9 5781.4 5784.8 5787.2 5606.0 5665.2 5665.3 5692.1 5713.9 5327.5 5331.7 5352.0 5353.2 5357.5 5847.4 5860.9 5865.2 5866.1 5899.1 5506.8 5548.1 5569.1 5625.4 5674.0 5740.4 5741.3 5741.7 5789.6 5803.8 5709.0 5709.4 5718.5 5720.9 5723.0 5575.9 5620.3 5729.3 5746.6 5752.3 4404.4 4414.7 4441.0 4445.8 4450.9 3975.5 3995.4 4013.8 4046.1 4071.0 5448.4 5458.2 5460.3 5462.3 5463.2 5596.8 5670.8 5782.2 5790.9 5807.8 5357.5 5388.2 5405.1 5442.1 5458.5 4971.8 5014.3 5018.2 5055.6 5073.3 5952.2 5963.6 5966.6 5969.5 5978.6 5593.9 5663.3 5672.4 5691.8 5828.6 5944.4 6008.3 6013.8 6022.8 6025.5 5639.3 5647.9 5650.2 5655.2 5659.3 5659.2 5766.0 5771.5 5772.5 5788.2 5435.3 5488.2 5517.3 5531.4 5561.7 5542.6 5543.9 5545.1 5548.1 5607.1 5520.7 5527.4 5538.1 5539.7 5540.6 5409.3 5518.3 5602.0 5636.4 5641.6 5482.4 5527.7 5539.4 5565.3 5588.3 18:45:25 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | [#1] ext.html Cycles:180 Average:59049.82 Median:36660.13 stddev:116397.70 (317.5%) stddev-sans-first:116641.37 18:45:25 INFO - PROCESS | 2939 | Values: 556.2 596.2 617.7 621.9 624.3 32182.0 43378.0 43398.0 43428.8 43686.0 44698.6 45116.3 45140.5 45205.5 45518.3 8142.3 8973.3 9120.4 9131.8 9132.6 8096.1 10676.7 10913.8 10919.9 11278.2 10709.5 10743.4 10747.8 10749.9 10753.5 10942.3 11017.5 11027.2 11030.3 11031.6 10756.9 10820.9 10834.6 10839.8 10839.9 43141.0 43450.8 43562.0 43636.8 44033.6 3334.8 3367.4 3538.0 3621.2 3805.1 31243.0 31694.7 32351.5 32392.5 32520.7 4208.4 4313.3 4326.3 4501.0 4532.6 351527.0 351952.0 352420.0 352431.0 352465.0 56021.7 56336.7 56377.0 56385.0 56388.4 58093.7 58245.4 58560.7 59293.4 59340.7 14569.3 14737.3 14745.9 14752.4 14753.1 10190.4 10496.2 11302.5 11308.2 11580.4 15139.5 15465.7 15475.5 15582.5 15858.3 5977.6 5978.9 6029.2 6089.1 6136.4 935.2 1008.4 1084.3 1115.0 1127.1 31164.2 31252.0 31303.7 31376.7 31477.2 1042.8 1097.5 1110.4 1117.7 1121.0 15876.7 16272.4 16641.6 16667.7 16955.2 538958.1 543188.0 543374.0 543426.0 544212.0 55968.2 56063.0 56063.2 56135.0 56139.4 1158.6 1228.0 1266.9 1322.7 1334.1 28010.9 31923.2 32291.0 32356.0 32819.3 48108.5 48529.8 48660.5 48680.5 48736.8 399121.0 399246.0 399558.0 400662.0 401296.0 27387.5 27889.4 28296.6 29174.4 39917.6 46099.8 46317.0 46424.0 46616.8 47041.1 39083.0 39431.6 39541.0 40491.4 40891.2 38504.9 38662.0 38689.0 39613.6 40896.6 39494.6 39743.0 40195.2 40661.8 40753.4 32184.8 35856.5 36024.6 36634.6 36685.6 26949.9 27101.9 27446.7 27512.6 27591.3 18:45:25 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | [#2] jquery.html Cycles:180 Average:28016.66 Median:190342.21 stddev:77166.93 (40.5%) stddev-sans-first:77355.48 18:45:25 INFO - PROCESS | 2939 | Values: 365.6 374.2 383.4 390.9 411.0 14389.4 18082.8 18582.9 19075.2 20395.4 17503.3 19629.5 19704.9 19865.8 19875.0 5508.2 5779.8 5784.0 5785.1 5789.1 5654.6 5695.9 5733.6 5962.5 5999.5 6066.2 6069.4 6071.1 6071.4 6072.7 5897.6 5918.3 6030.8 6037.2 6037.3 5080.7 5838.6 5857.6 5858.0 5861.3 13451.5 14299.5 14307.6 14325.3 16845.5 2168.1 2258.4 2584.7 2622.2 2631.9 9999.5 10000.6 10290.6 10529.2 10652.8 1778.5 1842.8 1855.6 1870.4 1899.4 82266.0 83769.6 83917.6 84739.2 87752.6 10729.8 10978.3 11048.7 11182.0 11187.8 15459.8 15477.5 15484.1 15497.1 15526.0 7461.0 7603.9 7626.8 7850.6 7915.8 7083.2 7210.2 7335.4 7440.3 7448.7 4523.7 4722.9 4739.1 4805.6 4879.6 1908.5 1929.9 1968.4 2012.2 2085.9 875.7 912.5 940.9 968.5 992.5 18058.5 18887.5 18934.2 19114.2 19609.1 917.8 935.6 942.8 986.6 988.6 10266.9 10515.2 10608.8 10688.5 10777.7 380301.0 472387.0 481190.0 491461.0 496192.0 65918.0 92839.5 94435.5 98867.0 102206.0 992.9 1029.2 1071.0 1076.1 1078.2 16546.3 16575.4 17317.6 17700.3 17967.6 41985.4 42406.4 43542.2 44377.8 44528.3 57230.4 57297.0 57395.4 57595.0 57690.7 8332.3 8333.0 8496.7 8833.6 8839.2 12614.8 12898.5 12926.2 12969.4 13066.7 10800.3 10824.6 11169.7 11292.8 11300.2 7334.6 11189.9 11479.5 11635.4 11697.1 11329.5 11449.3 11663.8 11669.4 11809.4 7510.1 7765.7 7849.0 8113.8 8637.8 10900.6 11050.7 11144.4 11172.5 11504.5 18:45:25 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | [#3] mootools.html Cycles:180 Average:6047.16 Median:4988.89 stddev:3490.76 (70.0%) stddev-sans-first:3483.42 18:45:25 INFO - PROCESS | 2939 | Values: 1445.3 1505.6 1624.3 1751.7 1781.2 8077.5 8415.1 8811.3 9506.5 9508.3 8773.9 9108.7 9144.7 9377.9 9384.3 2359.1 2375.9 2385.1 2396.3 2399.5 2083.6 2156.1 2316.8 2390.4 2408.7 2357.1 2425.1 2428.8 2429.3 2435.9 2292.2 2349.5 2360.2 2381.8 2385.2 2316.0 2321.7 2352.6 2366.5 2375.1 9238.4 9304.2 9361.7 9361.7 9389.1 5409.8 5537.3 5552.3 5562.9 5571.8 3472.3 3646.2 3705.6 3750.4 3762.7 1117.2 1170.2 1203.2 1213.3 1213.4 12795.3 12879.4 13000.4 13007.4 13007.9 4741.9 4755.4 4809.5 4859.5 4970.5 11011.3 11027.0 11039.4 11042.1 11061.8 5482.2 5485.1 5488.3 5489.3 5495.2 4937.8 5007.3 5017.9 5026.6 5055.6 3973.6 4000.3 4073.8 4097.8 4099.2 1184.6 1229.2 1248.6 1294.2 1321.6 925.3 937.3 939.8 941.9 980.3 5787.5 5948.9 5972.1 6024.9 6247.5 872.8 920.2 926.7 964.8 964.9 4015.3 4041.8 4047.5 4063.4 4090.4 11151.9 11564.2 11567.1 11614.8 11618.2 11471.3 11478.7 11509.3 11524.9 11540.4 8299.3 8394.0 8543.5 8550.7 8564.4 5748.2 5853.9 6047.1 6116.3 6225.1 10292.9 10562.7 10568.3 10639.9 10642.8 10828.2 10877.2 10883.2 10917.6 10921.7 8156.1 8199.3 8199.5 8218.7 8230.8 8588.4 8824.0 8943.3 8950.6 8963.5 7927.8 7984.1 8115.2 8144.7 8364.8 7842.7 7911.0 8058.5 8074.5 8105.1 7007.0 7089.3 7110.1 7115.2 7120.0 5314.8 5383.1 5409.3 5482.3 5586.1 5388.8 5427.2 5447.4 5461.4 5587.6 18:45:25 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | [#4] prototype.html Cycles:180 Average:4688.02 Median:5217.95 stddev:1360.45 (26.1%) stddev-sans-first:1324.14 18:45:25 INFO - PROCESS | 2939 | Values: 317.9 320.3 329.4 336.1 336.9 5150.3 5299.8 5318.3 5395.5 5411.9 5185.0 5306.4 5321.6 5323.4 5338.4 4174.9 4205.9 4219.1 4225.4 4232.0 4137.6 4151.0 4204.7 4227.3 4256.3 4152.6 4167.7 4187.4 4195.7 4212.2 4178.5 4188.1 4194.7 4209.5 4221.5 3745.3 3756.1 3762.8 3771.3 3776.3 5013.1 5119.7 5189.1 5206.7 5229.2 4741.8 4768.2 4810.8 4812.6 4825.5 5382.5 5536.4 5545.9 5591.4 5597.2 4060.3 4076.8 4078.4 4089.8 4116.3 5723.6 5752.6 5759.3 5767.5 5784.5 4208.3 4208.4 4208.6 4219.5 4246.0 4118.3 4257.2 4259.0 4261.1 4283.6 4793.2 4834.8 4844.2 4850.0 4860.5 5589.8 5599.7 5609.5 5631.4 5696.4 1404.9 1461.3 1467.8 1468.9 1476.9 925.8 941.6 942.0 951.4 955.0 4818.3 4833.5 4834.6 4844.5 4857.8 5037.3 5061.2 5066.8 5130.5 5158.0 4872.8 4879.4 4888.0 4937.8 5195.5 3000.2 3039.0 3043.7 3046.2 3055.5 5953.0 5960.0 5962.0 5965.0 5972.8 5680.2 5822.4 5854.4 5872.1 5901.6 5795.8 5884.8 5910.9 5931.3 5944.7 5609.4 5673.7 5700.3 5737.4 5767.5 5632.6 5665.8 5673.3 5689.9 5699.3 5943.5 5953.6 5958.7 6008.8 6030.6 4089.4 4120.1 4126.2 4127.3 4133.9 5656.5 5721.8 5768.2 5772.1 5791.1 5626.4 5642.0 5643.7 5644.7 5659.7 5387.3 5560.8 5584.8 5618.7 5619.2 5577.4 5580.6 5589.3 5590.5 5614.2 5448.9 5601.2 5663.7 5712.3 5717.7 5400.7 5400.8 5416.3 5437.6 5443.3 18:45:25 INFO - PROCESS | 2939 | 18:45:25 INFO - PROCESS | 2939 | [#5] yui.html Cycles:180 Average:20124.05 Median:4454.49 stddev:29696.90 (666.7%) stddev-sans-first:29744.23 18:45:25 INFO - PROCESS | 2939 | Values: 655.5 669.5 675.5 759.4 760.9 15222.9 16562.7 16586.3 16590.8 16604.8 14783.5 14879.7 14897.2 14940.9 14968.0 777.6 800.9 803.6 803.9 804.1 787.7 788.8 789.5 789.8 790.1 834.5 834.8 835.4 836.6 837.1 829.4 829.8 829.9 830.0 830.0 613.9 614.0 614.5 614.8 614.8 13672.9 13947.5 14037.4 14263.9 14271.9 12555.0 12667.7 12669.6 12776.6 12798.7 10675.0 10846.3 10880.6 10916.0 11082.4 3635.5 3641.9 3642.5 3698.2 3762.4 64063.0 64993.4 65067.3 72810.0 73590.3 9988.5 10028.0 10101.8 10132.1 10748.2 19836.3 19856.9 19869.5 19893.0 19943.1 6486.0 6629.1 8181.6 8348.1 8705.0 3770.5 4083.9 4280.6 4628.4 4639.7 3643.5 3762.2 3779.4 3785.8 3786.1 632.2 645.5 647.4 647.9 652.1 651.9 696.5 720.2 764.9 788.1 9526.5 10213.1 10220.6 10270.9 10532.2 621.1 685.9 696.8 701.7 751.2 4765.5 4766.6 4831.2 4858.0 4897.7 105906.0 111977.0 113219.0 116542.0 119062.0 101268.0 101777.0 105532.5 106710.0 107069.0 56528.0 57328.7 86171.6 87261.6 88425.0 9215.0 9233.8 9252.3 9255.7 9449.9 52860.0 54610.5 54625.4 54946.0 56518.7 75821.6 75899.0 77920.5 80315.0 80542.0 11342.6 11429.9 11458.5 11608.8 11768.5 12782.0 12893.9 13005.4 13304.5 13534.0 11381.8 11772.2 11872.6 12341.8 12379.5 12063.2 12284.6 12352.2 12375.8 12907.8 11502.8 11738.0 11769.6 12344.3 12372.4 9663.6 9799.2 9943.3 9954.6 10106.0 9775.5 10761.1 10784.8 10793.7 10965.6 18:45:25 INFO - PROCESS | 2939 | -------- Summary: end -------- 18:45:25 INFO - PROCESS | 2939 | 18:45:26 INFO - TEST-INFO | 2939: exit 0 18:45:26 INFO - TEST-OK | dromaeo_css | took 1116572ms 18:45:26 INFO - TEST-START | kraken 18:45:26 INFO - operating with platform_type : linux_ 18:45:26 INFO - Initialising browser for kraken test... 18:45:26 INFO - TEST-INFO | started process 3245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoa_NDc/profile http://localhost:41330/getInfo.html) 18:45:30 INFO - PROCESS | 3245 | __metrics Screen width/height:1600/1200 18:45:30 INFO - PROCESS | 3245 | colorDepth:24 18:45:30 INFO - PROCESS | 3245 | Browser inner width/height: 1024/697 18:45:30 INFO - PROCESS | 3245 | __metrics 18:45:31 INFO - PROCESS | 3245 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:45:31 INFO - PROCESS | 3245 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:45:31 INFO - PROCESS | 3245 | console.error: PushService: 18:45:31 INFO - PROCESS | 3245 | stateChangeProcessEnqueue: Error transitioning state 18:45:31 INFO - PROCESS | 3245 | UnknownError 18:45:32 INFO - TEST-INFO | 3245: exit 0 18:45:32 INFO - Browser initialized. 18:45:32 INFO - Running cycle 1/1 for kraken test... 18:45:32 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoa_NDc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:44 INFO - PROCESS | 3332 | RSS: Main: 173654016 18:45:44 INFO - PROCESS | 3332 | 18:45:47 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41330/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:47 INFO - PROCESS | 3332 | RSS: Main: 233385984 18:45:47 INFO - PROCESS | 3332 | 18:45:50 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41330/tests/kraken/driver.html?testName=audio-dft) 18:45:51 INFO - PROCESS | 3332 | RSS: Main: 217935872 18:45:51 INFO - PROCESS | 3332 | 18:45:54 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41330/tests/kraken/driver.html?testName=audio-fft) 18:45:54 INFO - PROCESS | 3332 | RSS: Main: 298672128 18:45:54 INFO - PROCESS | 3332 | 18:45:57 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41330/tests/kraken/driver.html?testName=audio-oscillator) 18:45:57 INFO - PROCESS | 3332 | RSS: Main: 208699392 18:45:57 INFO - PROCESS | 3332 | 18:45:59 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:46:00 INFO - PROCESS | 3332 | RSS: Main: 212664320 18:46:00 INFO - PROCESS | 3332 | 18:46:03 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41330/tests/kraken/driver.html?testName=imaging-darkroom) 18:46:03 INFO - PROCESS | 3332 | RSS: Main: 249384960 18:46:03 INFO - PROCESS | 3332 | 18:46:07 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41330/tests/kraken/driver.html?testName=imaging-desaturate) 18:46:07 INFO - PROCESS | 3332 | RSS: Main: 248012800 18:46:07 INFO - PROCESS | 3332 | 18:46:10 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41330/tests/kraken/driver.html?testName=json-parse-financial) 18:46:11 INFO - PROCESS | 3332 | RSS: Main: 248705024 18:46:11 INFO - PROCESS | 3332 | 18:46:12 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:46:13 INFO - PROCESS | 3332 | RSS: Main: 210284544 18:46:13 INFO - PROCESS | 3332 | 18:46:15 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41330/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:46:15 INFO - PROCESS | 3332 | RSS: Main: 217845760 18:46:15 INFO - PROCESS | 3332 | 18:46:17 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:46:18 INFO - PROCESS | 3332 | RSS: Main: 222625792 18:46:18 INFO - PROCESS | 3332 | 18:46:21 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:46:21 INFO - PROCESS | 3332 | RSS: Main: 224313344 18:46:21 INFO - PROCESS | 3332 | 18:46:24 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:25 INFO - PROCESS | 3332 | RSS: Main: 221794304 18:46:25 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:41330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41330/tests/kraken/driver.html?testName=ai-astar) 18:46:26 INFO - PROCESS | 3332 | RSS: Main: 272994304 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | __start_tp_report 18:46:26 INFO - PROCESS | 3332 | _x_x_mozilla_page_load 18:46:26 INFO - PROCESS | 3332 | _x_x_mozilla_page_load_details 18:46:26 INFO - PROCESS | 3332 | |i|pagename|runs| 18:46:26 INFO - PROCESS | 3332 | |0;ai-astar;108;112;109;109;111;111;111;110;111;111 18:46:26 INFO - PROCESS | 3332 | |1;audio-beat-detection;148;118;122;155;124;119;118;119;163;125 18:46:26 INFO - PROCESS | 3332 | |2;audio-dft;160;161;160;160;160;161;162;163;162;161 18:46:26 INFO - PROCESS | 3332 | |3;audio-fft;76;75;76;113;76;76;75;75;118;75 18:46:26 INFO - PROCESS | 3332 | |4;audio-oscillator;84;84;110;83;82;82;101;82;82;114 18:46:26 INFO - PROCESS | 3332 | |5;imaging-gaussian-blur;118;118;117;117;118;116;117;116;117;117 18:46:26 INFO - PROCESS | 3332 | |6;imaging-darkroom;146;146;145;147;146;146;145;145;146;146 18:46:26 INFO - PROCESS | 3332 | |7;imaging-desaturate;95;97;96;97;96;96;95;95;95;96 18:46:26 INFO - PROCESS | 3332 | |8;json-parse-financial;51;51;54;49;51;51;52;53;52;52 18:46:26 INFO - PROCESS | 3332 | |9;json-stringify-tinderbox;63;62;62;62;62;60;60;61;61;61 18:46:26 INFO - PROCESS | 3332 | |10;stanford-crypto-aes;77;85;78;82;88;79;78;83;78;77 18:46:26 INFO - PROCESS | 3332 | |11;stanford-crypto-ccm;127;131;123;122;125;121;132;126;176;122 18:46:26 INFO - PROCESS | 3332 | |12;stanford-crypto-pbkdf2;161;161;162;167;159;162;167;161;161;161 18:46:26 INFO - PROCESS | 3332 | |13;stanford-crypto-sha256-iterative;65;65;65;65;65;63;64;66;65;66 18:46:26 INFO - PROCESS | 3332 | __end_tp_report 18:46:26 INFO - PROCESS | 3332 | __start_cc_report 18:46:26 INFO - PROCESS | 3332 | _x_x_mozilla_cycle_collect,1626 18:46:26 INFO - PROCESS | 3332 | __end_cc_report 18:46:26 INFO - PROCESS | 3332 | __startTimestamp1475113586908__endTimestamp 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | ------- Summary: start ------- 18:46:26 INFO - PROCESS | 3332 | Number of tests: 14 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.25 (1.1%) stddev-sans-first:1.01 18:46:26 INFO - PROCESS | 3332 | Values: 108.0 112.0 109.0 109.0 111.0 111.0 111.0 110.0 111.0 111.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:124.50 stddev:17.26 (13.9%) stddev-sans-first:17.19 18:46:26 INFO - PROCESS | 3332 | Values: 148.0 118.0 122.0 155.0 124.0 119.0 118.0 119.0 163.0 125.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 18:46:26 INFO - PROCESS | 3332 | Values: 160.0 161.0 160.0 160.0 160.0 161.0 162.0 163.0 162.0 161.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.50 stddev:16.91 (22.4%) stddev-sans-first:17.72 18:46:26 INFO - PROCESS | 3332 | Values: 76.0 75.0 76.0 113.0 76.0 76.0 75.0 75.0 118.0 75.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.00 stddev:12.79 (15.6%) stddev-sans-first:13.36 18:46:26 INFO - PROCESS | 3332 | Values: 84.0 84.0 110.0 83.0 82.0 82.0 101.0 82.0 82.0 114.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 18:46:26 INFO - PROCESS | 3332 | Values: 118.0 118.0 117.0 117.0 118.0 116.0 117.0 116.0 117.0 117.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 18:46:26 INFO - PROCESS | 3332 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 145.0 145.0 146.0 146.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 18:46:26 INFO - PROCESS | 3332 | Values: 95.0 97.0 96.0 97.0 96.0 96.0 95.0 95.0 95.0 96.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.35 (2.6%) stddev-sans-first:1.41 18:46:26 INFO - PROCESS | 3332 | Values: 51.0 51.0 54.0 49.0 51.0 51.0 52.0 53.0 52.0 52.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:0.83 18:46:26 INFO - PROCESS | 3332 | Values: 63.0 62.0 62.0 62.0 62.0 60.0 60.0 61.0 61.0 61.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:3.81 (4.7%) stddev-sans-first:3.82 18:46:26 INFO - PROCESS | 3332 | Values: 77.0 85.0 78.0 82.0 88.0 79.0 78.0 83.0 78.0 77.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:126.50 stddev:16.42 (13.0%) stddev-sans-first:17.37 18:46:26 INFO - PROCESS | 3332 | Values: 127.0 131.0 123.0 122.0 125.0 121.0 132.0 126.0 176.0 122.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:161.50 stddev:2.66 (1.6%) stddev-sans-first:2.78 18:46:26 INFO - PROCESS | 3332 | Values: 161.0 161.0 162.0 167.0 159.0 162.0 167.0 161.0 161.0 161.0 18:46:26 INFO - PROCESS | 3332 | 18:46:26 INFO - PROCESS | 3332 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 18:46:26 INFO - PROCESS | 3332 | Values: 65.0 65.0 65.0 65.0 65.0 63.0 64.0 66.0 65.0 66.0 18:46:26 INFO - PROCESS | 3332 | -------- Summary: end -------- 18:46:26 INFO - PROCESS | 3332 | 18:46:28 INFO - TEST-INFO | 3332: exit 0 18:46:28 INFO - TEST-OK | kraken | took 61907ms 18:46:28 INFO - SUITE-END | took 1178s 18:46:28 INFO - Completed test suite (00:19:38) 18:46:28 INFO - javascript benchmark 18:46:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.683038280981, 3046.0404972433666, 3053.5114381698927, 3077.2153100959254, 3100.5504201890726, 5245.763940622672, 5272.8154514592, 5348.973255133724, 5355.143177091666, 5380.7309634518315, 5293.0, 5303.920441193375, 5311.62818602698, 5320.866978325544, 5351.919721204185, 4894.0, 4909.0, 4927.531884470969, 4930.556249937505, 4942.209246520558, 4864.635152363569, 4927.3348098006845, 4932.901341973158, 4952.380952380952, 4959.0, 4487.775611219442, 4930.605551555867, 4939.728314942677, 4941.357623508939, 4974.0, 4771.761411929389, 4929.8028078876805, 4935.80256789728, 4969.608509617313, 4977.42759582649, 4745.59662428694, 4774.40319960005, 4790.856274311742, 4795.664303498756, 4832.4684284728655, 5243.292155558989, 5272.367315922113, 5282.10204265272, 5327.627066105374, 5408.405075441738, 5772.7113644317615, 5780.942190578125, 5781.364049954502, 5784.82645520635, 5787.189793428924, 5605.971970140124, 5665.206871038058, 5665.263515742927, 5692.089265717465, 5713.857153571153, 5327.547158491533, 5331.653442526223, 5351.973240133774, 5353.197020446964, 5357.491038351351, 5847.44449277318, 5860.8534786629825, 5865.20819689345, 5866.149408335853, 5899.085641725539, 5506.807261745819, 5548.112302031655, 5569.081101618188, 5625.353084395265, 5673.971630141823, 5740.397258287903, 5741.339745929272, 5741.65550066989, 5789.565782566325, 5803.82588522345, 5708.9714551427805, 5709.42905709434, 5718.485336319751, 5720.914186287209, 5722.9984752668115, 5575.860603484945, 5620.325560932714, 5729.28383952006, 5746.569007324468, 5752.28096487939, 4404.383386325917, 4414.713043652152, 4440.977795111004, 4445.799939002753, 4450.888727781831, 3975.5030621172355, 3995.3607422812793, 4013.7591744495426, 4046.069404037088, 4070.9592904070582, 5448.427915068861, 5458.153986132156, 5460.34475862891, 5462.344518657707, 5463.153211252183, 5596.776128954796, 5670.801521946794, 5782.219400380979, 5790.855228619318, 5807.796727114531, 5357.544608708304, 5388.164834450667, 5405.081136206854, 5442.102053161263, 5458.4541545845095, 4971.751412429364, 5014.2979982802435, 5018.222175562793, 5055.570276526463, 5073.264376665363, 5952.166696662471, 5963.5825492216, 5966.552508561788, 5969.52243820502, 5978.611390259619, 5593.860153496195, 5663.292088488939, 5672.376038635664, 5691.8292451226525, 5828.562857785768, 5944.375840536682, 6008.339082700987, 6013.789517367046, 6022.849428764316, 6025.487833534199, 5639.295088113986, 5647.858803529944, 5650.152477128464, 5655.179998900054, 5659.292588426447, 5659.151127330933, 5766.0, 5771.451712087345, 5772.451617096369, 5788.189653448605, 5435.347758269033, 5488.17677348401, 5517.282753242052, 5531.363893152178, 5561.749721262472, 5542.63972841764, 5543.9168412474655, 5545.112781954868, 5548.0845660465575, 5607.130894711327, 5520.723963801714, 5527.44725527444, 5538.141588053858, 5539.667619942817, 5540.556755459473, 5409.323834520685, 5518.255035570147, 5602.047651899105, 5636.408177141341, 5641.605087643826, 5482.369527504388, 5527.723613819373, 5539.362973257966, 5565.332160140809, 5588.273524441796], "value": 5282.991941736154, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.201850344755, 596.153462083841, 617.7405489694328, 621.8619925536268, 624.33508313646, 32182.0, 43378.0, 43398.0, 43428.78285608567, 43685.99999999996, 44698.55301446984, 45116.3232551512, 45140.548594514046, 45205.54794452054, 45518.31722524165, 8142.267195952363, 8973.282137429007, 9120.361574689774, 9131.817363652723, 9132.634694612207, 8096.068952070528, 10676.733081672981, 10913.781724365508, 10919.945400272987, 11278.15413843961, 10709.464526773669, 10743.355398676105, 10747.83878241827, 10749.892501075006, 10753.51609177589, 10942.288751231185, 11017.504212310385, 11027.17296202788, 11030.338179709242, 11031.61389351377, 10756.892431075667, 10820.891791082146, 10834.620788272452, 10839.83740243897, 10839.891601083968, 43141.0, 43450.782746086064, 43562.0, 43636.78181609072, 44033.55966440326, 3334.7832390894514, 3367.36020156172, 3538.0, 3621.167131559756, 3805.140312069117, 31243.0, 31694.683053169403, 32351.51472727911, 32392.514112288336, 32520.674793252, 4208.362849075613, 4313.266744653416, 4326.286162783137, 4500.977500087064, 4532.614727748145, 351527.0, 351952.0, 352419.99999999744, 352431.0, 352465.0, 56021.71989140028, 56336.71831640816, 56377.0, 56385.0, 56388.43611563832, 58093.70953145207, 58245.417545824, 58560.70719646374, 59293.40706592965, 59340.70329648324, 14569.344379502947, 14737.263136843116, 14745.92627036858, 14752.409903603735, 14753.114813111033, 10190.43952582615, 10496.160307175407, 11302.491387887565, 11308.208425410143, 11580.420978951019, 15139.54581362561, 15465.690686186213, 15475.458358957383, 15582.532524024298, 15858.286377113058, 5977.581569290195, 5978.940210597925, 6029.246344206974, 6089.130901341085, 6136.355682653347, 935.1863878425813, 1008.369768894441, 1084.295208114716, 1114.9665510034713, 1127.1039523578775, 31164.220894477818, 31252.0, 31303.686963130076, 31376.686233137378, 31477.213069673442, 1042.7653777899911, 1097.4512743628186, 1110.3781882146025, 1117.7373317270435, 1120.966371008871, 15876.682466350609, 16272.43046493367, 16641.583960401087, 16667.749983750255, 16955.237014334383, 538958.0520973935, 543188.0, 543374.0, 543426.0, 544212.0, 55968.16047759287, 56063.0, 56063.159052614246, 56135.0, 56139.43860561424, 1158.5713286084203, 1228.0421271408138, 1266.949322027127, 1322.6693326668333, 1334.099482849073, 28010.85994570014, 31923.201919952186, 32291.0, 32356.0, 32819.34361312808, 48108.518914810404, 48529.75735121302, 48660.5133948656, 48680.5131948676, 48736.75631621819, 399121.0, 399246.0, 399558.0, 400662.0, 401296.0, 27387.452250955266, 27889.44221115607, 28296.575551367157, 29174.41651167007, 39917.600823991386, 46099.76950115362, 46317.0, 46424.0, 46616.76691616656, 47041.05917881692, 39083.0, 39431.60568394279, 39541.0, 40491.39262911, 40891.1821763569, 38504.91960643198, 38662.0, 38689.0, 39613.60386396215, 40896.59103408928, 39494.60505394909, 39743.0, 40195.1960960785, 40661.79669101635, 40753.38869916894, 32184.83907580447, 35856.46215306825, 36024.639753602125, 36634.63365366419, 36685.63314366822, 26949.86525067362, 27101.86449067742, 27446.725532744418, 27512.58851887158, 27591.31021724473], "value": 19937.861486076163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.5668033380446, 374.23469005882964, 383.4152916801877, 390.88859674992625, 411.04022108376955, 14389.42442302308, 18082.819171808278, 18582.907085464587, 19075.236990520396, 20395.388138355873, 17503.299868005295, 19629.50926226845, 19704.90147549264, 19865.801341986575, 19875.0, 5508.228847961289, 5779.82660520183, 5784.0, 5785.1033089870925, 5789.102689083199, 5654.575906806986, 5695.8576035599235, 5733.569982251327, 5962.463378295953, 5999.460048595647, 6066.150738896536, 6069.423404776539, 6071.089336599523, 6071.4232147946095, 6072.666003369813, 5897.616654917417, 5918.289805223358, 6030.7889223876955, 6037.154798328237, 6037.275526936795, 5080.745962701887, 5838.591298609099, 5857.648541087548, 5857.970710146422, 5861.325947516048, 13451.529196478075, 14299.49951751694, 14307.642308942255, 14325.283735813271, 16845.494635160965, 2168.1219106261988, 2258.367657056027, 2584.689837219527, 2622.2002289301754, 2631.8552479613613, 9999.500024998793, 10000.59997600095, 10290.639827606074, 10529.157667386591, 10652.786944261072, 1778.457570441015, 1842.8157184281465, 1855.5732181598173, 1870.4295189967054, 1899.3542195653406, 82266.0, 83769.58115209384, 83917.58041209816, 84739.15260847435, 87752.56123719341, 10729.83905241422, 10978.286411383235, 11048.668539943814, 11182.0, 11187.832182517268, 15459.845401545841, 15477.5356739298, 15484.148371839658, 15497.14765687898, 15526.0, 7460.962695186489, 7603.923960760432, 7626.771196863992, 7850.646720897574, 7915.802104947423, 7083.220845706968, 7210.242924492853, 7335.4131669466315, 7440.2931721486375, 7448.664810083559, 4523.7285762854335, 4722.881927951828, 4739.099571081483, 4805.6155507559315, 4879.609631229493, 1908.5324095596668, 1929.8938558379423, 1968.3602829080605, 2012.2252932621047, 2085.8748475091543, 875.6803766625263, 912.4890061565412, 940.8965013848472, 968.5060619084318, 992.5335092506655, 18058.548536286435, 18887.527811804815, 18934.242630294633, 19114.23543058262, 19609.117589708498, 917.8210249001514, 935.5789894547481, 942.8397172480558, 986.5730303453441, 988.6342053440274, 10266.864713446863, 10515.211359148094, 10608.840867386996, 10688.465576721133, 10777.676669699922, 380301.0, 472387.0, 481190.0, 491461.0, 496192.0, 65918.0, 92839.5358023219, 94435.52782236045, 98867.0, 102206.0, 992.93545919515, 1029.2280789407944, 1070.9571617135384, 1076.1175835814713, 1078.2021304234966, 16546.255418505956, 16575.41986030483, 17317.56706082358, 17700.29198832032, 17967.640647186723, 41985.37021944612, 42406.36390454084, 43542.16975896557, 44377.77811110924, 44528.332075018254, 57230.42769572251, 57297.0, 57395.426045739005, 57595.0, 57690.711546442, 8332.333413326798, 8333.0, 8496.745097647081, 8833.602487887933, 8839.20447159733, 12614.810777838156, 12898.548550801052, 12926.159799613371, 12969.351532423152, 13066.738665226452, 10800.297980631234, 10824.56701731922, 11169.664910052712, 11292.830607541058, 11300.152488563555, 7334.559926404433, 11189.944050279697, 11479.483423246142, 11635.360055197045, 11697.06423486102, 11329.490172942402, 11449.313041217554, 11663.842189195026, 11669.416529173337, 11809.409529523662, 7510.098788145458, 7765.689372425039, 7848.960755196187, 8113.7565873023905, 8637.784055398666, 10900.563977440814, 11050.723731906766, 11144.387058711525, 11172.49723762449, 11504.53981840717], "value": 8996.283462582642, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.291807014563, 1505.5709122899973, 1624.3421414327195, 1751.6934536456117, 1781.1984606926885, 8077.515349079059, 8415.116412776662, 8811.251043661288, 9506.52467376631, 9508.334416590833, 8773.868391974125, 9108.726738197847, 9144.679936202234, 9377.859332110007, 9384.296177786659, 2359.079958816063, 2375.928722138339, 2385.105585405473, 2396.341006223294, 2399.520095980802, 2083.5832833433296, 2156.1159924430985, 2316.791488766019, 2390.4143484846236, 2408.7350391456926, 2357.0689577616918, 2425.0542288507495, 2428.8421252618614, 2429.331933718224, 2435.8782060896974, 2292.2435596253194, 2349.494858605408, 2360.221127028077, 2381.8213633977434, 2385.2486466763003, 2315.9652605210936, 2321.721393432782, 2352.588297048027, 2366.538524987628, 2375.0618505690154, 9238.445693258358, 9304.162625363682, 9361.672341468016, 9361.672341468084, 9389.108034736757, 5409.783608655649, 5537.335519737658, 5552.278203833516, 5562.888742225133, 5571.8328450146155, 3472.2881809229048, 3646.1613828819254, 3705.555333359987, 3750.4186851038135, 3762.7366084374103, 1117.2067831839404, 1170.1867202294409, 1203.205884116479, 1213.3023511480933, 1213.4478812140544, 12795.296258705768, 12879.356032198446, 13000.414981325863, 13007.414666340037, 13007.86992130076, 4741.857744267678, 4755.358026666356, 4809.519048095162, 4859.465458799529, 4970.453250142481, 11011.28426652265, 11027.0, 11039.448027598748, 11042.116630669527, 11061.778764424667, 5482.205080263339, 5485.122380419114, 5488.259085023471, 5489.313835770528, 5495.203195536625, 4937.802487900443, 5007.3240112584335, 5017.874553136201, 5026.597872170218, 5055.595552355802, 3973.642372186517, 4000.27994960904, 4073.796310184538, 4097.795110244476, 4099.200655872076, 1184.5676328140166, 1229.164168365502, 1248.6066888929959, 1294.152330223705, 1321.6167311479755, 925.2505470568726, 937.3355442801675, 939.8026414452904, 941.9058094190664, 980.2843923935567, 5787.479126878601, 5948.940510594925, 5972.104184372379, 6024.939750602438, 6247.468965137923, 872.7556284240422, 920.204023519664, 926.6525053105086, 964.8408012677829, 964.9469279189572, 4015.3336365408027, 4041.7979101045416, 4047.534533528623, 4063.3904914262507, 4090.406891000788, 11151.944240278908, 11564.248323858923, 11567.132465065153, 11614.825777613343, 11618.186726929034, 11471.311721296583, 11478.713032174262, 11509.251898626562, 11524.942375288238, 11540.365279909518, 8299.29455996247, 8393.958030209931, 8543.530105844115, 8550.657973680984, 8564.443311184628, 5748.195252664714, 5853.94146058551, 6047.09293605945, 6116.296625887901, 6225.097360882737, 10292.897071029194, 10562.683119506428, 10568.313059651098, 10639.8936010642, 10642.84035739449, 10828.187885908746, 10877.238593298393, 10883.183761217782, 10917.563297468012, 10921.726956826144, 8156.0620528639965, 8199.303059240032, 8199.467034642728, 8218.671253150047, 8230.753077407688, 8588.441751286146, 8824.0, 8943.284537236876, 8950.597223124845, 8963.462192268486, 7927.801804954922, 7984.121746607984, 8115.188481151838, 8144.67421303165, 8364.790880228044, 7842.686292548234, 7910.9604451977375, 8058.516489010678, 8074.515529068275, 8105.148959359182, 7006.9649651751415, 7089.255628159175, 7110.14678238594, 7115.217326094022, 7120.0387947626405, 5314.813981510629, 5383.138697808488, 5409.269748584048, 5482.342118945592, 5586.095230480047, 5388.811391601275, 5427.24018637399, 5447.373552041566, 5461.399246082849, 5587.608867379245], "value": 4800.263979265819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9030395729303, 320.2586013379028, 329.3939151960393, 336.12271970157883, 336.9460886258199, 5150.33045704058, 5299.78105035842, 5318.282031925689, 5395.541378982786, 5411.89176216476, 5185.0, 5306.416294207634, 5321.574274058075, 5323.402979106272, 5338.439463856297, 4174.853880114197, 4205.915881682372, 4219.092895027568, 4225.408442817992, 4231.978840105795, 4137.586241375853, 4151.005228479071, 4204.66362690984, 4227.323628219486, 4256.2764330063965, 4152.647025002879, 4167.708260421772, 4187.434696315989, 4195.727277726954, 4212.1575684863, 4178.477690288714, 4188.057687020427, 4194.6853985951175, 4209.494860616715, 4221.493420789525, 3745.2509498100217, 3756.098536351256, 3762.755420897633, 3771.264603402338, 3776.3195378056776, 5013.072581572421, 5119.667221630582, 5189.143791274435, 5206.739663016872, 5229.1633338666015, 4741.834035808764, 4768.189407800647, 4810.7835147418455, 4812.614990800727, 4825.541573550507, 5382.515573598395, 5536.4186760390385, 5545.861353466155, 5591.384947655754, 5597.216389705403, 4060.3300455425115, 4076.8165432555606, 4078.4290199371817, 4089.8364065437645, 4116.341385378325, 5723.570732195102, 5752.597318187729, 5759.308882934033, 5767.509761670263, 5784.537237021028, 4208.347706105558, 4208.36874468826, 4208.579142085767, 4219.472565929259, 4245.957540424556, 4118.299889018874, 4257.233248202024, 4258.957410425918, 4261.10516791471, 4283.593058659422, 4793.209120495149, 4834.758262086882, 4844.176489996709, 4849.957259189221, 4860.513948605182, 5589.804356847572, 5599.748011339418, 5609.523190528851, 5631.436856314336, 5696.401877802854, 1404.8946329025364, 1461.3277892169722, 1467.8385377608454, 1468.9412423503154, 1476.859698328657, 925.8379783537989, 941.5621735892843, 942.0, 951.4101257220567, 954.9570269337896, 4818.349522814376, 4833.540813622701, 4834.589059929875, 4844.491328410466, 4857.80568777252, 5037.312500312363, 5061.215511595708, 5066.82266120684, 5130.48695130484, 5157.974210128926, 4872.756362181947, 4879.414470263591, 4887.951120488749, 4937.8271760488215, 5195.506426889439, 3000.234940090263, 3039.0, 3043.7412819910555, 3046.1875184265327, 3055.4958431858495, 5953.0, 5959.970200148971, 5962.0, 5964.970175149097, 5972.790952316648, 5680.204771332017, 5822.359540450547, 5854.356020837705, 5872.11918212263, 5901.557383196277, 5795.768169273266, 5884.823455296348, 5910.911336329958, 5931.347551769388, 5944.6730429826775, 5609.419666953084, 5673.744681489426, 5700.315962084576, 5737.397573254748, 5767.481836080072, 5632.5775566831835, 5665.773369065191, 5673.347565030074, 5689.8862022758485, 5699.287589051369, 5943.465088142088, 5953.553483488669, 5958.731857066356, 6008.819735407945, 6030.6080104793045, 4089.4070359798257, 4120.093579412524, 4126.216018956388, 4127.29835927899, 4133.8503977931905, 5656.519195868397, 5721.771129154788, 5768.192453056659, 5772.076467765138, 5791.131330300489, 5626.409227031103, 5641.971790141023, 5643.689597072201, 5644.66132032063, 5659.745311460912, 5387.2727181831515, 5560.805371811967, 5584.766093562607, 5618.69097199658, 5619.185218143264, 5577.414371490935, 5580.581456390868, 5589.301337332833, 5590.468905454138, 5614.157876318585, 5448.945510544844, 5601.243832082617, 5663.688497132697, 5712.285964254468, 5717.742701578522, 5400.729963501888, 5400.83797486076, 5416.322959630046, 5437.619366644297, 5443.265159203615], "value": 4253.009251047412, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.4520341785563, 669.5079116849116, 675.4765057080765, 759.3811043999141, 760.8554374668814, 15222.923885380571, 16562.66874662506, 16586.336546538125, 16590.7511387329, 16604.750928736063, 14783.482578109768, 14879.702405951875, 14897.180655063967, 14940.925295373509, 14968.027078239935, 777.630625452911, 800.9439339246255, 803.562058678019, 803.907550631676, 804.0592506767067, 787.708547837301, 788.846174995876, 789.5223389849144, 789.8301865099003, 790.119017295714, 834.4742812028413, 834.7537476444434, 835.3776436554775, 836.6318819719335, 837.1084794693662, 829.3945419843548, 829.8132920093021, 829.8589239829213, 829.9543525106117, 830.0205757206494, 613.9416755408229, 614.008376471999, 614.4991831657185, 614.8155553333982, 614.846288427893, 13672.863271367358, 13947.511837085754, 14037.368318425593, 14263.928680356532, 14271.928640356835, 12555.0, 12667.683307917376, 12669.619911402673, 12776.552820651232, 12798.680032999157, 10675.0, 10846.349219046882, 10880.564777408894, 10916.0, 11082.445877706163, 3635.5273814404222, 3641.9453708194396, 3642.526471558707, 3698.1863989922176, 3762.3792074307707, 64063.0, 64993.3500664992, 65067.34932650708, 72810.0, 73590.26409735941, 9988.500574971222, 10028.0, 10101.797964040677, 10132.138768204784, 10748.247622666495, 19836.305729299405, 19856.90071549633, 19869.503262418555, 19893.0, 19943.102560384817, 6485.967570162119, 6629.105070815378, 8181.550014749127, 8348.081711011784, 8705.0, 3770.5098337215986, 4083.89790255246, 4280.636145927569, 4628.352030715702, 4639.675222734376, 3643.544556930384, 3762.228743107711, 3779.4141908004303, 3785.7917814519915, 3786.091338078841, 632.193952710298, 645.5094128462403, 647.391452035095, 647.870425914819, 652.0642877470844, 651.8663673946829, 696.5263620737946, 720.2318308552595, 764.9196834332315, 788.0740130346934, 9526.476043817656, 10213.08082272599, 10220.591176353011, 10270.897291027144, 10532.210084243712, 621.1056079245872, 685.9279775623488, 696.8292768271806, 701.7368486817444, 751.1511991449627, 4765.510176813745, 4766.593854812769, 4831.154547954094, 4858.0, 4897.730624815669, 105906.0, 111977.0, 113219.0, 116542.0, 119062.0, 101268.0, 101777.0, 105532.47233763935, 106710.0, 107069.0, 56528.0, 57328.71335643295, 86171.56914215515, 87261.56369218114, 88425.0, 9214.953925230599, 9233.815323693623, 9252.306077044113, 9255.67605133844, 9449.858252126087, 52860.0, 54610.453895462124, 54625.36123916289, 54946.0, 56518.71740641435, 75821.6208918974, 75899.0, 77920.493577788, 80315.0, 80542.0, 11342.60300889465, 11429.885701142883, 11458.484368203284, 11608.825867611824, 11768.52925882955, 12782.0, 12893.881553078863, 13005.414756335798, 13304.467821287428, 13534.0, 11381.829272561085, 11772.234804737665, 11872.584459543874, 12341.814872776737, 12379.504819807107, 12063.21589096706, 12284.570040048555, 12352.197107188003, 12375.814362784386, 12907.806382904077, 11502.82745758831, 11738.0, 11769.588064418047, 12344.259344439362, 12372.4432400544, 9663.613455461702, 9799.23613749532, 9943.30396872241, 9954.601815927283, 10106.0, 9775.462349570842, 10761.059116869732, 10784.784304313713, 10793.730156746144, 10965.56137754481], "value": 7237.251828413387, "unit": "score"}], "name": "dromaeo_css", "value": 7206.095357600813, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 109.0, 109.0, 111.0, 111.0, 111.0, 110.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 122.0, 155.0, 124.0, 119.0, 118.0, 119.0, 163.0, 125.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 162.0, 163.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 113.0, 76.0, 76.0, 75.0, 75.0, 118.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 83.0, 82.0, 82.0, 101.0, 82.0, 82.0, 114.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 54.0, 49.0, 51.0, 51.0, 52.0, 53.0, 52.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 78.0, 82.0, 88.0, 79.0, 78.0, 83.0, 78.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 131.0, 123.0, 122.0, 125.0, 121.0, 132.0, 126.0, 176.0, 122.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 167.0, 159.0, 162.0, 167.0, 161.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 63.0, 64.0, 66.0, 65.0, 66.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1486.1000000000001, "alertThreshold": 2.0}]} 18:46:28 INFO - Return code: 0 18:46:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:46:28 INFO - # TBPL SUCCESS # 18:46:28 INFO - Running post-action listener: _resource_record_post_action 18:46:28 INFO - [mozharness: 2016-09-29 01:46:28.726206Z] Finished run-tests step (success) 18:46:28 INFO - Running post-run listener: _resource_record_post_run 18:46:28 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 394608640; Read time: 0; Write time: 366080 18:46:28 INFO - TinderboxPrint: CPU usage
13.1% 18:46:28 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:46:28 INFO - TinderboxPrint: I/O write bytes / time
394,608,640 / 366,080 18:46:28 INFO - TinderboxPrint: CPU idle
8,292.5 (86.9%) 18:46:28 INFO - TinderboxPrint: CPU user
1,198.8 (12.6%) 18:46:28 INFO - TinderboxPrint: Swap in / out
0 / 0 18:46:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103112704; Read time: 0; Write time: 76504 18:46:28 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 290340864; Read time: 0; Write time: 289548 18:46:29 INFO - Running post-run listener: _upload_blobber_files 18:46:29 INFO - Blob upload gear active. 18:46:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:46:29 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 18:46:29 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:46:29 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:46:29 INFO - (blobuploader) - INFO - Open directory for files ... 18:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:46:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:34 INFO - (blobuploader) - INFO - Done attempting. 18:46:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:46:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:46:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:34 INFO - (blobuploader) - INFO - Done attempting. 18:46:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:46:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:46:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:35 INFO - (blobuploader) - INFO - Done attempting. 18:46:35 INFO - (blobuploader) - INFO - Iteration through files over. 18:46:35 INFO - Return code: 0 18:46:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:46:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:46:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/630bef5a2183bb594419a6a8727d518ceded439cad86f3fee6af8d85c5f49ad9928bf1e34668a18d54ee73b45291ccad2e40e8655e658503b14d23c5da832e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a35efb76f13cc4aa24cd1c921136151ec7431aa063126cde6aff41266fdfa051221c36543e0c60107da9722ef95a0cc2ed34234b8e3133c2b04f631d95c0a76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f9b5504db6b048c3c9a26d6f0f22d96e2e896acd66d7b1faa421e2872301fa589a46bc199c9235d8ee68b5d1c551b11e4f723eff198a499a4d94dbf0e891c5"} 18:46:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:46:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:46:35 INFO - Contents: 18:46:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/630bef5a2183bb594419a6a8727d518ceded439cad86f3fee6af8d85c5f49ad9928bf1e34668a18d54ee73b45291ccad2e40e8655e658503b14d23c5da832e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a35efb76f13cc4aa24cd1c921136151ec7431aa063126cde6aff41266fdfa051221c36543e0c60107da9722ef95a0cc2ed34234b8e3133c2b04f631d95c0a76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f9b5504db6b048c3c9a26d6f0f22d96e2e896acd66d7b1faa421e2872301fa589a46bc199c9235d8ee68b5d1c551b11e4f723eff198a499a4d94dbf0e891c5"} 18:46:35 INFO - Running post-run listener: copy_logs_to_upload_dir 18:46:35 INFO - Copying logs to upload dir... 18:46:35 INFO - mkdir: /builds/slave/test/build/upload/logs 18:46:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.901864 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-28 18:46:35.628483) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 18:46:35.631629) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/630bef5a2183bb594419a6a8727d518ceded439cad86f3fee6af8d85c5f49ad9928bf1e34668a18d54ee73b45291ccad2e40e8655e658503b14d23c5da832e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a35efb76f13cc4aa24cd1c921136151ec7431aa063126cde6aff41266fdfa051221c36543e0c60107da9722ef95a0cc2ed34234b8e3133c2b04f631d95c0a76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f9b5504db6b048c3c9a26d6f0f22d96e2e896acd66d7b1faa421e2872301fa589a46bc199c9235d8ee68b5d1c551b11e4f723eff198a499a4d94dbf0e891c5"} build_url:https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/BlD0lvjcTP6vyjVirGxrHw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/630bef5a2183bb594419a6a8727d518ceded439cad86f3fee6af8d85c5f49ad9928bf1e34668a18d54ee73b45291ccad2e40e8655e658503b14d23c5da832e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a35efb76f13cc4aa24cd1c921136151ec7431aa063126cde6aff41266fdfa051221c36543e0c60107da9722ef95a0cc2ed34234b8e3133c2b04f631d95c0a76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f9b5504db6b048c3c9a26d6f0f22d96e2e896acd66d7b1faa421e2872301fa589a46bc199c9235d8ee68b5d1c551b11e4f723eff198a499a4d94dbf0e891c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 18:46:35.660327) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:46:35.660904) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475112354.243654-1651462502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:46:35.743307) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 18:46:35.743648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 18:46:35.743985) ========= ========= Total master_lag: 0.15 =========