builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1474994129.28 results: success (0) buildid: 20160927063018 builduid: 79a84203a1b34df09167cc1894e1c7f0 revision: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:29.281945) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:29.282468) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:29.282797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:29.298560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:29.299228) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 09:35:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-09-27 09:35:29 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:29.441303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:29.442062) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017864 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:29.493513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 09:35:29.493882) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca --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 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca --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=9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 09:35:29,741 truncating revision to first 12 chars 2016-09-27 09:35:29,741 Setting DEBUG logging. 2016-09-27 09:35:29,742 attempt 1/10 2016-09-27 09:35:29,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7c1929f35c5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 09:35:30,468 unpacking tar archive at: fx-team-7c1929f35c5d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.053018 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 09:35:30.560349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:30.560737) ========= script_repo_revision: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:30.561186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:30.561518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 09:35:30.571994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-27 09:35:30.572315) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:30 INFO - MultiFileLogger online at 20160927 09:35:30 in /builds/slave/test 09:35:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:35:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:35:30 INFO - {'append_to_log': False, 09:35:30 INFO - 'base_work_dir': '/builds/slave/test', 09:35:30 INFO - 'blob_upload_branch': 'Fx-Team', 09:35:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:35:30 INFO - 'branch': 'Fx-Team', 09:35:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:30 INFO - 'config_files': ('talos/linux_config.py',), 09:35:30 INFO - 'default_actions': ('clobber', 09:35:30 INFO - 'read-buildbot-config', 09:35:30 INFO - 'download-and-extract', 09:35:30 INFO - 'populate-webroot', 09:35:30 INFO - 'create-virtualenv', 09:35:30 INFO - 'install', 09:35:30 INFO - 'run-tests'), 09:35:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:30 INFO - 'download_minidump_stackwalk': True, 09:35:30 INFO - 'download_symbols': 'ondemand', 09:35:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:30 INFO - 'installer_path': 'installer.exe', 09:35:30 INFO - 'log_level': 'info', 09:35:30 INFO - 'log_name': 'talos', 09:35:30 INFO - 'log_to_console': True, 09:35:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:30 INFO - 'opt_config_files': (), 09:35:30 INFO - 'pip_index': False, 09:35:30 INFO - 'sps_profile': False, 09:35:30 INFO - 'sps_profile_interval': 0, 09:35:30 INFO - 'suite': 'dromaeojs-e10s', 09:35:30 INFO - 'system_bits': '32', 09:35:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:30 INFO - 'title': 'talos-linux64-ix-022', 09:35:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:30 INFO - 'use_talos_json': True, 09:35:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:35:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:30 INFO - 'work_dir': 'build'} 09:35:30 INFO - [mozharness: 2016-09-27 16:35:30.920596Z] Running clobber step. 09:35:30 INFO - Running pre-action listener: _resource_record_pre_action 09:35:30 INFO - Running main action method: clobber 09:35:30 INFO - rmtree: /builds/slave/test/build 09:35:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:35:31 INFO - Running post-action listener: _resource_record_post_action 09:35:31 INFO - [mozharness: 2016-09-27 16:35:31.371139Z] Finished clobber step (success) 09:35:31 INFO - [mozharness: 2016-09-27 16:35:31.371238Z] Running read-buildbot-config step. 09:35:31 INFO - Running pre-action listener: _resource_record_pre_action 09:35:31 INFO - Running main action method: read_buildbot_config 09:35:31 INFO - Using buildbot properties: 09:35:31 INFO - { 09:35:31 INFO - "project": "", 09:35:31 INFO - "product": "firefox", 09:35:31 INFO - "script_repo_revision": "production", 09:35:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:35:31 INFO - "repository": "", 09:35:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:35:31 INFO - "buildid": "20160927063018", 09:35:31 INFO - "pgo_build": "True", 09:35:31 INFO - "basedir": "/builds/slave/test", 09:35:31 INFO - "buildnumber": 803, 09:35:31 INFO - "slavename": "talos-linux64-ix-022", 09:35:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:35:31 INFO - "platform": "ubuntu64_hw", 09:35:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:35:31 INFO - "branch": "fx-team", 09:35:31 INFO - "repo_path": "integration/fx-team", 09:35:31 INFO - "revision": "7c1929f35c5d11b0b921ebd03c197bdb5afbeaca", 09:35:31 INFO - "stage_platform": "linux64-pgo", 09:35:31 INFO - "builduid": "79a84203a1b34df09167cc1894e1c7f0", 09:35:31 INFO - "slavebuilddir": "test" 09:35:31 INFO - } 09:35:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:35:31 INFO - Running post-action listener: _resource_record_post_action 09:35:31 INFO - [mozharness: 2016-09-27 16:35:31.373649Z] Finished read-buildbot-config step (success) 09:35:31 INFO - [mozharness: 2016-09-27 16:35:31.373737Z] Running download-and-extract step. 09:35:31 INFO - Running pre-action listener: _resource_record_pre_action 09:35:31 INFO - Running main action method: download_and_extract 09:35:31 INFO - mkdir: /builds/slave/test/build/tests 09:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:31 INFO - trying https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:35:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/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 09:35:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/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 09:35:31 INFO - Downloaded 1361 bytes. 09:35:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:35:31 INFO - Using the following test package requirements: 09:35:31 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:35:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:35:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:31 INFO - u'jsshell-linux-x86_64.zip'], 09:35:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:35:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:35:31 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:35:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:35:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:35:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:35:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:35:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:35:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:35:32 INFO - Expected file size: 21984008 09:35:36 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 09:35:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:35:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:35:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:35:37 INFO - Expected file size: 21984008 09:35:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:35:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:35:42 INFO - Expected file size: 14414062 09:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:43 INFO - trying https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/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 09:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/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 09:35:44 INFO - Downloaded 59725255 bytes. 09:35:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:35:44 INFO - mkdir: /builds/slave/test/properties 09:35:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:35:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:35:44 INFO - Contents: 09:35:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:35:45 INFO - Running post-action listener: _resource_record_post_action 09:35:45 INFO - Running post-action listener: set_extra_try_arguments 09:35:45 INFO - [mozharness: 2016-09-27 16:35:45.205988Z] Finished download-and-extract step (success) 09:35:45 INFO - [mozharness: 2016-09-27 16:35:45.206214Z] Running populate-webroot step. 09:35:45 INFO - Running pre-action listener: _resource_record_pre_action 09:35:45 INFO - Running main action method: populate_webroot 09:35:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:45 INFO - '--tppagecycles', 09:35:45 INFO - '7'], 09:35:45 INFO - 'tests': ['tsvgm']}}, 09:35:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:35:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:35:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:35:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:45 INFO - 'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:45 INFO - 'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['damp', 'tps']}, 09:35:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:45 INFO - 'tests': ['damp', 'tps']}, 09:35:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['dromaeo_dom']}, 09:35:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:35:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['basic_compositor_video']}, 09:35:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:35:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['a11yr', 09:35:45 INFO - 'ts_paint', 09:35:45 INFO - 'tpaint', 09:35:45 INFO - 'sessionrestore', 09:35:45 INFO - 'sessionrestore_no_auto_restore', 09:35:45 INFO - 'tabpaint']}, 09:35:45 INFO - 'other-e10s': {'tests': ['a11yr', 09:35:45 INFO - 'ts_paint', 09:35:45 INFO - 'tpaint', 09:35:45 INFO - 'sessionrestore', 09:35:45 INFO - 'sessionrestore_no_auto_restore', 09:35:45 INFO - 'tabpaint']}, 09:35:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:35:45 INFO - 'ts_paint', 09:35:45 INFO - 'tpaint', 09:35:45 INFO - 'sessionrestore', 09:35:45 INFO - 'sessionrestore_no_auto_restore', 09:35:45 INFO - 'tabpaint']}, 09:35:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:35:45 INFO - 'ts_paint', 09:35:45 INFO - 'tpaint', 09:35:45 INFO - 'sessionrestore', 09:35:45 INFO - 'sessionrestore_no_auto_restore', 09:35:45 INFO - 'tabpaint']}, 09:35:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['a11yr', 09:35:45 INFO - 'ts_paint', 09:35:45 INFO - 'tpaint', 09:35:45 INFO - 'sessionrestore', 09:35:45 INFO - 'sessionrestore_no_auto_restore', 09:35:45 INFO - 'tabpaint']}, 09:35:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['a11yr', 09:35:45 INFO - 'ts_paint', 09:35:45 INFO - 'tpaint', 09:35:45 INFO - 'sessionrestore', 09:35:45 INFO - 'sessionrestore_no_auto_restore', 09:35:45 INFO - 'tabpaint']}, 09:35:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['tsvgx', 09:35:45 INFO - 'tsvgr_opacity', 09:35:45 INFO - 'tart', 09:35:45 INFO - 'tscrollx', 09:35:45 INFO - 'cart']}, 09:35:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:35:45 INFO - 'tsvgr_opacity', 09:35:45 INFO - 'tart', 09:35:45 INFO - 'tscrollx', 09:35:45 INFO - 'cart']}, 09:35:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:45 INFO - 'talos_options': ['--disable-e10s'], 09:35:45 INFO - 'tests': ['tp5o']}, 09:35:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:45 INFO - 'tests': ['tp5o']}, 09:35:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:45 INFO - 'talos_options': ['--disable-e10s', 09:35:45 INFO - '--xperf_path', 09:35:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:45 INFO - 'tests': ['tp5n']}, 09:35:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:45 INFO - 'talos_options': ['--xperf_path', 09:35:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:45 INFO - 'tests': ['tp5n']}}, 09:35:45 INFO - 'talos.zip': {'path': '', 09:35:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:45 INFO - Running post-action listener: _resource_record_post_action 09:35:45 INFO - [mozharness: 2016-09-27 16:35:45.228745Z] Finished populate-webroot step (success) 09:35:45 INFO - [mozharness: 2016-09-27 16:35:45.228834Z] Running create-virtualenv step. 09:35:45 INFO - Running pre-action listener: _resource_record_pre_action 09:35:45 INFO - Running main action method: create_virtualenv 09:35:45 INFO - Creating virtualenv /builds/slave/test/build/venv 09:35:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:35:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:35:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:45 INFO - Using real prefix '/usr' 09:35:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:35:45 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:47 INFO - Installing pip.................done. 09:35:47 INFO - Return code: 0 09:35:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:35:48 INFO - Reading from file tmpfile_stdout 09:35:48 INFO - Output received: 09:35:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:35:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:48 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:35:48 INFO - Using env: {'DISPLAY': ':0', 09:35:48 INFO - 'HOME': '/home/cltbld', 09:35:48 INFO - 'LANG': 'en_US.UTF-8', 09:35:48 INFO - 'LANGUAGE': 'en_US:en', 09:35:48 INFO - 'LOGNAME': 'cltbld', 09:35:48 INFO - 'MAIL': '/var/mail/cltbld', 09:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:48 INFO - 'MOZ_NO_REMOTE': '1', 09:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:48 INFO - 'NO_EM_RESTART': '1', 09:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:48 INFO - 'PWD': '/builds/slave/test', 09:35:48 INFO - 'SHELL': '/bin/bash', 09:35:48 INFO - 'SHLVL': '1', 09:35:48 INFO - 'TERM': 'linux', 09:35:48 INFO - 'TMOUT': '86400', 09:35:48 INFO - 'USER': 'cltbld', 09:35:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:48 INFO - '_': '/tools/buildbot/bin/python'} 09:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:35:48 INFO - Cleaning up... 09:35:48 INFO - Return code: 0 09:35:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:48 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:35:48 INFO - Using env: {'DISPLAY': ':0', 09:35:48 INFO - 'HOME': '/home/cltbld', 09:35:48 INFO - 'LANG': 'en_US.UTF-8', 09:35:48 INFO - 'LANGUAGE': 'en_US:en', 09:35:48 INFO - 'LOGNAME': 'cltbld', 09:35:48 INFO - 'MAIL': '/var/mail/cltbld', 09:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:48 INFO - 'MOZ_NO_REMOTE': '1', 09:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:48 INFO - 'NO_EM_RESTART': '1', 09:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:48 INFO - 'PWD': '/builds/slave/test', 09:35:48 INFO - 'SHELL': '/bin/bash', 09:35:48 INFO - 'SHLVL': '1', 09:35:48 INFO - 'TERM': 'linux', 09:35:48 INFO - 'TMOUT': '86400', 09:35:48 INFO - 'USER': 'cltbld', 09:35:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:48 INFO - '_': '/tools/buildbot/bin/python'} 09:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:48 INFO - Downloading/unpacking psutil>=3.1.1 09:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:50 INFO - Installing collected packages: psutil 09:35:50 INFO - Running setup.py install for psutil 09:35:50 INFO - building 'psutil._psutil_linux' extension 09:35:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:35:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:35:50 INFO - building 'psutil._psutil_posix' extension 09:35:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:35:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:35:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:50 INFO - Successfully installed psutil 09:35:50 INFO - Cleaning up... 09:35:51 INFO - Return code: 0 09:35:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:51 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:35:51 INFO - Using env: {'DISPLAY': ':0', 09:35:51 INFO - 'HOME': '/home/cltbld', 09:35:51 INFO - 'LANG': 'en_US.UTF-8', 09:35:51 INFO - 'LANGUAGE': 'en_US:en', 09:35:51 INFO - 'LOGNAME': 'cltbld', 09:35:51 INFO - 'MAIL': '/var/mail/cltbld', 09:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:51 INFO - 'MOZ_NO_REMOTE': '1', 09:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:51 INFO - 'NO_EM_RESTART': '1', 09:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:51 INFO - 'PWD': '/builds/slave/test', 09:35:51 INFO - 'SHELL': '/bin/bash', 09:35:51 INFO - 'SHLVL': '1', 09:35:51 INFO - 'TERM': 'linux', 09:35:51 INFO - 'TMOUT': '86400', 09:35:51 INFO - 'USER': 'cltbld', 09:35:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:51 INFO - '_': '/tools/buildbot/bin/python'} 09:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:35:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:35:53 INFO - Installing collected packages: mozsystemmonitor 09:35:53 INFO - Running setup.py install for mozsystemmonitor 09:35:53 INFO - Successfully installed mozsystemmonitor 09:35:53 INFO - Cleaning up... 09:35:53 INFO - Return code: 0 09:35:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:53 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:35:53 INFO - Using env: {'DISPLAY': ':0', 09:35:53 INFO - 'HOME': '/home/cltbld', 09:35:53 INFO - 'LANG': 'en_US.UTF-8', 09:35:53 INFO - 'LANGUAGE': 'en_US:en', 09:35:53 INFO - 'LOGNAME': 'cltbld', 09:35:53 INFO - 'MAIL': '/var/mail/cltbld', 09:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:53 INFO - 'MOZ_NO_REMOTE': '1', 09:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:53 INFO - 'NO_EM_RESTART': '1', 09:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:53 INFO - 'PWD': '/builds/slave/test', 09:35:53 INFO - 'SHELL': '/bin/bash', 09:35:53 INFO - 'SHLVL': '1', 09:35:53 INFO - 'TERM': 'linux', 09:35:53 INFO - 'TMOUT': '86400', 09:35:53 INFO - 'USER': 'cltbld', 09:35:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:53 INFO - '_': '/tools/buildbot/bin/python'} 09:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:53 INFO - Downloading/unpacking jsonschema==2.5.1 09:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:35:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:35:55 INFO - warning: no files found matching '*.txt' 09:35:55 INFO - no previously-included directories found matching 'build' 09:35:55 INFO - no previously-included directories found matching 'dist' 09:35:55 INFO - no previously-included directories found matching '.git*' 09:35:55 INFO - Installing collected packages: jsonschema, functools32 09:35:55 INFO - Running setup.py install for functools32 09:35:55 INFO - warning: no files found matching '*.txt' 09:35:55 INFO - no previously-included directories found matching 'build' 09:35:55 INFO - no previously-included directories found matching 'dist' 09:35:55 INFO - no previously-included directories found matching '.git*' 09:35:55 INFO - Successfully installed jsonschema functools32 09:35:55 INFO - Cleaning up... 09:35:55 INFO - Return code: 0 09:35:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:35:55 INFO - Using env: {'DISPLAY': ':0', 09:35:55 INFO - 'HOME': '/home/cltbld', 09:35:55 INFO - 'LANG': 'en_US.UTF-8', 09:35:55 INFO - 'LANGUAGE': 'en_US:en', 09:35:55 INFO - 'LOGNAME': 'cltbld', 09:35:55 INFO - 'MAIL': '/var/mail/cltbld', 09:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:55 INFO - 'MOZ_NO_REMOTE': '1', 09:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:55 INFO - 'NO_EM_RESTART': '1', 09:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:55 INFO - 'PWD': '/builds/slave/test', 09:35:55 INFO - 'SHELL': '/bin/bash', 09:35:55 INFO - 'SHLVL': '1', 09:35:55 INFO - 'TERM': 'linux', 09:35:55 INFO - 'TMOUT': '86400', 09:35:55 INFO - 'USER': 'cltbld', 09:35:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:55 INFO - '_': '/tools/buildbot/bin/python'} 09:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:35:56 INFO - Cleaning up... 09:35:56 INFO - Return code: 0 09:35:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:56 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:35:56 INFO - Using env: {'DISPLAY': ':0', 09:35:56 INFO - 'HOME': '/home/cltbld', 09:35:56 INFO - 'LANG': 'en_US.UTF-8', 09:35:56 INFO - 'LANGUAGE': 'en_US:en', 09:35:56 INFO - 'LOGNAME': 'cltbld', 09:35:56 INFO - 'MAIL': '/var/mail/cltbld', 09:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:56 INFO - 'MOZ_NO_REMOTE': '1', 09:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:56 INFO - 'NO_EM_RESTART': '1', 09:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:56 INFO - 'PWD': '/builds/slave/test', 09:35:56 INFO - 'SHELL': '/bin/bash', 09:35:56 INFO - 'SHLVL': '1', 09:35:56 INFO - 'TERM': 'linux', 09:35:56 INFO - 'TMOUT': '86400', 09:35:56 INFO - 'USER': 'cltbld', 09:35:56 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:56 INFO - '_': '/tools/buildbot/bin/python'} 09:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:35:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:35:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:58 INFO - Downloading docopt-0.6.1.tar.gz 09:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:35:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:35:59 INFO - Running setup.py install for blobuploader 09:35:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:35:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:35:59 INFO - Running setup.py install for requests 09:35:59 INFO - Running setup.py install for docopt 09:35:59 INFO - Successfully installed blobuploader requests docopt 09:35:59 INFO - Cleaning up... 09:35:59 INFO - Return code: 0 09:35:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:59 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:35:59 INFO - Using env: {'DISPLAY': ':0', 09:35:59 INFO - 'HOME': '/home/cltbld', 09:35:59 INFO - 'LANG': 'en_US.UTF-8', 09:35:59 INFO - 'LANGUAGE': 'en_US:en', 09:35:59 INFO - 'LOGNAME': 'cltbld', 09:35:59 INFO - 'MAIL': '/var/mail/cltbld', 09:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:59 INFO - 'MOZ_NO_REMOTE': '1', 09:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:59 INFO - 'NO_EM_RESTART': '1', 09:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:59 INFO - 'PWD': '/builds/slave/test', 09:35:59 INFO - 'SHELL': '/bin/bash', 09:35:59 INFO - 'SHLVL': '1', 09:35:59 INFO - 'TERM': 'linux', 09:35:59 INFO - 'TMOUT': '86400', 09:35:59 INFO - 'USER': 'cltbld', 09:35:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:59 INFO - '_': '/tools/buildbot/bin/python'} 09:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:59 INFO - Running setup.py (path:/tmp/pip-h6leQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:59 INFO - Running setup.py (path:/tmp/pip-h3ST9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:59 INFO - Running setup.py (path:/tmp/pip-0vwn31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:00 INFO - Running setup.py (path:/tmp/pip-Xf0Hmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:00 INFO - Running setup.py (path:/tmp/pip-N5iF0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:00 INFO - Running setup.py (path:/tmp/pip-Eqickt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:00 INFO - Running setup.py (path:/tmp/pip-MBQNaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:00 INFO - Running setup.py (path:/tmp/pip-XIt41t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:00 INFO - Running setup.py (path:/tmp/pip-A5H1lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:00 INFO - Running setup.py (path:/tmp/pip-tCgWhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:00 INFO - Running setup.py (path:/tmp/pip-_EDmgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:00 INFO - Running setup.py (path:/tmp/pip-_RROk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:00 INFO - Running setup.py (path:/tmp/pip-mGQH2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:00 INFO - Running setup.py (path:/tmp/pip-LhJbN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:00 INFO - Running setup.py (path:/tmp/pip-VDCxYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:00 INFO - Running setup.py (path:/tmp/pip-tk60k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:00 INFO - Running setup.py (path:/tmp/pip-8jhguN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:01 INFO - Running setup.py install for manifestparser 09:36:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Running setup.py install for mozcrash 09:36:01 INFO - Running setup.py install for mozdebug 09:36:01 INFO - Running setup.py install for mozdevice 09:36:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Running setup.py install for mozfile 09:36:01 INFO - Running setup.py install for mozhttpd 09:36:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Running setup.py install for mozinfo 09:36:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Running setup.py install for mozInstall 09:36:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:01 INFO - Running setup.py install for mozleak 09:36:01 INFO - Running setup.py install for mozlog 09:36:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:02 INFO - Running setup.py install for moznetwork 09:36:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:02 INFO - Running setup.py install for mozprocess 09:36:02 INFO - Running setup.py install for mozprofile 09:36:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:02 INFO - Running setup.py install for mozrunner 09:36:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:02 INFO - Running setup.py install for mozscreenshot 09:36:02 INFO - Running setup.py install for moztest 09:36:02 INFO - Running setup.py install for mozversion 09:36:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:02 INFO - Cleaning up... 09:36:02 INFO - Return code: 0 09:36:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:02 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:36:02 INFO - Using env: {'DISPLAY': ':0', 09:36:02 INFO - 'HOME': '/home/cltbld', 09:36:02 INFO - 'LANG': 'en_US.UTF-8', 09:36:02 INFO - 'LANGUAGE': 'en_US:en', 09:36:02 INFO - 'LOGNAME': 'cltbld', 09:36:02 INFO - 'MAIL': '/var/mail/cltbld', 09:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:02 INFO - 'MOZ_NO_REMOTE': '1', 09:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:02 INFO - 'NO_EM_RESTART': '1', 09:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:02 INFO - 'PWD': '/builds/slave/test', 09:36:02 INFO - 'SHELL': '/bin/bash', 09:36:02 INFO - 'SHLVL': '1', 09:36:02 INFO - 'TERM': 'linux', 09:36:02 INFO - 'TMOUT': '86400', 09:36:02 INFO - 'USER': 'cltbld', 09:36:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:02 INFO - '_': '/tools/buildbot/bin/python'} 09:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:03 INFO - Running setup.py (path:/tmp/pip-8py85d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:03 INFO - Running setup.py (path:/tmp/pip-Ip7fHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:03 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)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:03 INFO - Running setup.py (path:/tmp/pip-Uc0AF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:03 INFO - Running setup.py (path:/tmp/pip-VKpxim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:03 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)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:03 INFO - Running setup.py (path:/tmp/pip-kimDgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:03 INFO - Running setup.py (path:/tmp/pip-2AvNZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:03 INFO - Running setup.py (path:/tmp/pip-hyCWy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:03 INFO - Running setup.py (path:/tmp/pip-yAzTfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:03 INFO - Running setup.py (path:/tmp/pip-aXjkgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:03 INFO - Running setup.py (path:/tmp/pip-6I2gbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:03 INFO - Running setup.py (path:/tmp/pip-7EGPQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:04 INFO - Running setup.py (path:/tmp/pip-EBB9gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:04 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)) 09:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:04 INFO - Running setup.py (path:/tmp/pip-L4a6n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:04 INFO - Running setup.py (path:/tmp/pip-o84bXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:04 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)) 09:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:04 INFO - Running setup.py (path:/tmp/pip-4nDt8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:04 INFO - Running setup.py (path:/tmp/pip-jZ78Z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:04 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)) 09:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:04 INFO - Running setup.py (path:/tmp/pip-O5zLH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:36:04 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)) 09:36:04 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)) 09:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:36:04 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)) 09:36:04 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)) 09:36:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:06 INFO - Downloading blessings-1.6.tar.gz 09:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:06 INFO - Installing collected packages: blessings 09:36:06 INFO - Running setup.py install for blessings 09:36:06 INFO - Successfully installed blessings 09:36:06 INFO - Cleaning up... 09:36:06 INFO - Return code: 0 09:36:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:06 INFO - Reading from file tmpfile_stdout 09:36:06 INFO - Current package versions: 09:36:06 INFO - argparse == 1.2.1 09:36:06 INFO - blessings == 1.6 09:36:06 INFO - blobuploader == 1.2.4 09:36:06 INFO - docopt == 0.6.1 09:36:06 INFO - functools32 == 3.2.3-2 09:36:06 INFO - jsonschema == 2.5.1 09:36:06 INFO - manifestparser == 1.1 09:36:06 INFO - mozInstall == 1.12 09:36:06 INFO - mozcrash == 0.17 09:36:06 INFO - mozdebug == 0.1 09:36:06 INFO - mozdevice == 0.48 09:36:06 INFO - mozfile == 1.2 09:36:06 INFO - mozhttpd == 0.7 09:36:06 INFO - mozinfo == 0.9 09:36:06 INFO - mozleak == 0.1 09:36:06 INFO - mozlog == 3.4 09:36:06 INFO - moznetwork == 0.27 09:36:06 INFO - mozprocess == 0.23 09:36:06 INFO - mozprofile == 0.28 09:36:06 INFO - mozrunner == 6.12 09:36:06 INFO - mozscreenshot == 0.1 09:36:06 INFO - mozsystemmonitor == 0.3 09:36:06 INFO - moztest == 0.7 09:36:06 INFO - mozversion == 1.4 09:36:06 INFO - psutil == 3.1.1 09:36:06 INFO - requests == 1.2.3 09:36:06 INFO - wsgiref == 0.1.2 09:36:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:36:06 INFO - Using env: {'DISPLAY': ':0', 09:36:06 INFO - 'HOME': '/home/cltbld', 09:36:06 INFO - 'LANG': 'en_US.UTF-8', 09:36:06 INFO - 'LANGUAGE': 'en_US:en', 09:36:06 INFO - 'LOGNAME': 'cltbld', 09:36:06 INFO - 'MAIL': '/var/mail/cltbld', 09:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:06 INFO - 'MOZ_NO_REMOTE': '1', 09:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:06 INFO - 'NO_EM_RESTART': '1', 09:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:06 INFO - 'PWD': '/builds/slave/test', 09:36:06 INFO - 'SHELL': '/bin/bash', 09:36:06 INFO - 'SHLVL': '1', 09:36:06 INFO - 'TERM': 'linux', 09:36:06 INFO - 'TMOUT': '86400', 09:36:06 INFO - 'USER': 'cltbld', 09:36:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:06 INFO - '_': '/tools/buildbot/bin/python'} 09:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:36:06 INFO - Cleaning up... 09:36:06 INFO - Return code: 0 09:36:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 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 0x7fbc7f075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:36:06 INFO - Using env: {'DISPLAY': ':0', 09:36:06 INFO - 'HOME': '/home/cltbld', 09:36:06 INFO - 'LANG': 'en_US.UTF-8', 09:36:06 INFO - 'LANGUAGE': 'en_US:en', 09:36:06 INFO - 'LOGNAME': 'cltbld', 09:36:06 INFO - 'MAIL': '/var/mail/cltbld', 09:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:06 INFO - 'MOZ_NO_REMOTE': '1', 09:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:06 INFO - 'NO_EM_RESTART': '1', 09:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:06 INFO - 'PWD': '/builds/slave/test', 09:36:06 INFO - 'SHELL': '/bin/bash', 09:36:06 INFO - 'SHLVL': '1', 09:36:06 INFO - 'TERM': 'linux', 09:36:06 INFO - 'TMOUT': '86400', 09:36:06 INFO - 'USER': 'cltbld', 09:36:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:06 INFO - '_': '/tools/buildbot/bin/python'} 09:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:36:07 INFO - Cleaning up... 09:36:07 INFO - Return code: 0 09:36:07 INFO - Running post-action listener: _resource_record_post_action 09:36:07 INFO - Running post-action listener: _start_resource_monitoring 09:36:07 INFO - Starting resource monitoring. 09:36:07 INFO - [mozharness: 2016-09-27 16:36:07.147667Z] Finished create-virtualenv step (success) 09:36:07 INFO - [mozharness: 2016-09-27 16:36:07.148138Z] Running install step. 09:36:07 INFO - Running pre-action listener: _resource_record_pre_action 09:36:07 INFO - Running main action method: install 09:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:07 INFO - Reading from file tmpfile_stdout 09:36:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:36:07 INFO - Reading from file tmpfile_stdout 09:36:07 INFO - Output received: 09:36:07 INFO - Usage: mozinstall [options] installer 09:36:07 INFO - Options: 09:36:07 INFO - -h, --help show this help message and exit 09:36:07 INFO - -d DEST, --destination=DEST 09:36:07 INFO - Directory to install application into. [default: 09:36:07 INFO - "/builds/slave/test"] 09:36:07 INFO - --app=APP Application being installed. [default: firefox] 09:36:07 INFO - mkdir: /builds/slave/test/build/application 09:36:07 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'] 09:36:07 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 09:36:24 INFO - Reading from file tmpfile_stdout 09:36:24 INFO - Output received: 09:36:24 INFO - /builds/slave/test/build/application/firefox/firefox 09:36:24 INFO - Running post-action listener: _resource_record_post_action 09:36:24 INFO - [mozharness: 2016-09-27 16:36:24.441980Z] Finished install step (success) 09:36:24 INFO - [mozharness: 2016-09-27 16:36:24.442225Z] Running run-tests step. 09:36:24 INFO - Running pre-action listener: _resource_record_pre_action 09:36:24 INFO - Running main action method: run_tests 09:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:36:24 INFO - Python 2.7.3 09:36:24 INFO - Return code: 0 09:36:24 INFO - grabbing minidump binary from tooltool 09:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:24 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 0x172b790>, '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 0x172c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:36:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:36:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:36:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:36:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:24 INFO - Return code: 0 09:36:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:36:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:36:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:36:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:36:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:36:24 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:36:24 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:36:24 INFO - Using env: {'DISPLAY': ':0', 09:36:24 INFO - 'HOME': '/home/cltbld', 09:36:24 INFO - 'LANG': 'en_US.UTF-8', 09:36:24 INFO - 'LANGUAGE': 'en_US:en', 09:36:24 INFO - 'LOGNAME': 'cltbld', 09:36:24 INFO - 'MAIL': '/var/mail/cltbld', 09:36:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:36:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:24 INFO - 'MOZ_NO_REMOTE': '1', 09:36:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:24 INFO - 'NO_EM_RESTART': '1', 09:36:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:24 INFO - 'PWD': '/builds/slave/test', 09:36:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:36:24 INFO - 'SHELL': '/bin/bash', 09:36:24 INFO - 'SHLVL': '1', 09:36:24 INFO - 'TERM': 'linux', 09:36:24 INFO - 'TMOUT': '86400', 09:36:24 INFO - 'USER': 'cltbld', 09:36:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136', 09:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:24 INFO - '_': '/tools/buildbot/bin/python'} 09:36:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:36:24 INFO - mozversion application_buildid: 20160927063018 09:36:24 INFO - mozversion application_changeset: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca 09:36:24 INFO - mozversion application_display_name: Nightly 09:36:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:24 INFO - mozversion application_name: Firefox 09:36:24 INFO - mozversion application_remotingname: firefox 09:36:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:36:24 INFO - mozversion application_vendor: Mozilla 09:36:24 INFO - mozversion application_version: 52.0a1 09:36:24 INFO - mozversion platform_buildid: 20160927063018 09:36:24 INFO - mozversion platform_changeset: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca 09:36:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:36:24 INFO - mozversion platform_version: 52.0a1 09:36:24 INFO - using testdate: 1474994184 09:36:24 INFO - actual date: 1474994184 09:36:24 INFO - starting webserver on 'localhost:50430' 09:36:24 INFO - SUITE-START | Running 2 tests 09:36:24 INFO - TEST-START | dromaeo_css 09:36:24 INFO - operating with platform_type : linux_ 09:36:24 INFO - Initialising browser for dromaeo_css test... 09:36:24 INFO - TEST-INFO | started process 2790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcxq77i/profile http://localhost:50430/getInfo.html) 09:36:29 INFO - PROCESS | 2790 | __metrics Screen width/height:1600/1200 09:36:29 INFO - PROCESS | 2790 | colorDepth:24 09:36:29 INFO - PROCESS | 2790 | Browser inner width/height: 1024/697 09:36:29 INFO - PROCESS | 2790 | __metrics 09:36:30 ERROR - PROCESS | 2790 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 09:36:31 INFO - TEST-INFO | 2790: exit 0 09:36:31 INFO - Browser initialized. 09:36:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:31 INFO - TEST-INFO | started process 3009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcxq77i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:43 INFO - PROCESS | 3009 | RSS: Main: 184950784 09:36:43 INFO - PROCESS | 3009 | 09:37:32 INFO - PROCESS | 3009 | 1474994252933 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] 09:39:42 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:50430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50430/tests/dromaeo/cssquery-ext.html) 09:39:43 INFO - PROCESS | 3009 | RSS: Main: 197857280 09:39:43 INFO - PROCESS | 3009 | 09:42:46 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:50430/tests/dromaeo/cssquery-ext.html (next: http://localhost:50430/tests/dromaeo/cssquery-jquery.html) 09:42:46 INFO - PROCESS | 3009 | RSS: Main: 196620288 09:42:46 INFO - PROCESS | 3009 | 09:45:48 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:50430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50430/tests/dromaeo/cssquery-mootools.html) 09:45:49 INFO - PROCESS | 3009 | RSS: Main: 198721536 09:45:49 INFO - PROCESS | 3009 | 09:48:51 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:50430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50430/tests/dromaeo/cssquery-prototype.html) 09:48:51 INFO - PROCESS | 3009 | RSS: Main: 195141632 09:48:51 INFO - PROCESS | 3009 | 09:51:54 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:50430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50430/tests/dromaeo/cssquery-yui.html) 09:51:54 INFO - PROCESS | 3009 | RSS: Main: 198701056 09:51:54 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:50430/tests/dromaeo/cssquery-yui.html (next: http://localhost:50430/tests/dromaeo/cssquery-dojo.html) 09:54:57 INFO - PROCESS | 3009 | RSS: Main: 199548928 09:54:57 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | __start_tp_report 09:54:57 INFO - PROCESS | 3009 | _x_x_mozilla_page_load 09:54:57 INFO - PROCESS | 3009 | _x_x_mozilla_page_load_details 09:54:57 INFO - PROCESS | 3009 | |i|pagename|runs| 09:54:57 INFO - PROCESS | 3009 | |0;dojo.html;3071.047975127712;3092.5979622649056;3113.3773245350935;3130.874765009399;3133.4986402175655;5347.331583552056;5377.8117765878205;5442.537384322332;5467.6172667913215;5487.5884308676905;5403.648762830413;5432.239486471887;5438.102713052342;5481.342238931334;5524.640898341605;4855.5872750816225;5004.724740139291;5007.699538027712;5060.84817455477;5078.974605126969;5039.395272567297;5096.541311281984;5103.030424219386;5106.668066575679;5113.616478764089;4813.470518242991;4878.731669758162;4883.804647814083;4910.435299940516;5042.697438153704;4929.975350123263;4931.334269873557;4981.32752078472;5009.44896061433;5023.8492845214705;4893.09477746618;4935.703857768545;4940.876478088041;4952.603791696655;4999.75001249936;5315.335583052119;5349.518543331119;5368.865778355573;5391.164369522691;5443.047466693313;5821.476067153976;5868.794592189295;5871.765129394819;5912.379200183962;5921.437463440966;5905.527557795409;5913.438223368773;5916.822495325104;5926.733297001645;5928.644281343133;5287.682739035593;5324.201369794562;5486.670799751988;5487.039768040577;5493.478119578674;5939.3763654816485;5972.820815375546;5999.280086389661;6002.339742628307;6112.724927378279;5752.482276595127;5764.106563482667;5777.19119323295;5785.218995435646;5789.131630255495;5662.68855212959;5708.914366284509;5817.7963771267805;5870.178175055496;5897.174395584621;5734.483896449339;5739.942600574024;5793.565482588822;5799.33307669615;5871.588988770745;5809.099589563624;5813.389594092644;5818.44724751148;5818.8254352369495;5819.592628515963;4424.7123936944;4459.6655250855665;4479.641628669764;4482.484514280899;4536.138133754576;3938.291107600602;3953.1303113315025;3961.5246170459727;4001.099752555652;4066.79666016698;5481.068218402881;5498.780048798003;5500.42245564218;5516.310461192351;5565.471280228372;5819.88360232793;5861.648301101947;5873.706314684248;5878.323992740804;5950.821475355746;5421.891562168735;5425.593080518976;5465.808696695596;5491.258680078218;5538.141588053858;4911.975440122848;4967.627427942919;4969.229769385751;5010.849674509697;5016.347874776256;6015.849603759941;6040.275166979991;6042.184305118841;6046.969765151146;6048.455638992512;5624.3250809903075;5671.120976248523;5802.1296805479515;5815.069588865761;5833.883322333445;6025.337212906489;6079.640721524511;6089.821397607039;6095.740618599674;6097.97841994295;5777.133429985536;5779.364269930388;5781.971090144522;5783.392743761844;5783.884322313615;5692.117721753135;5734.455226753452;5787.36339002701;5874.060150375919;5877.794277200277;5661.745221465127;5674.319081710221;5681.346645135863;5696.1455781633085;5787.045137552257;5714.599978001666;5715.9142612860005;5723.656580605177;5723.828285151452;5725.083986562297;5549.38956714753;5597.860053498695;5621.381648018796;5629.605927585029;5669.546436285004;5760.193572899713;5772.451617096369;5782.392848750989;5792.5655575832825;5842.853928651818;5590.105583106683;5605;5622.522085622768;5645.181448689999;5655 09:54:57 INFO - PROCESS | 3009 | |1;ext.html;545.2094463028607;564.8531381840721;596.3797650443539;601.885641728072;602.7317843559617;30719.846400767994;42193.367099493495;43074;43074.56925430745;43096.78451607737;44867.32699009509;45078;45317.32024019642;45431.091378172416;45480.09039819201;8922.06318336575;8998.370114092017;9089.318301127409;9091.318151138657;9097.22673572747;8813.603387847563;8944.329175311845;8959.73120806377;8964.731058068235;8976.955115224415;8909.821803563926;8965.282777377826;8969.01340852509;9002.054784247657;9016.233620142295;8897.288216942661;8900.243479304267;8948.955255223747;8964.910350896505;8976.192142707188;8965.462072275684;8976.910230897673;8977.102289771035;9004.054574269738;9020.81958360829;42524.36213456801;43060.354094688606;43182.784086079686;43314.35028474576;43347.34978975318;3358;3857.7492462990094;4010.258102251093;4035.2534781065597;4095.1195492968855;31502.212444688837;31507;31765.364692706247;31860.362792744247;33775;3982.561918188997;4025.7181997260204;4089.427480152781;4164.7917604119675;4234.851780187679;344568;347276;347721;348059;348586;57474.71262643744;58261;58521;58550;58629.827403451694;35742.821285893406;36449;36489.452658210146;38374.424383634265;58923.41076589265;17017;17172.141392930305;17176.914115429343;17177.742333865;17302.826971730123;13007.284599347127;13027.283499407435;13029.869701303056;13126.14680045794;13166;18534.16596253172;18669.719954200697;18707.34524291643;18741.34405295808;18780.71828922567;6698.296678848651;6919.111323221631;7109.360157585738;7112.608806515588;7204.9279507204255;898.3576742628921;927.638221093774;977.8239916815041;1017.7837484206302;1109.755853712182;31005.224869378446;31911.52132718011;31950.201244969063;31997.840010800264;32104.83947580247;1116.1963386361806;1120.4733775125678;1150.465033759306;1180.8346831443605;1189.2804853063944;16239.188040597923;16887.324507019828;16984.32062717502;17035.48893533196;17218.31126754941;525178;530430;530818;530834;532124;57278.42721572731;57660;57778;57881.421185788444;57909.4209057904;1256.58532684214;1326.2241588670543;1333.7599232138114;1348.2988845800326;1355.2478374502246;29772.702272976992;30520.694793052673;31045.534316984813;31317.686823131477;32040.359192815547;49364;49803.25295120649;49951.50048499614;50137.74931125321;50162.498375015784;469073;472513;475227;475363;476034;28056.116209471642;28793.85603071971;28846.423071538873;28934.565981509873;29080.418391632473;47054;47227.52772472231;47472;47632;52510.21234681559;41719.16561668689;41904.58095419007;43171.35242971421;43577.56422435862;43841.12317753691;41144.79427602843;41596.96843957549;42286.753164180234;42631.147377052905;42861.3570796432;35246.11884702903;36081.639183607826;40839;41293.58706413017;42352.78823605862;34595.65404346025;37273.44089838709;37330.81334593309;37988.62011379961;38066.238675226894;28871.56692649654;29089.854550727956;29199.944093922415;29359.55960660549;29438.411231774815 09:54:57 INFO - PROCESS | 3009 | |2;jquery.html;397.64410852287205;401.8131568820499;401.97186196966226;404.7065877239002;420.0129695216242;15857.286422111003;18313.908430457846;19338.903305483487;20039;20065;18664.813351866476;18914.243430262806;19192.52018699533;19256;19351.225950961943;5697.886042279152;5730.541556675476;5951.137085122655;5993.28080630325;6059.242594675666;5751.913721294184;5951.2858456985;5970.641761494324;5973.044312909935;5986.371430999726;5715.571332150084;5760.107183386582;5761.078227483604;5766;5767.682777447239;5646.435356464321;5768.336641286264;5808.448197421239;5821.155932389801;5932.3474417814;5816.418358164192;5831.3877042910735;5841.153032810261;5841.532677385799;5844.240248767675;14127.64680882986;19647.901760491248;21953.67069493959;22521.549569008526;22541.098356065737;2155.299527653503;2196.1654571262816;2494.7131079925857;2543.923682289516;2617.8036647251533;10074.445905475195;10139.797204055878;10356.275060745751;10743.83884241737;10860.45697715111;1916.629609828979;1933.9129739161772;1942.5629233422508;1965.2924947019205;1992.5516758729316;82165;83450;85234.57382713108;85252.31112288822;86590.13409865947;9356.906430935604;9725.90274097264;9814.705558833246;9900.702978910644;10344.793104137874;12305.876941230652;12952.611421657366;13426.731465370833;13458.259795711134;13487.662808429868;7909.960450197712;7936.642851071716;7957.164497727771;8142.226488483703;8226.424150309422;7850.861625064448;7923.247291507298;8084.595770211466;8093.8381232376205;8187.058488273806;4010.57888921659;4067.206894655573;4168.854090106832;4217.283061879488;4260.467441569804;1988.2544045982756;1988.8309493693198;1996.2015193922548;2018.4852862520256;2059.814616684476;903.823754367905;976.9023097690174;998.4608311511703;1011.6863772230632;1021.1218352217087;19591.314303999578;19755.802441975684;20033.59932801336;20044.098015589334;20074.899625501777;935.822193783179;953.0564740906452;956.1299217711849;956.660385563129;1091.5961094395125;10379.96200379956;10962.232643714864;11016.511867904956;11074.446277686084;11145.777084458265;443247;448369.6467317957;460798;465914;472982;83674.58162709269;83800.58099709463;84782.15217847866;85445.57277213699;85859.57070214608;953.7520244736419;979.4759803505091;1007.29992655104;1011.9544620492095;1012.0840639221516;16721.247543860798;16793.664126717642;17126.571835703708;17398.73901891447;17526.649467010844;40217.39673904952;42109;42160;42594;42872.78563607162;56857.431425685216;58097.12854307104;58440;58831.411685884304;59172.40827591669;6109.847253818512;8503.937007874016;8713.869291960498;8987.236084932854;9128.361014728906;11589.884101159218;13552.254625995665;13628;13639;13676.863231367559;11215.158863085464;11449.313041217554;11630.94184529072;11840;12125.029997600348;11568.190226684052;11571.768564628828;11583;12104.75790484203;12258.938705306417;11856.347900865536;12028.218165819193;12052.638420847388;12102.878971210175;12199.329036903055;8480.915190848013;8650.653973840976;8778.517181555077;8976.640934362553;9077.546122693971;10785.514651840844;11485.598004069818;11662.70843228926;12155.635330940086;12387 09:54:57 INFO - PROCESS | 3009 | |3;mootools.html;1459.3068292561031;1493.1638282561764;1606.3815431059038;1714.5113642611843;1743.1545700335344;7851.097123830761;8072;8567.742967710963;9331.346805723602;9343.01898300678;8584.098669639692;8758.737237882859;8934;9019.909800901989;9088.272938164948;2304.3662992677023;2311.653252012203;2324.9302520924316;2324.9651255231183;2356.8114550835976;2329.452578644026;2347.788699017088;2402;2404.5791986402396;2412.2883749294;2305.5158416732506;2321.58211521926;2323.0591610397814;2325.2094287942095;2350.8589484630893;2292.33522278539;2297.8851057447146;2306.6655334976417;2315.0392587076426;2356.9528609427716;2198.8131008864107;2203.603351396748;2212.9225477108384;2215.5125872308067;2223.844330896838;8555;8562.914370856273;8570.18583234598;8587;8643.049264580892;5130.7691153897795;5293.973530132324;5305.4164041955355;5306.973465132688;5329.920051199235;3292.6378098409155;3411.6325536546774;3514.297140571896;3527.8412471438846;3548.716102711777;1087.724186969416;1129.6498085593491;1138.7950168969583;1147.305879942631;1163.0463020323339;12986.870131298661;13020.934895325463;13028.54400095992;13033.86966130336;13071.54249601269;4575.519570445122;4724.338592597039;4772.902232486478;4826.107170173529;4950.900981980412;10628.309159904582;10764.192685548458;10811.297265677706;10829.404382758867;10847.349159050482;5140.46025167352;5172.379314482287;5182;5183.2743415921805;5198.402183748842;4377.255866502702;4514.119746649438;4756.9762151189025;4873.390826146731;5018.347614810052;3867.651911327938;3976.76139431635;4067.4102255172834;4078.8164532596106;4116.176764647083;1304.6738315421144;1348.7235116801032;1353.9864601354057;1357.592722183341;1357.633438971472;908.318760929303;924.9409426206955;938.6010945348336;939.8872135343803;960.9855852162223;5646;5696.259486266758;5821.526224210788;5904.084866845646;5921.082232254007;464.9279361698942;471.93107611260524;482.6910777102657;484.7309743092547;487.14262897301006;3794.2032173243374;3815.980920095382;3867.3038853006165;3945.585713500099;3952.940705889414;10896.128309735202;11464.31214127155;11471.885281147082;11516.596919107958;11544.538218471334;10887.83668244977;11105.72235694098;11284.887151128547;11287.322760634388;11302.886971130183;7975.401844861659;8180.345572354317;8365.832683346422;8451.577421128919;8453.535055572003;6046.407297559933;6126.877462450815;6150.169727086786;6232.594881332699;6287.182666253358;9857;9888.752781180528;9990.450525221182;10068.093871551595;10345.224108191765;10142.949285253822;10277.640282590073;10408.583656653649;10474.4239066849;10503.579856805642;7217.06178196831;7442.665080071301;7750.069991600819;7828.45200835936;7973.800654983672;8176.550289734122;8318.750437486886;8483.618237179218;8507.574621268788;8529.061803201519;7319.74380896666;7498.287662672037;7578.12851522082;7608.581528016012;7737.961310193413;7303.926960730325;7423.851522969402;7588.013558237394;7686;7834.177411371952;6785.762498312535;6907.309269073053;6947.409470194888;6961.164660240601;6987.755428559976;5095.898082038412;5151.201563757623;5244.187150991603;5263.736813159403;5482.17767334887;5127.948720512747;5180.818671346485;5274.024305503494;5302.416734159162;5311.5485183758265 09:54:57 INFO - PROCESS | 3009 | |4;prototype.html;337.1066673315713;338.5886148329779;345.28353666142755;348.39379479705286;351.1834983662984;5556.222128901952;5644.717764111793;5647.632903861251;5675.744591493382;5677.9716101419535;5510.421405752399;5523;5543.673795722564;5575.721213939297;5591.552675785927;4028.5165780106427;4069.613386728256;4223.746575205498;4256.531781504032;4287.035417031158;4312.331588603755;4316.158349121923;4318.488529014851;4355.847545335914;4356.869293921171;4336.959129808854;4342.370356298335;4357.281048626973;4364.869053928387;4375.299952007679;4279.593438623326;4291.120320334339;4304.526502084768;4325.07010992635;4337.869863904088;3849.557300910375;3849.903752406184;3853.0542076251595;3868.524144547464;3876.6511014008875;5414.891702165974;5427.701476418795;5439;5443;5445.591580631469;4862.246351815475;4939.394696723543;4950;4955.182394904837;5018.473060328686;5657.490825825655;5685.403032681592;5712.57155713319;5781.884362312772;5807.128930660392;4190.245755763961;4208.747475151501;4217.957820421787;4234;4250.872473825791;5770.278715160605;5919.01089949577;5935.465808077293;5955.8213253602025;6059.848503787396;4323.935140972888;4351.586599273064;4362.454693163355;4370.803313850821;4373.278409062533;4390.165868484977;4390.429244198233;4423.5576442355505;4433.224185767478;4451.577100175478;4621;4814.3390530267;4817.13291607514;4872.5138832655675;4922.409310882717;5738.110592858114;5783.23611298558;5799.710014499343;5810.622309549865;5908.675022873783;1495.035701972222;1497.7903093566908;1498.5354540092605;1508.328793686799;1511.4960614188733;934.3879758757888;957.9425234485954;968.4673429613684;997.7029861180437;1002.6891663584166;5515.862103447446;5528.364238112588;5614.29821272341;5629.943700562942;5633.267675202197;5867.647941123546;5870.412958704095;5883.794067207627;5960.582759206901;5965.612235204698;5437.673739575638;5505.917411238835;5547.944520554824;5576.414476479992;5582.86042848932;3089.1041597936346;3100.8139511629374;3114.9720592204517;3144.748420126384;3151.16494129056;5964.671943043174;6044.546659000593;6116;6121.173641558333;6139.969300153471;5900.436384358149;5914.852128696817;5968.22413086296;6038.879222415527;6049.304330002106;6144;6157.7229024694;6158.753649854045;6196.783112591128;6205.379462053849;5668.5465162787705;5808.244928159313;5841.415858414124;5855.707214639337;5856.648601083949;5810.418958104325;5847.210626565359;5875.882482350415;5880.676562789087;5897.823065308047;5942.58401911862;5942.910856337245;6109.877802443837;6142.692865356804;6161.6919154041225;4154.293770059036;4160.313548264502;4171.561985991427;4173.770442625685;4234.449521562177;5839.153322768259;5844.240248767803;5886.94113058864;5888.676122813286;5912.822615321547;5430.972845135749;5647.350554686263;5656.434356564475;5660.745266463102;5720.914186287292;5689.630174038674;5705.7147142643535;5734.283214598176;5737.5983681141915;5776.19133321327;5384.70384128861;5591.748371323219;5602.13166959122;5715.742791574306;5717.08477659972;5750.827475175584;5848.84162552217;5855.975204339138;5872.970635146797;5876.236089308362;5775.480206781242;5796.275465566804;5824.534037276923;5843.883122337445;5856.4143585641095 09:54:57 INFO - PROCESS | 3009 | |5;yui.html;645.9160309159809;725.6226762083717;751.2937838431874;775.8293175501387;808.5593351623364;15049.172295523742;16173.999999999985;16242.18789060548;16254.756178657315;16286.755698664529;15119.395224191047;15147.54557363278;15197.088174709525;15252.847471525281;15264.542063738105;757.6211894052974;768.0552919908516;784.2588753627824;789.9210078992112;791.6121100660664;793.3851265269404;793.5754371411296;794.1145622630754;794.5074054086446;797.0714118052462;824.6124321568853;828.1759649149105;833.8082241084554;833.9166083391673;839.7522730794431;832.2551316571664;833.3000279765026;834.3283656656389;834.4993004197494;834.845553572591;600.8467840700637;608.2214765100679;609.2932198649545;609.4149616368292;609.6860117039728;14074.2962851857;14096.365663545164;14127.152370857679;14130.85869141316;14134.787978180335;13792;13909.652258693512;14392.856071439257;14473.927630361886;14550.417983280762;11416.600418985296;11600.883991160064;11621.302721836631;11867.465964031553;11975.28148311104;3534.3284775892757;3590.7666001709804;3631.670478724715;3656.634336566349;3796.1079146400575;76094.23905760983;76565;77691.22308776896;80059.5997020017;80265;10482.63310784119;10508.842367364496;10555;10866.239363244655;10985.890141098647;18953.810461895482;18958.14688339028;18973.241070357308;18994.905025475062;19018.239270429305;7695.884561731578;7978.082520510099;8053.194680532017;8086.070101938352;8325;4617.630589552895;4748.7863046163;4754.595859351924;4819.518048195152;4823.686460380064;3495.632958539368;3631.7276204284785;3659.597444281127;3666.1201311685004;3669.889903302852;581.2211636407235;582.4001278682963;587.3245767367476;592.9347771745105;605.4157737783061;605.3885575568619;698.996939391964;717.2540557819809;722.5917356693451;731.7877815433571;9049.638014479347;9838.950805245928;9854.310198286052;10092;10111.747206319753;502.91450453423005;624.8469125064388;638.1990601794718;652.2271108736163;731.1956847467743;4717.716936983792;4900.828471003498;4913.680610760289;4920.975395123073;5003.449620541737;93649;95207.52396237974;97438;115951.42024289824;119774;55584;67505;82647;87837.56081219553;96960.51519742356;83705.58147209225;83886;84975;86085;88681.11318886858;9046.457212567268;9557.235421166151;9651.469169195761;9719.9028009719;9784.804303914025;50555;51048.489515104375;51091.744541277054;51285.7435712834;52240;75236.62381688057;75529.62235188788;78631.60684196542;78672;79237;11013.229073965065;11135.443227838738;11517.136214783757;11616.244944078608;11859.110566707704;13776;13816.861831381959;14233.857661423253;14445.85554144445;15453.845461545241;13462.326883655975;13598.252096134807;14149.221792801083;14624.488142914946;14742;13170.670733231746;13614.93192534031;13687.384067717176;13785.931070344584;14250.358733856794;12119.939400302943;12386.347218278337;12530.812037819258;12675.746485070062;12707.93646031764;9664.420134791935;9708.514574271117;9899.65351212704;10421.06210441064;10447;8052.194780522135;8775.385722999328;9190.54047297619;9595.904040959502;9731.951340243253 09:54:57 INFO - PROCESS | 3009 | __end_tp_report 09:54:57 INFO - PROCESS | 3009 | __start_cc_report 09:54:57 INFO - PROCESS | 3009 | _x_x_mozilla_cycle_collect,306 09:54:57 INFO - PROCESS | 3009 | __end_cc_report 09:54:57 INFO - PROCESS | 3009 | __startTimestamp1474995297725__endTimestamp 09:54:57 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | ------- Summary: start ------- 09:54:57 INFO - PROCESS | 3009 | Number of tests: 6 09:54:57 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | [#0] dojo.html Cycles:165 Average:5419.70 Median:5629.61 stddev:622.17 (11.1%) stddev-sans-first:596.18 09:54:57 INFO - PROCESS | 3009 | Values: 3071.0 3092.6 3113.4 3130.9 3133.5 5347.3 5377.8 5442.5 5467.6 5487.6 5403.6 5432.2 5438.1 5481.3 5524.6 4855.6 5004.7 5007.7 5060.8 5079.0 5039.4 5096.5 5103.0 5106.7 5113.6 4813.5 4878.7 4883.8 4910.4 5042.7 4930.0 4931.3 4981.3 5009.4 5023.8 4893.1 4935.7 4940.9 4952.6 4999.8 5315.3 5349.5 5368.9 5391.2 5443.0 5821.5 5868.8 5871.8 5912.4 5921.4 5905.5 5913.4 5916.8 5926.7 5928.6 5287.7 5324.2 5486.7 5487.0 5493.5 5939.4 5972.8 5999.3 6002.3 6112.7 5752.5 5764.1 5777.2 5785.2 5789.1 5662.7 5708.9 5817.8 5870.2 5897.2 5734.5 5739.9 5793.6 5799.3 5871.6 5809.1 5813.4 5818.4 5818.8 5819.6 4424.7 4459.7 4479.6 4482.5 4536.1 3938.3 3953.1 3961.5 4001.1 4066.8 5481.1 5498.8 5500.4 5516.3 5565.5 5819.9 5861.6 5873.7 5878.3 5950.8 5421.9 5425.6 5465.8 5491.3 5538.1 4912.0 4967.6 4969.2 5010.8 5016.3 6015.8 6040.3 6042.2 6047.0 6048.5 5624.3 5671.1 5802.1 5815.1 5833.9 6025.3 6079.6 6089.8 6095.7 6098.0 5777.1 5779.4 5782.0 5783.4 5783.9 5692.1 5734.5 5787.4 5874.1 5877.8 5661.7 5674.3 5681.3 5696.1 5787.0 5714.6 5715.9 5723.7 5723.8 5725.1 5549.4 5597.9 5621.4 5629.6 5669.5 5760.2 5772.5 5782.4 5792.6 5842.9 5590.1 5605.0 5622.5 5645.2 5655.0 09:54:57 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | [#1] ext.html Cycles:180 Average:60515.69 Median:23260.80 stddev:121161.67 (520.9%) stddev-sans-first:121417.89 09:54:57 INFO - PROCESS | 3009 | Values: 545.2 564.9 596.4 601.9 602.7 30719.8 42193.4 43074.0 43074.6 43096.8 44867.3 45078.0 45317.3 45431.1 45480.1 8922.1 8998.4 9089.3 9091.3 9097.2 8813.6 8944.3 8959.7 8964.7 8977.0 8909.8 8965.3 8969.0 9002.1 9016.2 8897.3 8900.2 8949.0 8964.9 8976.2 8965.5 8976.9 8977.1 9004.1 9020.8 42524.4 43060.4 43182.8 43314.4 43347.3 3358.0 3857.7 4010.3 4035.3 4095.1 31502.2 31507.0 31765.4 31860.4 33775.0 3982.6 4025.7 4089.4 4164.8 4234.9 344568.0 347276.0 347721.0 348059.0 348586.0 57474.7 58261.0 58521.0 58550.0 58629.8 35742.8 36449.0 36489.5 38374.4 58923.4 17017.0 17172.1 17176.9 17177.7 17302.8 13007.3 13027.3 13029.9 13126.1 13166.0 18534.2 18669.7 18707.3 18741.3 18780.7 6698.3 6919.1 7109.4 7112.6 7204.9 898.4 927.6 977.8 1017.8 1109.8 31005.2 31911.5 31950.2 31997.8 32104.8 1116.2 1120.5 1150.5 1180.8 1189.3 16239.2 16887.3 16984.3 17035.5 17218.3 525178.0 530430.0 530818.0 530834.0 532124.0 57278.4 57660.0 57778.0 57881.4 57909.4 1256.6 1326.2 1333.8 1348.3 1355.2 29772.7 30520.7 31045.5 31317.7 32040.4 49364.0 49803.3 49951.5 50137.7 50162.5 469073.0 472513.0 475227.0 475363.0 476034.0 28056.1 28793.9 28846.4 28934.6 29080.4 47054.0 47227.5 47472.0 47632.0 52510.2 41719.2 41904.6 43171.4 43577.6 43841.1 41144.8 41597.0 42286.8 42631.1 42861.4 35246.1 36081.6 40839.0 41293.6 42352.8 34595.7 37273.4 37330.8 37988.6 38066.2 28871.6 29089.9 29199.9 29359.6 29438.4 09:54:57 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | [#2] jquery.html Cycles:180 Average:27880.46 Median:22113.99 stddev:75702.11 (342.3%) stddev-sans-first:75886.35 09:54:57 INFO - PROCESS | 3009 | Values: 397.6 401.8 402.0 404.7 420.0 15857.3 18313.9 19338.9 20039.0 20065.0 18664.8 18914.2 19192.5 19256.0 19351.2 5697.9 5730.5 5951.1 5993.3 6059.2 5751.9 5951.3 5970.6 5973.0 5986.4 5715.6 5760.1 5761.1 5766.0 5767.7 5646.4 5768.3 5808.4 5821.2 5932.3 5816.4 5831.4 5841.2 5841.5 5844.2 14127.6 19647.9 21953.7 22521.5 22541.1 2155.3 2196.2 2494.7 2543.9 2617.8 10074.4 10139.8 10356.3 10743.8 10860.5 1916.6 1933.9 1942.6 1965.3 1992.6 82165.0 83450.0 85234.6 85252.3 86590.1 9356.9 9725.9 9814.7 9900.7 10344.8 12305.9 12952.6 13426.7 13458.3 13487.7 7910.0 7936.6 7957.2 8142.2 8226.4 7850.9 7923.2 8084.6 8093.8 8187.1 4010.6 4067.2 4168.9 4217.3 4260.5 1988.3 1988.8 1996.2 2018.5 2059.8 903.8 976.9 998.5 1011.7 1021.1 19591.3 19755.8 20033.6 20044.1 20074.9 935.8 953.1 956.1 956.7 1091.6 10380.0 10962.2 11016.5 11074.4 11145.8 443247.0 448369.6 460798.0 465914.0 472982.0 83674.6 83800.6 84782.2 85445.6 85859.6 953.8 979.5 1007.3 1012.0 1012.1 16721.2 16793.7 17126.6 17398.7 17526.6 40217.4 42109.0 42160.0 42594.0 42872.8 56857.4 58097.1 58440.0 58831.4 59172.4 6109.8 8503.9 8713.9 8987.2 9128.4 11589.9 13552.3 13628.0 13639.0 13676.9 11215.2 11449.3 11630.9 11840.0 12125.0 11568.2 11571.8 11583.0 12104.8 12258.9 11856.3 12028.2 12052.6 12102.9 12199.3 8480.9 8650.7 8778.5 8976.6 9077.5 10785.5 11485.6 11662.7 12155.6 12387.0 09:54:57 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | [#3] mootools.html Cycles:180 Average:5833.04 Median:2654.40 stddev:3399.56 (128.1%) stddev-sans-first:3393.21 09:54:57 INFO - PROCESS | 3009 | Values: 1459.3 1493.2 1606.4 1714.5 1743.2 7851.1 8072.0 8567.7 9331.3 9343.0 8584.1 8758.7 8934.0 9019.9 9088.3 2304.4 2311.7 2324.9 2325.0 2356.8 2329.5 2347.8 2402.0 2404.6 2412.3 2305.5 2321.6 2323.1 2325.2 2350.9 2292.3 2297.9 2306.7 2315.0 2357.0 2198.8 2203.6 2212.9 2215.5 2223.8 8555.0 8562.9 8570.2 8587.0 8643.0 5130.8 5294.0 5305.4 5307.0 5329.9 3292.6 3411.6 3514.3 3527.8 3548.7 1087.7 1129.6 1138.8 1147.3 1163.0 12986.9 13020.9 13028.5 13033.9 13071.5 4575.5 4724.3 4772.9 4826.1 4950.9 10628.3 10764.2 10811.3 10829.4 10847.3 5140.5 5172.4 5182.0 5183.3 5198.4 4377.3 4514.1 4757.0 4873.4 5018.3 3867.7 3976.8 4067.4 4078.8 4116.2 1304.7 1348.7 1354.0 1357.6 1357.6 908.3 924.9 938.6 939.9 961.0 5646.0 5696.3 5821.5 5904.1 5921.1 464.9 471.9 482.7 484.7 487.1 3794.2 3816.0 3867.3 3945.6 3952.9 10896.1 11464.3 11471.9 11516.6 11544.5 10887.8 11105.7 11284.9 11287.3 11302.9 7975.4 8180.3 8365.8 8451.6 8453.5 6046.4 6126.9 6150.2 6232.6 6287.2 9857.0 9888.8 9990.5 10068.1 10345.2 10142.9 10277.6 10408.6 10474.4 10503.6 7217.1 7442.7 7750.1 7828.5 7973.8 8176.6 8318.8 8483.6 8507.6 8529.1 7319.7 7498.3 7578.1 7608.6 7738.0 7303.9 7423.9 7588.0 7686.0 7834.2 6785.8 6907.3 6947.4 6961.2 6987.8 5095.9 5151.2 5244.2 5263.7 5482.2 5127.9 5180.8 5274.0 5302.4 5311.5 09:54:57 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | [#4] prototype.html Cycles:180 Average:4873.56 Median:5591.65 stddev:1422.31 (25.4%) stddev-sans-first:1384.95 09:54:57 INFO - PROCESS | 3009 | Values: 337.1 338.6 345.3 348.4 351.2 5556.2 5644.7 5647.6 5675.7 5678.0 5510.4 5523.0 5543.7 5575.7 5591.6 4028.5 4069.6 4223.7 4256.5 4287.0 4312.3 4316.2 4318.5 4355.8 4356.9 4337.0 4342.4 4357.3 4364.9 4375.3 4279.6 4291.1 4304.5 4325.1 4337.9 3849.6 3849.9 3853.1 3868.5 3876.7 5414.9 5427.7 5439.0 5443.0 5445.6 4862.2 4939.4 4950.0 4955.2 5018.5 5657.5 5685.4 5712.6 5781.9 5807.1 4190.2 4208.7 4218.0 4234.0 4250.9 5770.3 5919.0 5935.5 5955.8 6059.8 4323.9 4351.6 4362.5 4370.8 4373.3 4390.2 4390.4 4423.6 4433.2 4451.6 4621.0 4814.3 4817.1 4872.5 4922.4 5738.1 5783.2 5799.7 5810.6 5908.7 1495.0 1497.8 1498.5 1508.3 1511.5 934.4 957.9 968.5 997.7 1002.7 5515.9 5528.4 5614.3 5629.9 5633.3 5867.6 5870.4 5883.8 5960.6 5965.6 5437.7 5505.9 5547.9 5576.4 5582.9 3089.1 3100.8 3115.0 3144.7 3151.2 5964.7 6044.5 6116.0 6121.2 6140.0 5900.4 5914.9 5968.2 6038.9 6049.3 6144.0 6157.7 6158.8 6196.8 6205.4 5668.5 5808.2 5841.4 5855.7 5856.6 5810.4 5847.2 5875.9 5880.7 5897.8 5942.6 5942.9 6109.9 6142.7 6161.7 4154.3 4160.3 4171.6 4173.8 4234.4 5839.2 5844.2 5886.9 5888.7 5912.8 5431.0 5647.4 5656.4 5660.7 5720.9 5689.6 5705.7 5734.3 5737.6 5776.2 5384.7 5591.7 5602.1 5715.7 5717.1 5750.8 5848.8 5856.0 5873.0 5876.2 5775.5 5796.3 5824.5 5843.9 5856.4 09:54:57 INFO - PROCESS | 3009 | 09:54:57 INFO - PROCESS | 3009 | [#5] yui.html Cycles:180 Average:19768.39 Median:51762.87 stddev:28072.38 (54.2%) stddev-sans-first:28114.41 09:54:57 INFO - PROCESS | 3009 | Values: 645.9 725.6 751.3 775.8 808.6 15049.2 16174.0 16242.2 16254.8 16286.8 15119.4 15147.5 15197.1 15252.8 15264.5 757.6 768.1 784.3 789.9 791.6 793.4 793.6 794.1 794.5 797.1 824.6 828.2 833.8 833.9 839.8 832.3 833.3 834.3 834.5 834.8 600.8 608.2 609.3 609.4 609.7 14074.3 14096.4 14127.2 14130.9 14134.8 13792.0 13909.7 14392.9 14473.9 14550.4 11416.6 11600.9 11621.3 11867.5 11975.3 3534.3 3590.8 3631.7 3656.6 3796.1 76094.2 76565.0 77691.2 80059.6 80265.0 10482.6 10508.8 10555.0 10866.2 10985.9 18953.8 18958.1 18973.2 18994.9 19018.2 7695.9 7978.1 8053.2 8086.1 8325.0 4617.6 4748.8 4754.6 4819.5 4823.7 3495.6 3631.7 3659.6 3666.1 3669.9 581.2 582.4 587.3 592.9 605.4 605.4 699.0 717.3 722.6 731.8 9049.6 9839.0 9854.3 10092.0 10111.7 502.9 624.8 638.2 652.2 731.2 4717.7 4900.8 4913.7 4921.0 5003.4 93649.0 95207.5 97438.0 115951.4 119774.0 55584.0 67505.0 82647.0 87837.6 96960.5 83705.6 83886.0 84975.0 86085.0 88681.1 9046.5 9557.2 9651.5 9719.9 9784.8 50555.0 51048.5 51091.7 51285.7 52240.0 75236.6 75529.6 78631.6 78672.0 79237.0 11013.2 11135.4 11517.1 11616.2 11859.1 13776.0 13816.9 14233.9 14445.9 15453.8 13462.3 13598.3 14149.2 14624.5 14742.0 13170.7 13614.9 13687.4 13785.9 14250.4 12119.9 12386.3 12530.8 12675.7 12707.9 9664.4 9708.5 9899.7 10421.1 10447.0 8052.2 8775.4 9190.5 9595.9 9732.0 09:54:57 INFO - PROCESS | 3009 | -------- Summary: end -------- 09:54:57 INFO - PROCESS | 3009 | 09:54:58 INFO - TEST-INFO | 3009: exit 0 09:54:58 INFO - TEST-OK | dromaeo_css | took 1113941ms 09:54:58 INFO - TEST-START | kraken 09:54:58 INFO - operating with platform_type : linux_ 09:54:58 INFO - Initialising browser for kraken test... 09:54:58 INFO - TEST-INFO | started process 3364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfs8hNW/profile http://localhost:50430/getInfo.html) 09:55:03 INFO - PROCESS | 3364 | __metrics Screen width/height:1600/1200 09:55:03 INFO - PROCESS | 3364 | colorDepth:24 09:55:03 INFO - PROCESS | 3364 | Browser inner width/height: 1024/697 09:55:03 INFO - PROCESS | 3364 | __metrics 09:55:03 ERROR - PROCESS | 3364 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 09:55:04 INFO - TEST-INFO | 3364: exit 0 09:55:04 INFO - Browser initialized. 09:55:04 INFO - Running cycle 1/1 for kraken test... 09:55:04 INFO - TEST-INFO | started process 3486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfs8hNW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:17 INFO - PROCESS | 3486 | RSS: Main: 185171968 09:55:17 INFO - PROCESS | 3486 | 09:55:19 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50430/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:20 INFO - PROCESS | 3486 | RSS: Main: 199700480 09:55:20 INFO - PROCESS | 3486 | 09:55:23 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50430/tests/kraken/driver.html?testName=audio-dft) 09:55:24 INFO - PROCESS | 3486 | RSS: Main: 198115328 09:55:24 INFO - PROCESS | 3486 | 09:55:26 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50430/tests/kraken/driver.html?testName=audio-fft) 09:55:27 INFO - PROCESS | 3486 | RSS: Main: 192983040 09:55:27 INFO - PROCESS | 3486 | 09:55:29 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50430/tests/kraken/driver.html?testName=audio-oscillator) 09:55:30 INFO - PROCESS | 3486 | RSS: Main: 193470464 09:55:30 INFO - PROCESS | 3486 | 09:55:32 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:32 INFO - PROCESS | 3486 | RSS: Main: 193437696 09:55:32 INFO - PROCESS | 3486 | 09:55:36 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50430/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:36 INFO - PROCESS | 3486 | RSS: Main: 194154496 09:55:36 INFO - PROCESS | 3486 | 09:55:40 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50430/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:40 INFO - PROCESS | 3486 | RSS: Main: 191492096 09:55:40 INFO - PROCESS | 3486 | 09:55:43 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50430/tests/kraken/driver.html?testName=json-parse-financial) 09:55:44 INFO - PROCESS | 3486 | RSS: Main: 193011712 09:55:44 INFO - PROCESS | 3486 | 09:55:45 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:46 INFO - PROCESS | 3486 | RSS: Main: 193540096 09:55:46 INFO - PROCESS | 3486 | 09:55:48 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50430/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:48 INFO - PROCESS | 3486 | RSS: Main: 193458176 09:55:48 INFO - PROCESS | 3486 | 09:55:50 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:55:51 INFO - PROCESS | 3486 | RSS: Main: 193392640 09:55:51 INFO - PROCESS | 3486 | 09:55:54 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:55:55 INFO - PROCESS | 3486 | RSS: Main: 193372160 09:55:55 INFO - PROCESS | 3486 | 09:55:57 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:55:58 INFO - PROCESS | 3486 | RSS: Main: 194117632 09:55:58 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:50430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50430/tests/kraken/driver.html?testName=ai-astar) 09:56:00 INFO - PROCESS | 3486 | RSS: Main: 195543040 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | __start_tp_report 09:56:00 INFO - PROCESS | 3486 | _x_x_mozilla_page_load 09:56:00 INFO - PROCESS | 3486 | _x_x_mozilla_page_load_details 09:56:00 INFO - PROCESS | 3486 | |i|pagename|runs| 09:56:00 INFO - PROCESS | 3486 | |0;ai-astar;106;113;114;114;117;115;114;114;116;113 09:56:00 INFO - PROCESS | 3486 | |1;audio-beat-detection;152;126;125;173;124;125;130;121;154;125 09:56:00 INFO - PROCESS | 3486 | |2;audio-dft;162;164;164;167;165;162;162;164;163;163 09:56:00 INFO - PROCESS | 3486 | |3;audio-fft;75;76;76;112;77;77;77;75;107;76 09:56:00 INFO - PROCESS | 3486 | |4;audio-oscillator;83;82;107;83;83;83;101;82;86;102 09:56:00 INFO - PROCESS | 3486 | |5;imaging-gaussian-blur;118;117;118;117;117;118;117;118;117;119 09:56:00 INFO - PROCESS | 3486 | |6;imaging-darkroom;147;150;148;148;147;147;148;147;147;146 09:56:00 INFO - PROCESS | 3486 | |7;imaging-desaturate;96;96;96;95;97;95;96;96;96;96 09:56:00 INFO - PROCESS | 3486 | |8;json-parse-financial;58;52;53;53;57;54;54;55;54;55 09:56:00 INFO - PROCESS | 3486 | |9;json-stringify-tinderbox;60;61;61;60;60;60;60;60;60;60 09:56:00 INFO - PROCESS | 3486 | |10;stanford-crypto-aes;88;81;82;85;81;79;79;79;79;79 09:56:00 INFO - PROCESS | 3486 | |11;stanford-crypto-ccm;129;130;135;129;126;127;140;140;183;135 09:56:00 INFO - PROCESS | 3486 | |12;stanford-crypto-pbkdf2;166;166;168;173;169;169;168;166;168;168 09:56:00 INFO - PROCESS | 3486 | |13;stanford-crypto-sha256-iterative;71;68;65;66;67;70;65;67;66;70 09:56:00 INFO - PROCESS | 3486 | __end_tp_report 09:56:00 INFO - PROCESS | 3486 | __start_cc_report 09:56:00 INFO - PROCESS | 3486 | _x_x_mozilla_cycle_collect,772 09:56:00 INFO - PROCESS | 3486 | __end_cc_report 09:56:00 INFO - PROCESS | 3486 | __startTimestamp1474995360424__endTimestamp 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | ------- Summary: start ------- 09:56:00 INFO - PROCESS | 3486 | Number of tests: 14 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.95 (2.6%) stddev-sans-first:1.33 09:56:00 INFO - PROCESS | 3486 | Values: 106.0 113.0 114.0 114.0 117.0 115.0 114.0 114.0 116.0 113.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:128.00 stddev:17.68 (13.8%) stddev-sans-first:17.72 09:56:00 INFO - PROCESS | 3486 | Values: 152.0 126.0 125.0 173.0 124.0 125.0 130.0 121.0 154.0 125.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.58 (1.0%) stddev-sans-first:1.56 09:56:00 INFO - PROCESS | 3486 | Values: 162.0 164.0 164.0 167.0 165.0 162.0 162.0 164.0 163.0 163.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:14.14 (18.6%) stddev-sans-first:14.71 09:56:00 INFO - PROCESS | 3486 | Values: 75.0 76.0 76.0 112.0 77.0 77.0 77.0 75.0 107.0 76.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.00 stddev:9.93 (12.0%) stddev-sans-first:10.28 09:56:00 INFO - PROCESS | 3486 | Values: 83.0 82.0 107.0 83.0 83.0 83.0 101.0 82.0 86.0 102.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 09:56:00 INFO - PROCESS | 3486 | Values: 118.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 119.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 09:56:00 INFO - PROCESS | 3486 | Values: 147.0 150.0 148.0 148.0 147.0 147.0 148.0 147.0 147.0 146.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:56:00 INFO - PROCESS | 3486 | Values: 96.0 96.0 96.0 95.0 97.0 95.0 96.0 96.0 96.0 96.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.84 (3.4%) stddev-sans-first:1.45 09:56:00 INFO - PROCESS | 3486 | Values: 58.0 52.0 53.0 53.0 57.0 54.0 54.0 55.0 54.0 55.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 09:56:00 INFO - PROCESS | 3486 | Values: 60.0 61.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:3.08 (3.8%) stddev-sans-first:2.07 09:56:00 INFO - PROCESS | 3486 | Values: 88.0 81.0 82.0 85.0 81.0 79.0 79.0 79.0 79.0 79.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:135.00 stddev:16.79 (12.4%) stddev-sans-first:17.54 09:56:00 INFO - PROCESS | 3486 | Values: 129.0 130.0 135.0 129.0 126.0 127.0 140.0 140.0 183.0 135.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.00 stddev:2.08 (1.2%) stddev-sans-first:2.06 09:56:00 INFO - PROCESS | 3486 | Values: 166.0 166.0 168.0 173.0 169.0 169.0 168.0 166.0 168.0 168.0 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:2.17 (3.2%) stddev-sans-first:1.90 09:56:00 INFO - PROCESS | 3486 | Values: 71.0 68.0 65.0 66.0 67.0 70.0 65.0 67.0 66.0 70.0 09:56:00 INFO - PROCESS | 3486 | -------- Summary: end -------- 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | 09:56:00 INFO - PROCESS | 3486 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:56:00 INFO - PROCESS | 3486 | 09:56:01 INFO - TEST-INFO | 3486: exit 0 09:56:01 INFO - TEST-OK | kraken | took 63011ms 09:56:01 INFO - SUITE-END | took 1176s 09:56:02 INFO - Completed test suite (00:19:37) 09:56:02 INFO - javascript benchmark 09:56:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.032630516332, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.047975127712, 3092.5979622649056, 3113.3773245350935, 3130.874765009399, 3133.4986402175655, 5347.331583552056, 5377.8117765878205, 5442.537384322332, 5467.6172667913215, 5487.5884308676905, 5403.648762830413, 5432.239486471887, 5438.102713052342, 5481.342238931334, 5524.640898341605, 4855.5872750816225, 5004.724740139291, 5007.699538027712, 5060.84817455477, 5078.974605126969, 5039.395272567297, 5096.541311281984, 5103.030424219386, 5106.668066575679, 5113.616478764089, 4813.470518242991, 4878.731669758162, 4883.804647814083, 4910.435299940516, 5042.697438153704, 4929.975350123263, 4931.334269873557, 4981.32752078472, 5009.44896061433, 5023.8492845214705, 4893.09477746618, 4935.703857768545, 4940.876478088041, 4952.603791696655, 4999.75001249936, 5315.335583052119, 5349.518543331119, 5368.865778355573, 5391.164369522691, 5443.047466693313, 5821.476067153976, 5868.794592189295, 5871.765129394819, 5912.379200183962, 5921.437463440966, 5905.527557795409, 5913.438223368773, 5916.822495325104, 5926.733297001645, 5928.644281343133, 5287.682739035593, 5324.201369794562, 5486.670799751988, 5487.039768040577, 5493.478119578674, 5939.3763654816485, 5972.820815375546, 5999.280086389661, 6002.339742628307, 6112.724927378279, 5752.482276595127, 5764.106563482667, 5777.19119323295, 5785.218995435646, 5789.131630255495, 5662.68855212959, 5708.914366284509, 5817.7963771267805, 5870.178175055496, 5897.174395584621, 5734.483896449339, 5739.942600574024, 5793.565482588822, 5799.33307669615, 5871.588988770745, 5809.099589563624, 5813.389594092644, 5818.44724751148, 5818.8254352369495, 5819.592628515963, 4424.7123936944, 4459.6655250855665, 4479.641628669764, 4482.484514280899, 4536.138133754576, 3938.291107600602, 3953.1303113315025, 3961.5246170459727, 4001.099752555652, 4066.79666016698, 5481.068218402881, 5498.780048798003, 5500.42245564218, 5516.310461192351, 5565.471280228372, 5819.88360232793, 5861.648301101947, 5873.706314684248, 5878.323992740804, 5950.821475355746, 5421.891562168735, 5425.593080518976, 5465.808696695596, 5491.258680078218, 5538.141588053858, 4911.975440122848, 4967.627427942919, 4969.229769385751, 5010.849674509697, 5016.347874776256, 6015.849603759941, 6040.275166979991, 6042.184305118841, 6046.969765151146, 6048.455638992512, 5624.3250809903075, 5671.120976248523, 5802.1296805479515, 5815.069588865761, 5833.883322333445, 6025.337212906489, 6079.640721524511, 6089.821397607039, 6095.740618599674, 6097.97841994295, 5777.133429985536, 5779.364269930388, 5781.971090144522, 5783.392743761844, 5783.884322313615, 5692.117721753135, 5734.455226753452, 5787.36339002701, 5874.060150375919, 5877.794277200277, 5661.745221465127, 5674.319081710221, 5681.346645135863, 5696.1455781633085, 5787.045137552257, 5714.599978001666, 5715.9142612860005, 5723.656580605177, 5723.828285151452, 5725.083986562297, 5549.38956714753, 5597.860053498695, 5621.381648018796, 5629.605927585029, 5669.546436285004, 5760.193572899713, 5772.451617096369, 5782.392848750989, 5792.5655575832825, 5842.853928651818, 5590.105583106683, 5605.0, 5622.522085622768, 5645.181448689999, 5655.0], "value": 5376.944576419612, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2094463028607, 564.8531381840721, 596.3797650443539, 601.885641728072, 602.7317843559617, 30719.846400767994, 42193.367099493495, 43074.0, 43074.56925430745, 43096.78451607737, 44867.32699009509, 45078.0, 45317.32024019642, 45431.091378172416, 45480.09039819201, 8922.06318336575, 8998.370114092017, 9089.318301127409, 9091.318151138657, 9097.22673572747, 8813.603387847563, 8944.329175311845, 8959.73120806377, 8964.731058068235, 8976.955115224415, 8909.821803563926, 8965.282777377826, 8969.01340852509, 9002.054784247657, 9016.233620142295, 8897.288216942661, 8900.243479304267, 8948.955255223747, 8964.910350896505, 8976.192142707188, 8965.462072275684, 8976.910230897673, 8977.102289771035, 9004.054574269738, 9020.81958360829, 42524.36213456801, 43060.354094688606, 43182.784086079686, 43314.35028474576, 43347.34978975318, 3358.0, 3857.7492462990094, 4010.258102251093, 4035.2534781065597, 4095.1195492968855, 31502.212444688837, 31507.0, 31765.364692706247, 31860.362792744247, 33775.0, 3982.561918188997, 4025.7181997260204, 4089.427480152781, 4164.7917604119675, 4234.851780187679, 344568.0, 347276.0, 347721.0, 348059.0, 348586.0, 57474.71262643744, 58261.0, 58521.0, 58550.0, 58629.827403451694, 35742.821285893406, 36449.0, 36489.452658210146, 38374.424383634265, 58923.41076589265, 17017.0, 17172.141392930305, 17176.914115429343, 17177.742333865, 17302.826971730123, 13007.284599347127, 13027.283499407435, 13029.869701303056, 13126.14680045794, 13166.0, 18534.16596253172, 18669.719954200697, 18707.34524291643, 18741.34405295808, 18780.71828922567, 6698.296678848651, 6919.111323221631, 7109.360157585738, 7112.608806515588, 7204.9279507204255, 898.3576742628921, 927.638221093774, 977.8239916815041, 1017.7837484206302, 1109.755853712182, 31005.224869378446, 31911.52132718011, 31950.201244969063, 31997.840010800264, 32104.83947580247, 1116.1963386361806, 1120.4733775125678, 1150.465033759306, 1180.8346831443605, 1189.2804853063944, 16239.188040597923, 16887.324507019828, 16984.32062717502, 17035.48893533196, 17218.31126754941, 525178.0, 530430.0, 530818.0, 530834.0, 532124.0, 57278.42721572731, 57660.0, 57778.0, 57881.421185788444, 57909.4209057904, 1256.58532684214, 1326.2241588670543, 1333.7599232138114, 1348.2988845800326, 1355.2478374502246, 29772.702272976992, 30520.694793052673, 31045.534316984813, 31317.686823131477, 32040.359192815547, 49364.0, 49803.25295120649, 49951.50048499614, 50137.74931125321, 50162.498375015784, 469073.0, 472513.0, 475227.0, 475363.0, 476034.0, 28056.116209471642, 28793.85603071971, 28846.423071538873, 28934.565981509873, 29080.418391632473, 47054.0, 47227.52772472231, 47472.0, 47632.0, 52510.21234681559, 41719.16561668689, 41904.58095419007, 43171.35242971421, 43577.56422435862, 43841.12317753691, 41144.79427602843, 41596.96843957549, 42286.753164180234, 42631.147377052905, 42861.3570796432, 35246.11884702903, 36081.639183607826, 40839.0, 41293.58706413017, 42352.78823605862, 34595.65404346025, 37273.44089838709, 37330.81334593309, 37988.62011379961, 38066.238675226894, 28871.56692649654, 29089.854550727956, 29199.944093922415, 29359.55960660549, 29438.411231774815], "value": 19961.420023751838, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.64410852287205, 401.8131568820499, 401.97186196966226, 404.7065877239002, 420.0129695216242, 15857.286422111003, 18313.908430457846, 19338.903305483487, 20039.0, 20065.0, 18664.813351866476, 18914.243430262806, 19192.52018699533, 19256.0, 19351.225950961943, 5697.886042279152, 5730.541556675476, 5951.137085122655, 5993.28080630325, 6059.242594675666, 5751.913721294184, 5951.2858456985, 5970.641761494324, 5973.044312909935, 5986.371430999726, 5715.571332150084, 5760.107183386582, 5761.078227483604, 5766.0, 5767.682777447239, 5646.435356464321, 5768.336641286264, 5808.448197421239, 5821.155932389801, 5932.3474417814, 5816.418358164192, 5831.3877042910735, 5841.153032810261, 5841.532677385799, 5844.240248767675, 14127.64680882986, 19647.901760491248, 21953.67069493959, 22521.549569008526, 22541.098356065737, 2155.299527653503, 2196.1654571262816, 2494.7131079925857, 2543.923682289516, 2617.8036647251533, 10074.445905475195, 10139.797204055878, 10356.275060745751, 10743.83884241737, 10860.45697715111, 1916.629609828979, 1933.9129739161772, 1942.5629233422508, 1965.2924947019205, 1992.5516758729316, 82165.0, 83450.0, 85234.57382713108, 85252.31112288822, 86590.13409865947, 9356.906430935604, 9725.90274097264, 9814.705558833246, 9900.702978910644, 10344.793104137874, 12305.876941230652, 12952.611421657366, 13426.731465370833, 13458.259795711134, 13487.662808429868, 7909.960450197712, 7936.642851071716, 7957.164497727771, 8142.226488483703, 8226.424150309422, 7850.861625064448, 7923.247291507298, 8084.595770211466, 8093.8381232376205, 8187.058488273806, 4010.57888921659, 4067.206894655573, 4168.854090106832, 4217.283061879488, 4260.467441569804, 1988.2544045982756, 1988.8309493693198, 1996.2015193922548, 2018.4852862520256, 2059.814616684476, 903.823754367905, 976.9023097690174, 998.4608311511703, 1011.6863772230632, 1021.1218352217087, 19591.314303999578, 19755.802441975684, 20033.59932801336, 20044.098015589334, 20074.899625501777, 935.822193783179, 953.0564740906452, 956.1299217711849, 956.660385563129, 1091.5961094395125, 10379.96200379956, 10962.232643714864, 11016.511867904956, 11074.446277686084, 11145.777084458265, 443247.0, 448369.6467317957, 460798.0, 465914.0, 472982.0, 83674.58162709269, 83800.58099709463, 84782.15217847866, 85445.57277213699, 85859.57070214608, 953.7520244736419, 979.4759803505091, 1007.29992655104, 1011.9544620492095, 1012.0840639221516, 16721.247543860798, 16793.664126717642, 17126.571835703708, 17398.73901891447, 17526.649467010844, 40217.39673904952, 42109.0, 42160.0, 42594.0, 42872.78563607162, 56857.431425685216, 58097.12854307104, 58440.0, 58831.411685884304, 59172.40827591669, 6109.847253818512, 8503.937007874016, 8713.869291960498, 8987.236084932854, 9128.361014728906, 11589.884101159218, 13552.254625995665, 13628.0, 13639.0, 13676.863231367559, 11215.158863085464, 11449.313041217554, 11630.94184529072, 11840.0, 12125.029997600348, 11568.190226684052, 11571.768564628828, 11583.0, 12104.75790484203, 12258.938705306417, 11856.347900865536, 12028.218165819193, 12052.638420847388, 12102.878971210175, 12199.329036903055, 8480.915190848013, 8650.653973840976, 8778.517181555077, 8976.640934362553, 9077.546122693971, 10785.514651840844, 11485.598004069818, 11662.70843228926, 12155.635330940086, 12387.0], "value": 9117.610668300158, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.3068292561031, 1493.1638282561764, 1606.3815431059038, 1714.5113642611843, 1743.1545700335344, 7851.097123830761, 8072.0, 8567.742967710963, 9331.346805723602, 9343.01898300678, 8584.098669639692, 8758.737237882859, 8934.0, 9019.909800901989, 9088.272938164948, 2304.3662992677023, 2311.653252012203, 2324.9302520924316, 2324.9651255231183, 2356.8114550835976, 2329.452578644026, 2347.788699017088, 2402.0, 2404.5791986402396, 2412.2883749294, 2305.5158416732506, 2321.58211521926, 2323.0591610397814, 2325.2094287942095, 2350.8589484630893, 2292.33522278539, 2297.8851057447146, 2306.6655334976417, 2315.0392587076426, 2356.9528609427716, 2198.8131008864107, 2203.603351396748, 2212.9225477108384, 2215.5125872308067, 2223.844330896838, 8555.0, 8562.914370856273, 8570.18583234598, 8587.0, 8643.049264580892, 5130.7691153897795, 5293.973530132324, 5305.4164041955355, 5306.973465132688, 5329.920051199235, 3292.6378098409155, 3411.6325536546774, 3514.297140571896, 3527.8412471438846, 3548.716102711777, 1087.724186969416, 1129.6498085593491, 1138.7950168969583, 1147.305879942631, 1163.0463020323339, 12986.870131298661, 13020.934895325463, 13028.54400095992, 13033.86966130336, 13071.54249601269, 4575.519570445122, 4724.338592597039, 4772.902232486478, 4826.107170173529, 4950.900981980412, 10628.309159904582, 10764.192685548458, 10811.297265677706, 10829.404382758867, 10847.349159050482, 5140.46025167352, 5172.379314482287, 5182.0, 5183.2743415921805, 5198.402183748842, 4377.255866502702, 4514.119746649438, 4756.9762151189025, 4873.390826146731, 5018.347614810052, 3867.651911327938, 3976.76139431635, 4067.4102255172834, 4078.8164532596106, 4116.176764647083, 1304.6738315421144, 1348.7235116801032, 1353.9864601354057, 1357.592722183341, 1357.633438971472, 908.318760929303, 924.9409426206955, 938.6010945348336, 939.8872135343803, 960.9855852162223, 5646.0, 5696.259486266758, 5821.526224210788, 5904.084866845646, 5921.082232254007, 464.9279361698942, 471.93107611260524, 482.6910777102657, 484.7309743092547, 487.14262897301006, 3794.2032173243374, 3815.980920095382, 3867.3038853006165, 3945.585713500099, 3952.940705889414, 10896.128309735202, 11464.31214127155, 11471.885281147082, 11516.596919107958, 11544.538218471334, 10887.83668244977, 11105.72235694098, 11284.887151128547, 11287.322760634388, 11302.886971130183, 7975.401844861659, 8180.345572354317, 8365.832683346422, 8451.577421128919, 8453.535055572003, 6046.407297559933, 6126.877462450815, 6150.169727086786, 6232.594881332699, 6287.182666253358, 9857.0, 9888.752781180528, 9990.450525221182, 10068.093871551595, 10345.224108191765, 10142.949285253822, 10277.640282590073, 10408.583656653649, 10474.4239066849, 10503.579856805642, 7217.06178196831, 7442.665080071301, 7750.069991600819, 7828.45200835936, 7973.800654983672, 8176.550289734122, 8318.750437486886, 8483.618237179218, 8507.574621268788, 8529.061803201519, 7319.74380896666, 7498.287662672037, 7578.12851522082, 7608.581528016012, 7737.961310193413, 7303.926960730325, 7423.851522969402, 7588.013558237394, 7686.0, 7834.177411371952, 6785.762498312535, 6907.309269073053, 6947.409470194888, 6961.164660240601, 6987.755428559976, 5095.898082038412, 5151.201563757623, 5244.187150991603, 5263.736813159403, 5482.17767334887, 5127.948720512747, 5180.818671346485, 5274.024305503494, 5302.416734159162, 5311.5485183758265], "value": 4576.396225207358, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.1066673315713, 338.5886148329779, 345.28353666142755, 348.39379479705286, 351.1834983662984, 5556.222128901952, 5644.717764111793, 5647.632903861251, 5675.744591493382, 5677.9716101419535, 5510.421405752399, 5523.0, 5543.673795722564, 5575.721213939297, 5591.552675785927, 4028.5165780106427, 4069.613386728256, 4223.746575205498, 4256.531781504032, 4287.035417031158, 4312.331588603755, 4316.158349121923, 4318.488529014851, 4355.847545335914, 4356.869293921171, 4336.959129808854, 4342.370356298335, 4357.281048626973, 4364.869053928387, 4375.299952007679, 4279.593438623326, 4291.120320334339, 4304.526502084768, 4325.07010992635, 4337.869863904088, 3849.557300910375, 3849.903752406184, 3853.0542076251595, 3868.524144547464, 3876.6511014008875, 5414.891702165974, 5427.701476418795, 5439.0, 5443.0, 5445.591580631469, 4862.246351815475, 4939.394696723543, 4950.0, 4955.182394904837, 5018.473060328686, 5657.490825825655, 5685.403032681592, 5712.57155713319, 5781.884362312772, 5807.128930660392, 4190.245755763961, 4208.747475151501, 4217.957820421787, 4234.0, 4250.872473825791, 5770.278715160605, 5919.01089949577, 5935.465808077293, 5955.8213253602025, 6059.848503787396, 4323.935140972888, 4351.586599273064, 4362.454693163355, 4370.803313850821, 4373.278409062533, 4390.165868484977, 4390.429244198233, 4423.5576442355505, 4433.224185767478, 4451.577100175478, 4621.0, 4814.3390530267, 4817.13291607514, 4872.5138832655675, 4922.409310882717, 5738.110592858114, 5783.23611298558, 5799.710014499343, 5810.622309549865, 5908.675022873783, 1495.035701972222, 1497.7903093566908, 1498.5354540092605, 1508.328793686799, 1511.4960614188733, 934.3879758757888, 957.9425234485954, 968.4673429613684, 997.7029861180437, 1002.6891663584166, 5515.862103447446, 5528.364238112588, 5614.29821272341, 5629.943700562942, 5633.267675202197, 5867.647941123546, 5870.412958704095, 5883.794067207627, 5960.582759206901, 5965.612235204698, 5437.673739575638, 5505.917411238835, 5547.944520554824, 5576.414476479992, 5582.86042848932, 3089.1041597936346, 3100.8139511629374, 3114.9720592204517, 3144.748420126384, 3151.16494129056, 5964.671943043174, 6044.546659000593, 6116.0, 6121.173641558333, 6139.969300153471, 5900.436384358149, 5914.852128696817, 5968.22413086296, 6038.879222415527, 6049.304330002106, 6144.0, 6157.7229024694, 6158.753649854045, 6196.783112591128, 6205.379462053849, 5668.5465162787705, 5808.244928159313, 5841.415858414124, 5855.707214639337, 5856.648601083949, 5810.418958104325, 5847.210626565359, 5875.882482350415, 5880.676562789087, 5897.823065308047, 5942.58401911862, 5942.910856337245, 6109.877802443837, 6142.692865356804, 6161.6919154041225, 4154.293770059036, 4160.313548264502, 4171.561985991427, 4173.770442625685, 4234.449521562177, 5839.153322768259, 5844.240248767803, 5886.94113058864, 5888.676122813286, 5912.822615321547, 5430.972845135749, 5647.350554686263, 5656.434356564475, 5660.745266463102, 5720.914186287292, 5689.630174038674, 5705.7147142643535, 5734.283214598176, 5737.5983681141915, 5776.19133321327, 5384.70384128861, 5591.748371323219, 5602.13166959122, 5715.742791574306, 5717.08477659972, 5750.827475175584, 5848.84162552217, 5855.975204339138, 5872.970635146797, 5876.236089308362, 5775.480206781242, 5796.275465566804, 5824.534037276923, 5843.883122337445, 5856.4143585641095], "value": 4418.292333001006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.9160309159809, 725.6226762083717, 751.2937838431874, 775.8293175501387, 808.5593351623364, 15049.172295523742, 16173.999999999985, 16242.18789060548, 16254.756178657315, 16286.755698664529, 15119.395224191047, 15147.54557363278, 15197.088174709525, 15252.847471525281, 15264.542063738105, 757.6211894052974, 768.0552919908516, 784.2588753627824, 789.9210078992112, 791.6121100660664, 793.3851265269404, 793.5754371411296, 794.1145622630754, 794.5074054086446, 797.0714118052462, 824.6124321568853, 828.1759649149105, 833.8082241084554, 833.9166083391673, 839.7522730794431, 832.2551316571664, 833.3000279765026, 834.3283656656389, 834.4993004197494, 834.845553572591, 600.8467840700637, 608.2214765100679, 609.2932198649545, 609.4149616368292, 609.6860117039728, 14074.2962851857, 14096.365663545164, 14127.152370857679, 14130.85869141316, 14134.787978180335, 13792.0, 13909.652258693512, 14392.856071439257, 14473.927630361886, 14550.417983280762, 11416.600418985296, 11600.883991160064, 11621.302721836631, 11867.465964031553, 11975.28148311104, 3534.3284775892757, 3590.7666001709804, 3631.670478724715, 3656.634336566349, 3796.1079146400575, 76094.23905760983, 76565.0, 77691.22308776896, 80059.5997020017, 80265.0, 10482.63310784119, 10508.842367364496, 10555.0, 10866.239363244655, 10985.890141098647, 18953.810461895482, 18958.14688339028, 18973.241070357308, 18994.905025475062, 19018.239270429305, 7695.884561731578, 7978.082520510099, 8053.194680532017, 8086.070101938352, 8325.0, 4617.630589552895, 4748.7863046163, 4754.595859351924, 4819.518048195152, 4823.686460380064, 3495.632958539368, 3631.7276204284785, 3659.597444281127, 3666.1201311685004, 3669.889903302852, 581.2211636407235, 582.4001278682963, 587.3245767367476, 592.9347771745105, 605.4157737783061, 605.3885575568619, 698.996939391964, 717.2540557819809, 722.5917356693451, 731.7877815433571, 9049.638014479347, 9838.950805245928, 9854.310198286052, 10092.0, 10111.747206319753, 502.91450453423005, 624.8469125064388, 638.1990601794718, 652.2271108736163, 731.1956847467743, 4717.716936983792, 4900.828471003498, 4913.680610760289, 4920.975395123073, 5003.449620541737, 93649.0, 95207.52396237974, 97438.0, 115951.42024289824, 119774.0, 55584.0, 67505.0, 82647.0, 87837.56081219553, 96960.51519742356, 83705.58147209225, 83886.0, 84975.0, 86085.0, 88681.11318886858, 9046.457212567268, 9557.235421166151, 9651.469169195761, 9719.9028009719, 9784.804303914025, 50555.0, 51048.489515104375, 51091.744541277054, 51285.7435712834, 52240.0, 75236.62381688057, 75529.62235188788, 78631.60684196542, 78672.0, 79237.0, 11013.229073965065, 11135.443227838738, 11517.136214783757, 11616.244944078608, 11859.110566707704, 13776.0, 13816.861831381959, 14233.857661423253, 14445.85554144445, 15453.845461545241, 13462.326883655975, 13598.252096134807, 14149.221792801083, 14624.488142914946, 14742.0, 13170.670733231746, 13614.93192534031, 13687.384067717176, 13785.931070344584, 14250.358733856794, 12119.939400302943, 12386.347218278337, 12530.812037819258, 12675.746485070062, 12707.93646031764, 9664.420134791935, 9708.514574271117, 9899.65351212704, 10421.06210441064, 10447.0, 8052.194780522135, 8775.385722999328, 9190.54047297619, 9595.904040959502, 9731.951340243253], "value": 7272.002195343535, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 114.0, 114.0, 117.0, 115.0, 114.0, 114.0, 116.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 125.0, 173.0, 124.0, 125.0, 130.0, 121.0, 154.0, 125.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 167.0, 165.0, 162.0, 162.0, 164.0, 163.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 112.0, 77.0, 77.0, 77.0, 75.0, 107.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 107.0, 83.0, 83.0, 83.0, 101.0, 82.0, 86.0, 102.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 53.0, 53.0, 57.0, 54.0, 54.0, 55.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 82.0, 85.0, 81.0, 79.0, 79.0, 79.0, 79.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 135.0, 129.0, 126.0, 127.0, 140.0, 140.0, 183.0, 135.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 168.0, 173.0, 169.0, 169.0, 168.0, 166.0, 168.0, 168.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 65.0, 66.0, 67.0, 70.0, 65.0, 67.0, 66.0, 70.0], "value": 67.5, "unit": "score"}]}]} 09:56:02 INFO - Return code: 0 09:56:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:56:02 ERROR - # TBPL SUCCESS # 09:56:02 INFO - Running post-action listener: _resource_record_post_action 09:56:02 INFO - [mozharness: 2016-09-27 16:56:02.233119Z] Finished run-tests step (success) 09:56:02 INFO - Running post-run listener: _resource_record_post_run 09:56:02 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392282112; Read time: 20; Write time: 231356 09:56:02 INFO - TinderboxPrint: CPU usage
13.4% 09:56:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:56:02 INFO - TinderboxPrint: I/O write bytes / time
392,282,112 / 231,356 09:56:02 INFO - TinderboxPrint: CPU idle
8,255.0 (86.6%) 09:56:02 INFO - TinderboxPrint: CPU user
1,213.9 (12.7%) 09:56:02 INFO - TinderboxPrint: Swap in / out
0 / 0 09:56:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103952384; Read time: 0; Write time: 70324 09:56:02 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288329728; Read time: 0; Write time: 161032 09:56:02 INFO - Running post-run listener: _upload_blobber_files 09:56:02 INFO - Blob upload gear active. 09:56:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:56:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:56:02 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'] 09:56:02 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 09:56:03 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:56:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:56:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:04 INFO - (blobuploader) - INFO - Done attempting. 09:56:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:56:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:56:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:07 INFO - (blobuploader) - INFO - Done attempting. 09:56:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:56:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:08 INFO - (blobuploader) - INFO - Done attempting. 09:56:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:08 INFO - Return code: 0 09:56:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:56:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aab76b0cb2e7bf6df16cea574df378a3be1485cf2fbd64d9a8711cb00701fefc8cea3de50acbe4032081c9cadd10558ca5b8bf1bb93886407b61ab6d23534113", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ded6d4d5edbfb2d288b3e01f498d9f96d3497ed1a60697a205f1cb2eb854fbfeb75d14b161feaafed34ec47fd31a6edbf230b2a82df501279c1d92e6e336ce03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9045a89b5248bb10563c1fc76e31d8598d883dfdeaa2d969f4fd17f0902fc1640b987672ab91f50650e0021ff0595fb672c4c84352f635784c12b3cf81d99cd"} 09:56:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:56:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:56:08 INFO - Contents: 09:56:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aab76b0cb2e7bf6df16cea574df378a3be1485cf2fbd64d9a8711cb00701fefc8cea3de50acbe4032081c9cadd10558ca5b8bf1bb93886407b61ab6d23534113", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ded6d4d5edbfb2d288b3e01f498d9f96d3497ed1a60697a205f1cb2eb854fbfeb75d14b161feaafed34ec47fd31a6edbf230b2a82df501279c1d92e6e336ce03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9045a89b5248bb10563c1fc76e31d8598d883dfdeaa2d969f4fd17f0902fc1640b987672ab91f50650e0021ff0595fb672c4c84352f635784c12b3cf81d99cd"} 09:56:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:08 INFO - Copying logs to upload dir... 09:56:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:56:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.623729 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-27 09:56:08.226065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 09:56:08.229232) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aab76b0cb2e7bf6df16cea574df378a3be1485cf2fbd64d9a8711cb00701fefc8cea3de50acbe4032081c9cadd10558ca5b8bf1bb93886407b61ab6d23534113", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ded6d4d5edbfb2d288b3e01f498d9f96d3497ed1a60697a205f1cb2eb854fbfeb75d14b161feaafed34ec47fd31a6edbf230b2a82df501279c1d92e6e336ce03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9045a89b5248bb10563c1fc76e31d8598d883dfdeaa2d969f4fd17f0902fc1640b987672ab91f50650e0021ff0595fb672c4c84352f635784c12b3cf81d99cd"} build_url:https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/Tz731C6cQJ-unKVkKathsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aab76b0cb2e7bf6df16cea574df378a3be1485cf2fbd64d9a8711cb00701fefc8cea3de50acbe4032081c9cadd10558ca5b8bf1bb93886407b61ab6d23534113", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ded6d4d5edbfb2d288b3e01f498d9f96d3497ed1a60697a205f1cb2eb854fbfeb75d14b161feaafed34ec47fd31a6edbf230b2a82df501279c1d92e6e336ce03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9045a89b5248bb10563c1fc76e31d8598d883dfdeaa2d969f4fd17f0902fc1640b987672ab91f50650e0021ff0595fb672c4c84352f635784c12b3cf81d99cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 09:56:08.259296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 09:56:08.259640) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1474994128.539913-71069136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 09:56:08.344808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 09:56:08.345596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 09:56:08.346295) ========= ========= Total master_lag: 0.20 =========