builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1474659858.36 results: success (0) buildid: 20160923093042 builduid: 69e2f772420848c1a28fdf33e622a6a7 revision: a18668c1ff8da7e0b6b6945a4186448762064d7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:18.355698) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:18.356260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:18.356583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:18.371555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:18.371909) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 12:44:18-- 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% 21.6M=0.001s 2016-09-23 12:44:18 (21.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127564 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:18.514014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:18.514395) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:18.565509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 12:44:18.565999) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a18668c1ff8da7e0b6b6945a4186448762064d7c --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 a18668c1ff8da7e0b6b6945a4186448762064d7c --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=8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 12:44:18,694 truncating revision to first 12 chars 2016-09-23 12:44:18,694 Setting DEBUG logging. 2016-09-23 12:44:18,694 attempt 1/10 2016-09-23 12:44:18,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a18668c1ff8d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 12:44:19,777 unpacking tar archive at: fx-team-a18668c1ff8d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.514225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 12:44:20.095519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:20.095910) ========= script_repo_revision: a18668c1ff8da7e0b6b6945a4186448762064d7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:20.096379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:20.096706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 12:44:20.106531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-23 12:44:20.106974) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:44:20 INFO - MultiFileLogger online at 20160923 12:44:20 in /builds/slave/test 12:44:20 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 12:44:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:44:20 INFO - {'append_to_log': False, 12:44:20 INFO - 'base_work_dir': '/builds/slave/test', 12:44:20 INFO - 'blob_upload_branch': 'Fx-Team', 12:44:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:44:20 INFO - 'branch': 'Fx-Team', 12:44:20 INFO - 'buildbot_json_path': 'buildprops.json', 12:44:20 INFO - 'config_files': ('talos/linux_config.py',), 12:44:20 INFO - 'default_actions': ('clobber', 12:44:20 INFO - 'read-buildbot-config', 12:44:20 INFO - 'download-and-extract', 12:44:20 INFO - 'populate-webroot', 12:44:20 INFO - 'create-virtualenv', 12:44:20 INFO - 'install', 12:44:20 INFO - 'run-tests'), 12:44:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:44:20 INFO - 'download_minidump_stackwalk': True, 12:44:20 INFO - 'download_symbols': 'ondemand', 12:44:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:44:20 INFO - 'tooltool.py': '/tools/tooltool.py', 12:44:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:44:20 INFO - '/tools/misc-python/virtualenv.py')}, 12:44:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:44:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:44:20 INFO - 'installer_path': 'installer.exe', 12:44:20 INFO - 'log_level': 'info', 12:44:20 INFO - 'log_name': 'talos', 12:44:20 INFO - 'log_to_console': True, 12:44:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:44:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:44:20 INFO - 'opt_config_files': (), 12:44:20 INFO - 'pip_index': False, 12:44:20 INFO - 'sps_profile': False, 12:44:20 INFO - 'sps_profile_interval': 0, 12:44:20 INFO - 'suite': 'dromaeojs-e10s', 12:44:20 INFO - 'system_bits': '32', 12:44:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:44:20 INFO - 'title': 'talos-linux64-ix-041', 12:44:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:44:20 INFO - 'use_talos_json': True, 12:44:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:44:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:44:20 INFO - 'work_dir': 'build'} 12:44:20 INFO - [mozharness: 2016-09-23 19:44:20.330434Z] Running clobber step. 12:44:20 INFO - Running pre-action listener: _resource_record_pre_action 12:44:20 INFO - Running main action method: clobber 12:44:20 INFO - rmtree: /builds/slave/test/build 12:44:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:44:20 INFO - Running post-action listener: _resource_record_post_action 12:44:20 INFO - [mozharness: 2016-09-23 19:44:20.790962Z] Finished clobber step (success) 12:44:20 INFO - [mozharness: 2016-09-23 19:44:20.791062Z] Running read-buildbot-config step. 12:44:20 INFO - Running pre-action listener: _resource_record_pre_action 12:44:20 INFO - Running main action method: read_buildbot_config 12:44:20 INFO - Using buildbot properties: 12:44:20 INFO - { 12:44:20 INFO - "project": "", 12:44:20 INFO - "product": "firefox", 12:44:20 INFO - "script_repo_revision": "production", 12:44:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:44:20 INFO - "repository": "", 12:44:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:44:20 INFO - "buildid": "20160923093042", 12:44:20 INFO - "pgo_build": "True", 12:44:20 INFO - "basedir": "/builds/slave/test", 12:44:20 INFO - "buildnumber": 801, 12:44:20 INFO - "slavename": "talos-linux64-ix-041", 12:44:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:44:20 INFO - "platform": "ubuntu64_hw", 12:44:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:44:20 INFO - "branch": "fx-team", 12:44:20 INFO - "repo_path": "integration/fx-team", 12:44:20 INFO - "revision": "a18668c1ff8da7e0b6b6945a4186448762064d7c", 12:44:20 INFO - "stage_platform": "linux64-pgo", 12:44:20 INFO - "builduid": "69e2f772420848c1a28fdf33e622a6a7", 12:44:20 INFO - "slavebuilddir": "test" 12:44:20 INFO - } 12:44:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:44:20 INFO - Running post-action listener: _resource_record_post_action 12:44:20 INFO - [mozharness: 2016-09-23 19:44:20.793775Z] Finished read-buildbot-config step (success) 12:44:20 INFO - [mozharness: 2016-09-23 19:44:20.793866Z] Running download-and-extract step. 12:44:20 INFO - Running pre-action listener: _resource_record_pre_action 12:44:20 INFO - Running main action method: download_and_extract 12:44:20 INFO - mkdir: /builds/slave/test/build/tests 12:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:44:20 INFO - trying https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:44:20 INFO - Downloading https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/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 12:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/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 12:44:21 INFO - Downloaded 1361 bytes. 12:44:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:44:21 INFO - Using the following test package requirements: 12:44:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:44:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:44:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:21 INFO - u'jsshell-linux-x86_64.zip'], 12:44:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:44:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:44:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:44:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:44:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:44:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:44:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:44:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:44:21 INFO - Fetch https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:44:21 INFO - Expected file size: 21947975 12:44:26 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 12:44:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:44:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:44:26 INFO - Fetch https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:44:26 INFO - Expected file size: 21947975 12:44:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:44:31 INFO - Fetch https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:44:32 INFO - Expected file size: 14414059 12:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:44:32 INFO - trying https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:44:32 INFO - Downloading https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/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 12:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/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 12:44:33 INFO - Downloaded 59699753 bytes. 12:44:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:44:33 INFO - mkdir: /builds/slave/test/properties 12:44:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:44:33 INFO - Writing to file /builds/slave/test/properties/build_url 12:44:33 INFO - Contents: 12:44:33 INFO - build_url:https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:44:34 INFO - Running post-action listener: _resource_record_post_action 12:44:34 INFO - Running post-action listener: set_extra_try_arguments 12:44:34 INFO - [mozharness: 2016-09-23 19:44:34.517905Z] Finished download-and-extract step (success) 12:44:34 INFO - [mozharness: 2016-09-23 19:44:34.518133Z] Running populate-webroot step. 12:44:34 INFO - Running pre-action listener: _resource_record_pre_action 12:44:34 INFO - Running main action method: populate_webroot 12:44:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:44:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:44:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:44:34 INFO - '--tppagecycles', 12:44:34 INFO - '7'], 12:44:34 INFO - 'tests': ['tsvgm']}}, 12:44:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:44:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:44:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:44:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:44:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:34 INFO - 'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:44:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:44:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:34 INFO - 'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['damp', 'tps']}, 12:44:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:34 INFO - 'tests': ['damp', 'tps']}, 12:44:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['dromaeo_dom']}, 12:44:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:44:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['basic_compositor_video']}, 12:44:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:44:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['a11yr', 12:44:34 INFO - 'ts_paint', 12:44:34 INFO - 'tpaint', 12:44:34 INFO - 'sessionrestore', 12:44:34 INFO - 'sessionrestore_no_auto_restore', 12:44:34 INFO - 'tabpaint']}, 12:44:34 INFO - 'other-e10s': {'tests': ['a11yr', 12:44:34 INFO - 'ts_paint', 12:44:34 INFO - 'tpaint', 12:44:34 INFO - 'sessionrestore', 12:44:34 INFO - 'sessionrestore_no_auto_restore', 12:44:34 INFO - 'tabpaint']}, 12:44:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:44:34 INFO - 'ts_paint', 12:44:34 INFO - 'tpaint', 12:44:34 INFO - 'sessionrestore', 12:44:34 INFO - 'sessionrestore_no_auto_restore', 12:44:34 INFO - 'tabpaint']}, 12:44:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:44:34 INFO - 'ts_paint', 12:44:34 INFO - 'tpaint', 12:44:34 INFO - 'sessionrestore', 12:44:34 INFO - 'sessionrestore_no_auto_restore', 12:44:34 INFO - 'tabpaint']}, 12:44:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['a11yr', 12:44:34 INFO - 'ts_paint', 12:44:34 INFO - 'tpaint', 12:44:34 INFO - 'sessionrestore', 12:44:34 INFO - 'sessionrestore_no_auto_restore', 12:44:34 INFO - 'tabpaint']}, 12:44:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['a11yr', 12:44:34 INFO - 'ts_paint', 12:44:34 INFO - 'tpaint', 12:44:34 INFO - 'sessionrestore', 12:44:34 INFO - 'sessionrestore_no_auto_restore', 12:44:34 INFO - 'tabpaint']}, 12:44:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['tsvgx', 12:44:34 INFO - 'tsvgr_opacity', 12:44:34 INFO - 'tart', 12:44:34 INFO - 'tscrollx', 12:44:34 INFO - 'cart']}, 12:44:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:44:34 INFO - 'tsvgr_opacity', 12:44:34 INFO - 'tart', 12:44:34 INFO - 'tscrollx', 12:44:34 INFO - 'cart']}, 12:44:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:34 INFO - 'talos_options': ['--disable-e10s'], 12:44:34 INFO - 'tests': ['tp5o']}, 12:44:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:34 INFO - 'tests': ['tp5o']}, 12:44:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:34 INFO - 'talos_options': ['--disable-e10s', 12:44:34 INFO - '--xperf_path', 12:44:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:44:34 INFO - 'tests': ['tp5n']}, 12:44:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:34 INFO - 'talos_options': ['--xperf_path', 12:44:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:44:34 INFO - 'tests': ['tp5n']}}, 12:44:34 INFO - 'talos.zip': {'path': '', 12:44:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:44:34 INFO - Running post-action listener: _resource_record_post_action 12:44:34 INFO - [mozharness: 2016-09-23 19:44:34.536148Z] Finished populate-webroot step (success) 12:44:34 INFO - [mozharness: 2016-09-23 19:44:34.536237Z] Running create-virtualenv step. 12:44:34 INFO - Running pre-action listener: _resource_record_pre_action 12:44:34 INFO - Running main action method: create_virtualenv 12:44:34 INFO - Creating virtualenv /builds/slave/test/build/venv 12:44:34 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 12:44:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:44:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:44:34 INFO - Using real prefix '/usr' 12:44:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:44:35 INFO - Installing distribute.............................................................................................................................................................................................done. 12:44:37 INFO - Installing pip.................done. 12:44:37 INFO - Return code: 0 12:44:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:44:37 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')]} 12:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:37 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')]} 12:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:37 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 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:37 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 12:44:37 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 12:44:37 INFO - Using env: {'DISPLAY': ':0', 12:44:37 INFO - 'HOME': '/home/cltbld', 12:44:37 INFO - 'LANG': 'en_US.UTF-8', 12:44:37 INFO - 'LANGUAGE': 'en_US:en', 12:44:37 INFO - 'LOGNAME': 'cltbld', 12:44:37 INFO - 'MAIL': '/var/mail/cltbld', 12:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:37 INFO - 'MOZ_NO_REMOTE': '1', 12:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:37 INFO - 'NO_EM_RESTART': '1', 12:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:37 INFO - 'PWD': '/builds/slave/test', 12:44:37 INFO - 'SHELL': '/bin/bash', 12:44:37 INFO - 'SHLVL': '1', 12:44:37 INFO - 'TERM': 'linux', 12:44:37 INFO - 'TMOUT': '86400', 12:44:37 INFO - 'USER': 'cltbld', 12:44:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:37 INFO - '_': '/tools/buildbot/bin/python'} 12:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:37 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 12:44:37 INFO - Cleaning up... 12:44:37 INFO - Return code: 0 12:44:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:44:37 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')]} 12:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:37 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')]} 12:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:37 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 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:37 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 12:44:37 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 12:44:37 INFO - Using env: {'DISPLAY': ':0', 12:44:37 INFO - 'HOME': '/home/cltbld', 12:44:37 INFO - 'LANG': 'en_US.UTF-8', 12:44:37 INFO - 'LANGUAGE': 'en_US:en', 12:44:37 INFO - 'LOGNAME': 'cltbld', 12:44:37 INFO - 'MAIL': '/var/mail/cltbld', 12:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:37 INFO - 'MOZ_NO_REMOTE': '1', 12:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:37 INFO - 'NO_EM_RESTART': '1', 12:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:37 INFO - 'PWD': '/builds/slave/test', 12:44:37 INFO - 'SHELL': '/bin/bash', 12:44:37 INFO - 'SHLVL': '1', 12:44:37 INFO - 'TERM': 'linux', 12:44:37 INFO - 'TMOUT': '86400', 12:44:37 INFO - 'USER': 'cltbld', 12:44:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:37 INFO - '_': '/tools/buildbot/bin/python'} 12:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:37 INFO - Downloading/unpacking psutil>=3.1.1 12:44:37 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 12:44:37 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 12:44:37 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 12:44:37 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 12:44:37 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 12:44:37 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 12:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:44:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:44:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:44:39 INFO - Installing collected packages: psutil 12:44:39 INFO - Running setup.py install for psutil 12:44:39 INFO - building 'psutil._psutil_linux' extension 12:44:39 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 12:44:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:44:39 INFO - building 'psutil._psutil_posix' extension 12:44:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:44:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:44:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:44:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:44:40 INFO - Successfully installed psutil 12:44:40 INFO - Cleaning up... 12:44:40 INFO - Return code: 0 12:44:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:44:40 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')]} 12:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:40 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')]} 12:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:40 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 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:40 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 12:44:40 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 12:44:40 INFO - Using env: {'DISPLAY': ':0', 12:44:40 INFO - 'HOME': '/home/cltbld', 12:44:40 INFO - 'LANG': 'en_US.UTF-8', 12:44:40 INFO - 'LANGUAGE': 'en_US:en', 12:44:40 INFO - 'LOGNAME': 'cltbld', 12:44:40 INFO - 'MAIL': '/var/mail/cltbld', 12:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:40 INFO - 'MOZ_NO_REMOTE': '1', 12:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:40 INFO - 'NO_EM_RESTART': '1', 12:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:40 INFO - 'PWD': '/builds/slave/test', 12:44:40 INFO - 'SHELL': '/bin/bash', 12:44:40 INFO - 'SHLVL': '1', 12:44:40 INFO - 'TERM': 'linux', 12:44:40 INFO - 'TMOUT': '86400', 12:44:40 INFO - 'USER': 'cltbld', 12:44:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:40 INFO - '_': '/tools/buildbot/bin/python'} 12:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:44:42 INFO - Installing collected packages: mozsystemmonitor 12:44:42 INFO - Running setup.py install for mozsystemmonitor 12:44:42 INFO - Successfully installed mozsystemmonitor 12:44:42 INFO - Cleaning up... 12:44:42 INFO - Return code: 0 12:44:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:44:42 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')]} 12:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:42 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')]} 12:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:42 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 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:42 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 12:44:42 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 12:44:42 INFO - Using env: {'DISPLAY': ':0', 12:44:42 INFO - 'HOME': '/home/cltbld', 12:44:42 INFO - 'LANG': 'en_US.UTF-8', 12:44:42 INFO - 'LANGUAGE': 'en_US:en', 12:44:42 INFO - 'LOGNAME': 'cltbld', 12:44:42 INFO - 'MAIL': '/var/mail/cltbld', 12:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:42 INFO - 'MOZ_NO_REMOTE': '1', 12:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:42 INFO - 'NO_EM_RESTART': '1', 12:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:42 INFO - 'PWD': '/builds/slave/test', 12:44:42 INFO - 'SHELL': '/bin/bash', 12:44:42 INFO - 'SHLVL': '1', 12:44:42 INFO - 'TERM': 'linux', 12:44:42 INFO - 'TMOUT': '86400', 12:44:42 INFO - 'USER': 'cltbld', 12:44:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:42 INFO - '_': '/tools/buildbot/bin/python'} 12:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:42 INFO - Downloading/unpacking jsonschema==2.5.1 12:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:44:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:44 INFO - Downloading functools32-3.2.3-2.tar.gz 12:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:44:44 INFO - warning: no files found matching '*.txt' 12:44:44 INFO - no previously-included directories found matching 'build' 12:44:44 INFO - no previously-included directories found matching 'dist' 12:44:44 INFO - no previously-included directories found matching '.git*' 12:44:44 INFO - Installing collected packages: jsonschema, functools32 12:44:44 INFO - Running setup.py install for functools32 12:44:44 INFO - warning: no files found matching '*.txt' 12:44:44 INFO - no previously-included directories found matching 'build' 12:44:44 INFO - no previously-included directories found matching 'dist' 12:44:44 INFO - no previously-included directories found matching '.git*' 12:44:44 INFO - Successfully installed jsonschema functools32 12:44:44 INFO - Cleaning up... 12:44:44 INFO - Return code: 0 12:44:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:44:44 INFO - Using env: {'DISPLAY': ':0', 12:44:44 INFO - 'HOME': '/home/cltbld', 12:44:44 INFO - 'LANG': 'en_US.UTF-8', 12:44:44 INFO - 'LANGUAGE': 'en_US:en', 12:44:44 INFO - 'LOGNAME': 'cltbld', 12:44:44 INFO - 'MAIL': '/var/mail/cltbld', 12:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:44 INFO - 'MOZ_NO_REMOTE': '1', 12:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:44 INFO - 'NO_EM_RESTART': '1', 12:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:44 INFO - 'PWD': '/builds/slave/test', 12:44:44 INFO - 'SHELL': '/bin/bash', 12:44:44 INFO - 'SHLVL': '1', 12:44:45 INFO - 'TERM': 'linux', 12:44:45 INFO - 'TMOUT': '86400', 12:44:45 INFO - 'USER': 'cltbld', 12:44:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:45 INFO - '_': '/tools/buildbot/bin/python'} 12:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:44:45 INFO - Cleaning up... 12:44:45 INFO - Return code: 0 12:44:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:44:45 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')]} 12:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:45 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')]} 12:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:45 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 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:45 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 12:44:45 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 12:44:45 INFO - Using env: {'DISPLAY': ':0', 12:44:45 INFO - 'HOME': '/home/cltbld', 12:44:45 INFO - 'LANG': 'en_US.UTF-8', 12:44:45 INFO - 'LANGUAGE': 'en_US:en', 12:44:45 INFO - 'LOGNAME': 'cltbld', 12:44:45 INFO - 'MAIL': '/var/mail/cltbld', 12:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:45 INFO - 'MOZ_NO_REMOTE': '1', 12:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:45 INFO - 'NO_EM_RESTART': '1', 12:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:45 INFO - 'PWD': '/builds/slave/test', 12:44:45 INFO - 'SHELL': '/bin/bash', 12:44:45 INFO - 'SHLVL': '1', 12:44:45 INFO - 'TERM': 'linux', 12:44:45 INFO - 'TMOUT': '86400', 12:44:45 INFO - 'USER': 'cltbld', 12:44:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:45 INFO - '_': '/tools/buildbot/bin/python'} 12:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:45 INFO - Downloading/unpacking blobuploader==1.2.4 12:44:45 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 12:44:45 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 12:44:45 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 12:44:45 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 12:44:45 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 12:44:45 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 12:44:47 INFO - Downloading blobuploader-1.2.4.tar.gz 12:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:44:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:44:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:48 INFO - Downloading docopt-0.6.1.tar.gz 12:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:44:48 INFO - Installing collected packages: blobuploader, requests, docopt 12:44:48 INFO - Running setup.py install for blobuploader 12:44:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:44:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:44:48 INFO - Running setup.py install for requests 12:44:48 INFO - Running setup.py install for docopt 12:44:48 INFO - Successfully installed blobuploader requests docopt 12:44:48 INFO - Cleaning up... 12:44:48 INFO - Return code: 0 12:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44: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')]} 12:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44: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')]} 12:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:44:48 INFO - Using env: {'DISPLAY': ':0', 12:44:48 INFO - 'HOME': '/home/cltbld', 12:44:48 INFO - 'LANG': 'en_US.UTF-8', 12:44:48 INFO - 'LANGUAGE': 'en_US:en', 12:44:48 INFO - 'LOGNAME': 'cltbld', 12:44:48 INFO - 'MAIL': '/var/mail/cltbld', 12:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:48 INFO - 'MOZ_NO_REMOTE': '1', 12:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:48 INFO - 'NO_EM_RESTART': '1', 12:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:48 INFO - 'PWD': '/builds/slave/test', 12:44:48 INFO - 'SHELL': '/bin/bash', 12:44:48 INFO - 'SHLVL': '1', 12:44:48 INFO - 'TERM': 'linux', 12:44:48 INFO - 'TMOUT': '86400', 12:44:48 INFO - 'USER': 'cltbld', 12:44:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:48 INFO - '_': '/tools/buildbot/bin/python'} 12:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:44:48 INFO - Running setup.py (path:/tmp/pip-uWfujz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:44:48 INFO - Running setup.py (path:/tmp/pip-ALB1va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:44:49 INFO - Running setup.py (path:/tmp/pip-iW1XOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:44:49 INFO - Running setup.py (path:/tmp/pip-5O3KRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:44:49 INFO - Running setup.py (path:/tmp/pip-nIjQch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:44:49 INFO - Running setup.py (path:/tmp/pip-tUp9sP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:44:49 INFO - Running setup.py (path:/tmp/pip-OQWDOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:44:49 INFO - Running setup.py (path:/tmp/pip-yZVSH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:44:49 INFO - Running setup.py (path:/tmp/pip-PJA64Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:44:49 INFO - Running setup.py (path:/tmp/pip-2G0NOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:44:49 INFO - Running setup.py (path:/tmp/pip-bjU7v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:44:49 INFO - Running setup.py (path:/tmp/pip-yYv8lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:44:49 INFO - Running setup.py (path:/tmp/pip-xdchlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:44:49 INFO - Running setup.py (path:/tmp/pip-Sx3AN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:49 INFO - Running setup.py (path:/tmp/pip-XMKHo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:44:49 INFO - Running setup.py (path:/tmp/pip-LD3vds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:44:50 INFO - Running setup.py (path:/tmp/pip-6ZpvbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:44:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:44:50 INFO - Running setup.py install for manifestparser 12:44:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Running setup.py install for mozcrash 12:44:50 INFO - Running setup.py install for mozdebug 12:44:50 INFO - Running setup.py install for mozdevice 12:44:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Running setup.py install for mozfile 12:44:50 INFO - Running setup.py install for mozhttpd 12:44:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Running setup.py install for mozinfo 12:44:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Running setup.py install for mozInstall 12:44:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:44:50 INFO - Running setup.py install for mozleak 12:44:51 INFO - Running setup.py install for mozlog 12:44:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:44:51 INFO - Running setup.py install for moznetwork 12:44:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:44:51 INFO - Running setup.py install for mozprocess 12:44:51 INFO - Running setup.py install for mozprofile 12:44:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:44:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:44:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:44:51 INFO - Running setup.py install for mozrunner 12:44:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:44:51 INFO - Running setup.py install for mozscreenshot 12:44:51 INFO - Running setup.py install for moztest 12:44:51 INFO - Running setup.py install for mozversion 12:44:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:44:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:44:51 INFO - Cleaning up... 12:44:51 INFO - Return code: 0 12:44:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44: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')]} 12:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44: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')]} 12:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:44:51 INFO - Using env: {'DISPLAY': ':0', 12:44:51 INFO - 'HOME': '/home/cltbld', 12:44:51 INFO - 'LANG': 'en_US.UTF-8', 12:44:51 INFO - 'LANGUAGE': 'en_US:en', 12:44:51 INFO - 'LOGNAME': 'cltbld', 12:44:51 INFO - 'MAIL': '/var/mail/cltbld', 12:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:51 INFO - 'MOZ_NO_REMOTE': '1', 12:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:51 INFO - 'NO_EM_RESTART': '1', 12:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:51 INFO - 'PWD': '/builds/slave/test', 12:44:51 INFO - 'SHELL': '/bin/bash', 12:44:51 INFO - 'SHLVL': '1', 12:44:51 INFO - 'TERM': 'linux', 12:44:51 INFO - 'TMOUT': '86400', 12:44:51 INFO - 'USER': 'cltbld', 12:44:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:51 INFO - '_': '/tools/buildbot/bin/python'} 12:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:44:52 INFO - Running setup.py (path:/tmp/pip-MRzyyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:44:52 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)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:44:52 INFO - Running setup.py (path:/tmp/pip-iIvZTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:44:52 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)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:44:52 INFO - Running setup.py (path:/tmp/pip-NJg0o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:44:52 INFO - Running setup.py (path:/tmp/pip-L6VSqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:44:52 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)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:44:52 INFO - Running setup.py (path:/tmp/pip-1a8FsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:44:52 INFO - Running setup.py (path:/tmp/pip-qf6ZVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:44:52 INFO - Running setup.py (path:/tmp/pip-f6VNkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:44:52 INFO - Running setup.py (path:/tmp/pip-xl2xe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:44:52 INFO - Running setup.py (path:/tmp/pip-LnznKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:44:52 INFO - Running setup.py (path:/tmp/pip-e9TBk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:44:52 INFO - Running setup.py (path:/tmp/pip-d2r8PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:44:52 INFO - Running setup.py (path:/tmp/pip-CZBACD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:44:53 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)) 12:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:44:53 INFO - Running setup.py (path:/tmp/pip-LhgBzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:44:53 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)) 12:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:44:53 INFO - Running setup.py (path:/tmp/pip-TbmxNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:44:53 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)) 12:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:53 INFO - Running setup.py (path:/tmp/pip-fyhKjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:53 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)) 12:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:44:53 INFO - Running setup.py (path:/tmp/pip-vuYTZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:44:53 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)) 12:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:44:53 INFO - Running setup.py (path:/tmp/pip-tTHBUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:44:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:44: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 12:44: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 12:44: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 12:44: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 12:44: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 12:44: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 12:44:55 INFO - Downloading blessings-1.6.tar.gz 12:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:44:55 INFO - Installing collected packages: blessings 12:44:55 INFO - Running setup.py install for blessings 12:44:55 INFO - Successfully installed blessings 12:44:55 INFO - Cleaning up... 12:44:55 INFO - Return code: 0 12:44:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:44:55 INFO - Reading from file tmpfile_stdout 12:44:55 INFO - Current package versions: 12:44:55 INFO - argparse == 1.2.1 12:44:55 INFO - blessings == 1.6 12:44:55 INFO - blobuploader == 1.2.4 12:44:55 INFO - docopt == 0.6.1 12:44:55 INFO - functools32 == 3.2.3-2 12:44:55 INFO - jsonschema == 2.5.1 12:44:55 INFO - manifestparser == 1.1 12:44:55 INFO - mozInstall == 1.12 12:44:55 INFO - mozcrash == 0.17 12:44:55 INFO - mozdebug == 0.1 12:44:55 INFO - mozdevice == 0.48 12:44:55 INFO - mozfile == 1.2 12:44:55 INFO - mozhttpd == 0.7 12:44:55 INFO - mozinfo == 0.9 12:44:55 INFO - mozleak == 0.1 12:44:55 INFO - mozlog == 3.4 12:44:55 INFO - moznetwork == 0.27 12:44:55 INFO - mozprocess == 0.23 12:44:55 INFO - mozprofile == 0.28 12:44:55 INFO - mozrunner == 6.12 12:44:55 INFO - mozscreenshot == 0.1 12:44:55 INFO - mozsystemmonitor == 0.3 12:44:55 INFO - moztest == 0.7 12:44:55 INFO - mozversion == 1.4 12:44:55 INFO - psutil == 3.1.1 12:44:55 INFO - requests == 1.2.3 12:44:55 INFO - wsgiref == 0.1.2 12:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44: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')]} 12:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44: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')]} 12:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:44:55 INFO - Using env: {'DISPLAY': ':0', 12:44:55 INFO - 'HOME': '/home/cltbld', 12:44:55 INFO - 'LANG': 'en_US.UTF-8', 12:44:55 INFO - 'LANGUAGE': 'en_US:en', 12:44:55 INFO - 'LOGNAME': 'cltbld', 12:44:55 INFO - 'MAIL': '/var/mail/cltbld', 12:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:55 INFO - 'MOZ_NO_REMOTE': '1', 12:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:55 INFO - 'NO_EM_RESTART': '1', 12:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:55 INFO - 'PWD': '/builds/slave/test', 12:44:55 INFO - 'SHELL': '/bin/bash', 12:44:55 INFO - 'SHLVL': '1', 12:44:55 INFO - 'TERM': 'linux', 12:44:55 INFO - 'TMOUT': '86400', 12:44:55 INFO - 'USER': 'cltbld', 12:44:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:55 INFO - '_': '/tools/buildbot/bin/python'} 12:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:44:55 INFO - Cleaning up... 12:44:55 INFO - Return code: 0 12:44:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:44: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')]} 12:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44: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')]} 12:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f013221bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2483c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', '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 12:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:44:55 INFO - Using env: {'DISPLAY': ':0', 12:44:55 INFO - 'HOME': '/home/cltbld', 12:44:55 INFO - 'LANG': 'en_US.UTF-8', 12:44:55 INFO - 'LANGUAGE': 'en_US:en', 12:44:55 INFO - 'LOGNAME': 'cltbld', 12:44:55 INFO - 'MAIL': '/var/mail/cltbld', 12:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:55 INFO - 'MOZ_NO_REMOTE': '1', 12:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:55 INFO - 'NO_EM_RESTART': '1', 12:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:55 INFO - 'PWD': '/builds/slave/test', 12:44:55 INFO - 'SHELL': '/bin/bash', 12:44:55 INFO - 'SHLVL': '1', 12:44:55 INFO - 'TERM': 'linux', 12:44:55 INFO - 'TMOUT': '86400', 12:44:55 INFO - 'USER': 'cltbld', 12:44:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:55 INFO - '_': '/tools/buildbot/bin/python'} 12:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:44:56 INFO - Cleaning up... 12:44:56 INFO - Return code: 0 12:44:56 INFO - Running post-action listener: _resource_record_post_action 12:44:56 INFO - Running post-action listener: _start_resource_monitoring 12:44:56 INFO - Starting resource monitoring. 12:44:56 INFO - [mozharness: 2016-09-23 19:44:56.223183Z] Finished create-virtualenv step (success) 12:44:56 INFO - [mozharness: 2016-09-23 19:44:56.223690Z] Running install step. 12:44:56 INFO - Running pre-action listener: _resource_record_pre_action 12:44:56 INFO - Running main action method: install 12:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:44:56 INFO - Reading from file tmpfile_stdout 12:44:56 INFO - Detecting whether we're running mozinstall >=1.0... 12:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:44:56 INFO - Reading from file tmpfile_stdout 12:44:56 INFO - Output received: 12:44:56 INFO - Usage: mozinstall [options] installer 12:44:56 INFO - Options: 12:44:56 INFO - -h, --help show this help message and exit 12:44:56 INFO - -d DEST, --destination=DEST 12:44:56 INFO - Directory to install application into. [default: 12:44:56 INFO - "/builds/slave/test"] 12:44:56 INFO - --app=APP Application being installed. [default: firefox] 12:44:56 INFO - mkdir: /builds/slave/test/build/application 12:44:56 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'] 12:44:56 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 12:45:13 INFO - Reading from file tmpfile_stdout 12:45:13 INFO - Output received: 12:45:13 INFO - /builds/slave/test/build/application/firefox/firefox 12:45:13 INFO - Running post-action listener: _resource_record_post_action 12:45:13 INFO - [mozharness: 2016-09-23 19:45:13.506185Z] Finished install step (success) 12:45:13 INFO - [mozharness: 2016-09-23 19:45:13.506429Z] Running run-tests step. 12:45:13 INFO - Running pre-action listener: _resource_record_pre_action 12:45:13 INFO - Running main action method: run_tests 12:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:45:13 INFO - Python 2.7.3 12:45:13 INFO - Return code: 0 12:45:13 INFO - grabbing minidump binary from tooltool 12:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:45:13 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 0x24bbb40>, '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 0x2504c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25050b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:45:13 INFO - Return code: 0 12:45:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:45:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:45:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:45:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:45:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:45:13 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/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 12:45:13 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/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 12:45:13 INFO - Using env: {'DISPLAY': ':0', 12:45:13 INFO - 'HOME': '/home/cltbld', 12:45:13 INFO - 'LANG': 'en_US.UTF-8', 12:45:13 INFO - 'LANGUAGE': 'en_US:en', 12:45:13 INFO - 'LOGNAME': 'cltbld', 12:45:13 INFO - 'MAIL': '/var/mail/cltbld', 12:45:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:45:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:13 INFO - 'MOZ_NO_REMOTE': '1', 12:45:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:13 INFO - 'NO_EM_RESTART': '1', 12:45:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:13 INFO - 'PWD': '/builds/slave/test', 12:45:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:45:13 INFO - 'SHELL': '/bin/bash', 12:45:13 INFO - 'SHLVL': '1', 12:45:13 INFO - 'TERM': 'linux', 12:45:13 INFO - 'TMOUT': '86400', 12:45:13 INFO - 'USER': 'cltbld', 12:45:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071', 12:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:13 INFO - '_': '/tools/buildbot/bin/python'} 12:45:13 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/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 12:45:13 INFO - mozversion application_buildid: 20160923093042 12:45:13 INFO - mozversion application_changeset: a18668c1ff8da7e0b6b6945a4186448762064d7c 12:45:13 INFO - mozversion application_display_name: Nightly 12:45:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:45:13 INFO - mozversion application_name: Firefox 12:45:13 INFO - mozversion application_remotingname: firefox 12:45:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:45:13 INFO - mozversion application_vendor: Mozilla 12:45:13 INFO - mozversion application_version: 52.0a1 12:45:13 INFO - mozversion platform_buildid: 20160923093042 12:45:13 INFO - mozversion platform_changeset: a18668c1ff8da7e0b6b6945a4186448762064d7c 12:45:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:45:13 INFO - mozversion platform_version: 52.0a1 12:45:13 INFO - using testdate: 1474659913 12:45:13 INFO - actual date: 1474659913 12:45:13 INFO - starting webserver on 'localhost:43634' 12:45:13 INFO - SUITE-START | Running 2 tests 12:45:13 INFO - TEST-START | dromaeo_css 12:45:13 INFO - operating with platform_type : linux_ 12:45:13 INFO - Initialising browser for dromaeo_css test... 12:45:13 INFO - TEST-INFO | started process 6872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0Y8fk/profile http://localhost:43634/getInfo.html) 12:45:18 INFO - PROCESS | 6872 | __metrics Screen width/height:1600/1200 12:45:18 INFO - PROCESS | 6872 | colorDepth:24 12:45:18 INFO - PROCESS | 6872 | Browser inner width/height: 1024/697 12:45:18 INFO - PROCESS | 6872 | __metrics 12:45:18 ERROR - PROCESS | 6872 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 12:45:19 INFO - TEST-INFO | 6872: exit 0 12:45:19 INFO - Browser initialized. 12:45:19 INFO - Running cycle 1/1 for dromaeo_css test... 12:45:19 INFO - TEST-INFO | started process 6994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0Y8fk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:45:31 INFO - PROCESS | 6994 | RSS: Main: 185622528 12:45:31 INFO - PROCESS | 6994 | 12:46:21 INFO - PROCESS | 6994 | 1474659981607 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] 12:48:31 INFO - PROCESS | 6994 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43634/tests/dromaeo/cssquery-ext.html) 12:48:33 INFO - PROCESS | 6994 | RSS: Main: 202506240 12:48:33 INFO - PROCESS | 6994 | 12:51:35 INFO - PROCESS | 6994 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-ext.html (next: http://localhost:43634/tests/dromaeo/cssquery-jquery.html) 12:51:35 INFO - PROCESS | 6994 | RSS: Main: 202240000 12:51:35 INFO - PROCESS | 6994 | 12:54:37 INFO - PROCESS | 6994 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43634/tests/dromaeo/cssquery-mootools.html) 12:54:38 INFO - PROCESS | 6994 | RSS: Main: 198414336 12:54:38 INFO - PROCESS | 6994 | 12:57:40 INFO - PROCESS | 6994 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43634/tests/dromaeo/cssquery-prototype.html) 12:57:40 INFO - PROCESS | 6994 | RSS: Main: 195117056 12:57:40 INFO - PROCESS | 6994 | 13:00:43 INFO - PROCESS | 6994 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43634/tests/dromaeo/cssquery-yui.html) 13:00:43 INFO - PROCESS | 6994 | RSS: Main: 198320128 13:00:43 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-yui.html (next: http://localhost:43634/tests/dromaeo/cssquery-dojo.html) 13:03:46 INFO - PROCESS | 6994 | RSS: Main: 199303168 13:03:46 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | __start_tp_report 13:03:46 INFO - PROCESS | 6994 | _x_x_mozilla_page_load 13:03:46 INFO - PROCESS | 6994 | _x_x_mozilla_page_load_details 13:03:46 INFO - PROCESS | 6994 | |i|pagename|runs| 13:03:46 INFO - PROCESS | 6994 | |0;dojo.html;3095.938081238375;3102.7207551320375;3121.5785868907706;3132.232603012262;3146.669599692032;5336.9199462008;5467.535259502942;5480.26016487774;5536.114221724525;5543.223948647187;5421.9457805421935;5425.02349577076;5430.0768869292215;5482.506574408302;5547.694876781786;4877.073356062355;5017.9247311290355;5053.393592768873;5076.84769456915;5140.0490909181735;5018.84943451697;5048.6465947383695;5055.671381360218;5069.315642388286;5092.694438333712;4912.7297998610065;4941.431735350445;4976.477469865685;5028.044671512401;5033.194688849803;5039.47085556015;5040.899182016339;5043.949560504385;5045.747712614391;5112.3865136183895;4986.152354099811;4999;5016.372953380827;5019.397672279313;5060.291559181717;5288.418273989896;5369.785208591652;5399.379071406799;5440.809571665012;5539.169124631298;5857.794977175821;5863.736131874076;5865.736041878125;5916.940830591682;5933.199018132583;5866.472017518444;5889.263842019747;5891.8527036824;5893.528517718572;5907.881842363172;5394.190871369326;5400.1899715043055;5443.074677304868;5444.210589464545;5484.451554844483;5955.464008239279;6021.066734656135;6025.487833534111;6078.75684972605;6082.2701275847185;5755.971220143872;5767.942320576824;5775.8556036099435;5775.942240577624;5776.277965254343;5735.885282294331;5799.739011744482;5842.357340692521;5852.151438041546;5855.824325270249;5784.855378615568;5856.326522449887;5862.618929769551;5873.471387575139;5896.941030589639;5819.127130930309;5868.647881127146;5874.50066744323;5878.118282257696;5910.34986151523;4445.177642136216;4483.50681425043;4487.282034874404;4521.389612402284;4535.455745310518;3959.703022273341;3972.781497017692;3982.123932734794;4012.598740126022;4024.597540245952;5559.861003474945;5561.165825126182;5609.326880774333;5616.887662246814;5622.240997465372;5827.970860145672;5847.795327163529;5894.145348924382;5942.851428714231;5948.613340132878;5588.2455868458055;5591.664500130005;5607.299087614048;5656.5757568181725;5719.370869204384;4945.134601444733;4994.375703037121;4998.1253280676465;5005.9749701251985;5051.444341122474;6056.121862329937;6061.212042434543;6084.452399284086;6101.694915254131;6112.786052488142;5756.251687280626;5839.124131380327;5840.386759390372;5865.501432378295;5946.1972633693895;6060.696965151813;6083.9136610884925;6084.269887613337;6111.5110791137495;6113.57204995646;5816.738246778989;5818.854528636818;5860.941390586039;5879.911801323069;5916.171735956884;5938.376470470538;5964.493018093511;5972.641641501524;5993.861166378374;5994.820155395345;5599.104143337209;5702.572307077069;5772.682502462405;5774.82675519735;5791.710414479344;5685.687287199078;5748.166515855261;5754.4533269339345;5769.932562475956;5842.211301474246;5666.688332141772;5722.084466485342;5731.828045158652;5756.510696590837;5782.826515204551;5674.602777805679;5764.164196191445;5817.185594016756;5821.76712931478;5824.359320474659;5484.670919744828;5622.887542249214;5632.88734225305;5639.774409023593;5751.396103409082 13:03:46 INFO - PROCESS | 6994 | |1;ext.html;540.7225849907385;565.7482420322958;572.7394035713751;584.780707234787;602.0667964654785;42644.57355426448;43904.99999999996;43941.340879886826;48410;48534;44361;44614.55385446153;44728.77635611826;45005;45073;8946.329025323093;9030.548472576378;9031.95484022579;9086.091390860895;9147.496887671176;8922.687705930293;8965.641374345018;8966.955165224164;8995.785568948173;9002.099790021011;8971.327150463709;9018.68434604789;9051.637934482613;9078.86381704275;9119.316051296146;8973.865392019125;8981.640734370618;8986.14631609996;9022.86465703015;9043.773905652411;8871.55642217893;8876.911230887674;8900.065493123193;8951.776205594912;8962.775930601721;43931.560684393386;44446.777766111285;44465.55534444679;44727;44763.552364476265;3384.187794929224;3495.9126021849656;3538.5930617979006;3773.6792372648356;3957.9010524736823;32406.837965810257;32435.837820810746;32487.51268730971;32757.672423275937;32892.83553582217;4263.637590804786;4267.0900802388605;4390.648748100144;4446.954965583085;4477.574630410106;237935;239030;239683;240341;240520;57443.13835292474;58277;58284.70857645769;58365.41634583685;58426;37130.44304335383;38459.42310865339;61667.38332616706;61687;61828;16377.181140942905;16511.917440412722;16733.497995060166;16736.6652666946;16769.496915092568;11909.047276217882;11933.28400295985;11949.283043017447;11962.162648614514;11963.64109076729;19193.136308866135;19253.518662033563;19262.4221273362;19298.517537061685;19433.31983380575;7092.893606595905;7151.604212588841;7210.351068403764;7249.673764680602;7264.782056538313;835.6406745099665;901.2519608724742;974.9122578967927;1011.7672935224939;1017.3438132404558;30929.845350773103;32702.509462358084;32832.50751238733;32921.506177407355;33246.83376583102;993.8360170571775;1034.7464871106627;1050.0759331787979;1060.3319908457777;1083.9945800270948;16204.189790510427;16954.660906781795;17009.319627214772;17054.147292635567;17103.315867365167;518839;519494;522507;522754;523650;57825;58461;58507.41492585105;58530.82938341209;58551;1228.121892846619;1259.515086691612;1261.6025951825145;1313.2842600782787;1319.9868001320056;29527.409451811272;31422.685773141977;31443.37113257768;31751;32032.359352812346;50455.747721262625;50545.74727126341;50753.23870141877;50999;51003.74498127485;426470;428747;429727;429852;429883;27462.725372746816;28462.715372846007;29055.7094429053;29154;29509.85245073761;46928.530714693785;46998.53001470078;47236.7638161807;47886.28170577374;47924.281135782294;39643.78167134724;40456.190876181725;40467.3929891046;41174.79412602918;42351;40803.38794918019;41192.79403602963;41202.175956481304;42568.36147457852;43407.782961084995;37267.62732372642;38695.22609547737;39189.80405097956;41887.58112418837;46699;38505;38652.420213696256;38752.80623596864;42605;43167;32651;34601.82699086489;34643.48034779531;34742.82628586841;34937.47593786146 13:03:46 INFO - PROCESS | 6994 | |2;jquery.html;404.31065034116835;407.5231978585057;408.3772247322834;413.3881854854816;425.0457722413183;18252.45242642721;19809.504762380948;19893.3037343693;19896.10467528961;20060.097295621694;18448.169832357544;18765.249390024383;19302.420927372164;19921.402357929248;19960.600787984233;5612.550995920337;5631.60578759487;5855.76576936922;5903.822885313426;5986.341502434729;5722.084466485363;5849.8830023399505;5864.149698293745;5868.325142608591;5877.941220587803;5872.17789509469;5926.911096333559;5929.822105336847;5942.465178133967;5960.374160713128;5666.263385759866;5807.128930660392;5849.093390524476;5879.353271140171;5922.2005029321135;5738.0532212184935;5738.8278351649515;5739.62692424991;5754.539636829044;5754.942450575482;11979.401029948554;12219.694507637292;12261.080418968613;12565.748685026248;21246.468838279012;2008.658528050235;2118.6186486432434;2119.0993827623197;2221.833362497803;2272.5909336319455;10042.89957100427;10062.547185376676;10202.795944081077;10324.328918620266;10568.947155264175;1874.1191639929211;1879.1168150969022;1936.244864502845;1946.6690662587393;2015.939521814348;80076;84163;86628.56685716531;86880;87974.5601271996;11297.435128243555;11465.484053217626;11604.593839215588;11637.53449861996;11835.940820296015;15850;15987.60030999211;16016.919915400582;16039.11784851821;16128.193590320438;7950.6422211000645;8048.637811298506;8113.594320283963;8214.219649133323;8539.316854651614;7420.9628951855975;7568.583727894908;7663.157052724196;7735.22647735222;8060.516369017878;4743.292414730694;4806.735629540339;4889.4377146627885;4918.385201849769;4932.284818701268;1934.5937353155714;2002.0390212697696;2035.5827055453597;2067.0904801887123;2072.699458578498;836.3727204596553;885.1853699915148;892.3396686451979;977.154761131616;991.7024892532212;18841;20283.79716202819;20392.388228353175;20441.795582044288;20525.178992840418;884.6903583745766;907.8638204269413;942.6465075596651;971.9222462203007;997.5112195024386;10548.789024219474;11270.154738394653;11320.490577924013;11362.375069371265;11448.313101213955;459582;459585;463281;467544;474061;92997.5350123245;93178.53410732903;93950.53024734833;94831.52584237173;97094.51452742692;991.9504024798731;993.9006099390148;1032.0969151992008;1051.1748277602046;1057.746140926172;17148.485545433658;17352;17980.2807887683;18112.45662630123;18255.361062362754;42733.57266427296;43037.56962430335;43223.783881081654;43569.128617428105;43658.34512482379;57742.7112864433;58976.70511647414;59298;59327;60284.69857650684;8364.53995030255;8539.188777066418;8568.779534624071;8688.261497772508;8778.297736181217;12278.386080695751;12933.417996190006;13065.346732663138;13112.213267203999;13207.60377188686;11029.44852757343;11384.373859437479;11431.828522572334;11616.767664646828;11744.58893938708;11325.603603873826;11555.537778489102;11698;11910;12217.45021474018;11360;11391.544338226378;11485.885141148816;11748.530058797895;11959.701007474534;8478.877296134906;8482.57587120629;8760.51817150063;8768.736937891874;9140.537513997728;8456.534890580831;10738.892611073788;11341.886581134084;11854.58508952217;11855.407229638311 13:03:46 INFO - PROCESS | 6994 | |3;mootools.html;1441.2361448432334;1488.1145718297614;1588;1673.1466951854566;1706.6416052628947;7841.4903031303065;8110.878336824938;8383.245507904287;9065.18413342799;9082.500462474569;8360.372972027108;8673.436226645264;8709.129087091287;8795.296376289898;8862.291016718664;2292.862428254302;2332.720073591163;2334.6498025296173;2334.976650233493;2336.6378211377264;2282.4065742906882;2309.4919117794143;2318.6637937499054;2322;2332.615118505453;2333.2766842278947;2345.3550273674705;2349.788519033287;2389.5220955808823;2389.832711710181;2252.3468194223656;2281.4638559938403;2285.657151427291;2289.404754763765;2291.8510296830736;2179.5314007488464;2190.58378908007;2191.2111639809655;2191.6822060801096;2194.4513871532117;8905.332100092453;9023.052579479192;9048.592813323416;9049.954750226272;9079.092090790868;5117.8720531987;5194;5263.368395792491;5279.260903473517;5288.1803320485005;3172.587563616738;3231.0791424444155;3366;3379.4423920053164;3402.0474267205223;1202.7534355457199;1212.4422765527868;1232.975340493185;1234.154604096197;1241.2304371289767;12141.15011949164;12328.753424931541;12333.260004399675;12380.380980950917;12395.442205100791;4376.431063961728;4561.498235194126;4671.229247174178;4724.078804633064;4759.095771803346;10410.843837342445;10423.478826058667;10424.061834434937;10426.530806113591;10431.113355364727;5224.686518808883;5259.974305010486;5295;5298.311219541512;5310.60170487215;4256.787160641956;4379.4525684289465;4696.459907110658;4843.709377437365;4883.780229889663;3895.96104038956;4043.1913617276073;4069.267531844237;4127.442795222607;4134.937975930364;1318.7032917593656;1322.907396482237;1324.7414955792035;1329.2954733991;1343.1605246720799;727.6034561164179;907.8683590879285;922.1700469577299;942.8727121838601;946.1059298962415;5799.391063938226;5887.941120588825;5944.3164036136395;6000.759969601254;6155.415235552616;451.17209919796886;452.08227298583927;454.4138061900178;935.7473482159915;1019.2202964731986;4004.2592120457225;4013.8795836124964;4055.6349928506575;4092.9181416371507;4163.708540402204;10663.573457061631;10817.78364432707;10931.672049838518;10938.835917461245;10946.781064378667;10785.083267922315;10832.78334433307;10846.945765271123;10872;10876.673699789018;8103.756887293391;8111.986001749781;8226.465279756916;8333.79165520879;8377.748667539983;5868.647881127146;5883.646981181143;5935.851603709769;6063.636181829104;6192.907106393498;9923.950380248341;10002.199824014207;10009.399436033862;10088.949555252177;10109.49452527356;10013.549390277309;10435.634752783617;10448.58205671795;10482.318649287772;10488.842667359842;6435.51733619971;6621.602703837785;7186.568805871664;7538.133114691661;7689.692412303445;8404.20160084791;8580.412623664392;8637.049924508174;8660.437071590326;8667.653293868427;7589.544627322378;7631.847363052597;7809.531428114331;7912.0505539335645;7943.523388596703;7160.319769621878;7384.298491643285;7392;7450.96274518624;7595.430342724208;6914.4468442525485;7035.296470353129;7049.29507049291;7056.8588628226125;7067.0459487968465;4930.112579735682;4985.3020577118505;5007.39911210657;5040.319556859777;5158.819441319536;5170.40540337866;5249.580033597226;5259.815906443256;5266.605004624746;5296.152615581643 13:03:46 INFO - PROCESS | 6994 | |4;prototype.html;328.9621693505248;334.58344361270224;335.70122590894107;339.6314998226924;341.482653779524;5391;5406.216098665696;5532.917006244909;5582.748776305071;5598.7962588043565;5420.810271640494;5470.452954704538;5481.369642491115;5495.175723641446;5507.428834067714;4286.142771445708;4288.356746488021;4292.549282325358;4296.699231053827;4305.98809279819;4224.831006759726;4246.540780940045;4253.766042867641;4264.061906380592;4307.289297265963;4216.704830661855;4222.873313800591;4237.470316210473;4245.7240279381895;4246.214450326684;4209.936850947238;4215.768132752697;4218.49378074633;4219;4264.211120942636;3730.4404339349044;3741.1021354874906;3744.719146064056;3745.8127093645207;3755.6244375562496;5131.4098878629065;5339.466053394668;5342.332208473941;5370.91943620846;5376.1398176292;4841.491643377465;4861.319415281828;4870.342503761982;4873.439554451248;4874.829380971649;5465.808696695636;5753.510951569122;5768.183022347989;5771.278590176228;5788.565857560658;4059.451973983504;4072.572379900127;4073.877783666495;4086.468759061303;4103.158852435274;6007.939920600782;6027.728752206117;6034.36639152887;6047.606905551125;6049.395060493959;3911.9608803912165;4128.401381799622;4134.669226461936;4163.188178305201;4170.270202714573;4144.52337981136;4161.729487583298;4193.895152621209;4205.422966387605;4213.494380674339;4801.159797035505;4828.46886842447;4834.903301934012;4840.927386089212;4852.1508735971065;5524.392316845144;5728.971355143198;5767.134929760486;5787;5804.419558044162;1424.4088703188268;1433.1974094506902;1439.1868594244218;1441.3802065112102;1448.8840892728556;874.9387542871938;914.9542522873962;925.2551695884742;926.5182105305204;927.7124091531647;4819.807207711652;4850.587700045536;4906.828261010847;4935.3090567320605;4944.25836124577;5188.11801993662;5217.973910130501;5223.817166399158;5231.686098834082;5240.502152295526;4613.446386433649;4862.319275301461;4917.9426423319155;4954.653174277766;4956.330895329156;2752.944941101167;2760.1920741914078;2775.8889644414403;2775.9167224983285;2784.818986765854;5272.657277276965;5315.601329900195;5333.626646134733;5377.462253774669;5387.353517577837;4908;5150.969806038807;5212.609054320866;5287.5677188492955;5315.73421328932;5284.207368894619;5291.708956007456;5305.44292849253;5308.336457942757;5336.67979921206;5123.590112790893;5148.382194136578;5151.948480515297;5152.948470515247;5174.534291913746;4698.906021879475;5081.92377114351;5116.155834287301;5138.511841375063;5158.793648254028;5254.7898084076205;5301.985245606645;5315.548178404879;5326.733663316896;5357.491038351351;3799.6511238511034;3948.9210215794947;4012.518497780285;4030.8387664493093;4097.364908439196;5830.475257226701;5849.678267695147;5856.180134781049;5885.3820348862755;5885.440883116097;5570;5726.455986681259;5751.332113686984;5761.337446193741;5762.654240745569;5640.85897852557;5680.5230640034715;5682.204491371129;5714.428507171706;5722.828315150552;5634.915476267777;5672.631278966854;5732.971335143297;5736.627119237403;5759.596828221985;5493.725313734377;5690.459406356389;5699.145128230799;5780.364159942319;5789.334226563999;5568.77724891016;5578.525825304894;5581.665100094007;5586.944130558805;5593.67176529964 13:03:46 INFO - PROCESS | 6994 | |5;yui.html;638.1608185236414;647.9902801457978;724.1997592660107;730.6237287796786;742.380112605974;14026.298685065743;14312.856871431282;14479.855201447983;14506.492272770454;15376.923115384436;14683.265836708175;14989.47536836211;15000.249987500609;15019.249037548107;15035.473758418457;793.4247670438914;805.2631841864687;823.2508417340222;824.7938015496126;824.8803923431099;818.6766227340197;825.5211977053294;825.9256666899978;828.2876726015652;828.3745771942175;857.5455008845322;859.5573279760928;860.1527495417009;860.4622111180512;861.1732736572866;848.9915100848974;850.336737344872;851.6082602003086;852.2925971443686;854.9615267312923;620.5935112501319;625.4871005775266;625.7715933684173;626.092166358777;628.2021832272987;14732.631684207981;14907.925460372737;14922.925385373112;14929.701405971928;14957.252137393196;13037.804432933419;13058.608241752667;13351.332433378293;13556.254406007665;13567.118137321042;10412.531436085319;10498.317609355443;10660.466976651136;10694.679159625224;10847.51186196623;3753.680937120321;3764.870538838365;3794.2221844522082;3800.923981520382;3888.650021498079;83475;83755;84204.15795842024;84466.15533844645;85090;9951.452670103214;10176.491175441346;10231.386116833013;10349.482525873827;10586.311889727298;19926.800731992786;19961.700574491395;20235.19059237614;20438.489037773877;20457.38627841167;7886.763397098096;7923.564203968837;7932.960335198402;7983.880241796378;8168;4434.11317736454;4509.843109823071;4605.332226827091;4628.95371046292;4666.626669866402;3427.9314413711586;3499.9825000874835;3505.4741788731894;3523.94714079289;3551.8579256829953;571.7512881896388;572.7680289482767;578.9276340457443;597.8087012156068;610.4109534299422;703.7712743358429;719.2879049740719;723.106962900817;729.4018904498366;765.1927216786344;8868.955655221682;9168.541572921327;9780.217582593375;9807.117359437685;10073;579.5189992306375;739.9408047356198;747.4431548496297;753.6683859101978;758.518340853562;4576.565226303496;4587.3807036050375;4587.816487340469;4743.288506724019;4810.067444322403;76083.61958190284;109430.88699234524;115046.4247678773;120498;124979;79305;80051.19948800554;82564;103393.48303258586;104354;59473.40526594765;61559.38440615626;76135;82875.5856220715;84766.99999999876;9208.631654733736;9997.55011024491;10116.342437741523;10134.493275336055;10357.533910973874;52795;53709.46290537201;55085.724571376886;55633;56671.58321041842;69059.65470172818;76732.6163369202;77721.61139194494;79696.60151699204;82025;12866.742665146832;12926.676833078873;13040.804387934379;13338.26639534835;13684.726305474034;13394.050635436546;14100.647483812576;14102.647433814236;14371.281435927953;14772.704545908806;12675.239485630891;12894.548690795777;13014.544490942772;13123.212607243597;14790;13503.797443038558;13696.246706431242;14034.649133771329;14076;14131.87172288815;11684.415779210836;11698.239614425034;12239.32683702405;12250.081243906565;12492.687682808002;11029.338239705643;11053.392063436588;11139.220254582102;11262.8768406162;11362.204645674723;11739.530418783495;11912.76174476523;11966.341851198267;12097.2136811107;12278.570250041563 13:03:46 INFO - PROCESS | 6994 | __end_tp_report 13:03:46 INFO - PROCESS | 6994 | __start_cc_report 13:03:46 INFO - PROCESS | 6994 | _x_x_mozilla_cycle_collect,318 13:03:46 INFO - PROCESS | 6994 | __end_cc_report 13:03:46 INFO - PROCESS | 6994 | __startTimestamp1474661026828__endTimestamp 13:03:46 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | ------- Summary: start ------- 13:03:46 INFO - PROCESS | 6994 | Number of tests: 6 13:03:46 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | [#0] dojo.html Cycles:165 Average:5461.91 Median:5702.57 stddev:629.43 (11.0%) stddev-sans-first:603.38 13:03:46 INFO - PROCESS | 6994 | Values: 3095.9 3102.7 3121.6 3132.2 3146.7 5336.9 5467.5 5480.3 5536.1 5543.2 5421.9 5425.0 5430.1 5482.5 5547.7 4877.1 5017.9 5053.4 5076.8 5140.0 5018.8 5048.6 5055.7 5069.3 5092.7 4912.7 4941.4 4976.5 5028.0 5033.2 5039.5 5040.9 5043.9 5045.7 5112.4 4986.2 4999.0 5016.4 5019.4 5060.3 5288.4 5369.8 5399.4 5440.8 5539.2 5857.8 5863.7 5865.7 5916.9 5933.2 5866.5 5889.3 5891.9 5893.5 5907.9 5394.2 5400.2 5443.1 5444.2 5484.5 5955.5 6021.1 6025.5 6078.8 6082.3 5756.0 5767.9 5775.9 5775.9 5776.3 5735.9 5799.7 5842.4 5852.2 5855.8 5784.9 5856.3 5862.6 5873.5 5896.9 5819.1 5868.6 5874.5 5878.1 5910.3 4445.2 4483.5 4487.3 4521.4 4535.5 3959.7 3972.8 3982.1 4012.6 4024.6 5559.9 5561.2 5609.3 5616.9 5622.2 5828.0 5847.8 5894.1 5942.9 5948.6 5588.2 5591.7 5607.3 5656.6 5719.4 4945.1 4994.4 4998.1 5006.0 5051.4 6056.1 6061.2 6084.5 6101.7 6112.8 5756.3 5839.1 5840.4 5865.5 5946.2 6060.7 6083.9 6084.3 6111.5 6113.6 5816.7 5818.9 5860.9 5879.9 5916.2 5938.4 5964.5 5972.6 5993.9 5994.8 5599.1 5702.6 5772.7 5774.8 5791.7 5685.7 5748.2 5754.5 5769.9 5842.2 5666.7 5722.1 5731.8 5756.5 5782.8 5674.6 5764.2 5817.2 5821.8 5824.4 5484.7 5622.9 5632.9 5639.8 5751.4 13:03:46 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | [#1] ext.html Cycles:180 Average:56758.66 Median:429789.50 stddev:109748.80 (25.5%) stddev-sans-first:109975.50 13:03:46 INFO - PROCESS | 6994 | Values: 540.7 565.7 572.7 584.8 602.1 42644.6 43905.0 43941.3 48410.0 48534.0 44361.0 44614.6 44728.8 45005.0 45073.0 8946.3 9030.5 9032.0 9086.1 9147.5 8922.7 8965.6 8967.0 8995.8 9002.1 8971.3 9018.7 9051.6 9078.9 9119.3 8973.9 8981.6 8986.1 9022.9 9043.8 8871.6 8876.9 8900.1 8951.8 8962.8 43931.6 44446.8 44465.6 44727.0 44763.6 3384.2 3495.9 3538.6 3773.7 3957.9 32406.8 32435.8 32487.5 32757.7 32892.8 4263.6 4267.1 4390.6 4447.0 4477.6 237935.0 239030.0 239683.0 240341.0 240520.0 57443.1 58277.0 58284.7 58365.4 58426.0 37130.4 38459.4 61667.4 61687.0 61828.0 16377.2 16511.9 16733.5 16736.7 16769.5 11909.0 11933.3 11949.3 11962.2 11963.6 19193.1 19253.5 19262.4 19298.5 19433.3 7092.9 7151.6 7210.4 7249.7 7264.8 835.6 901.3 974.9 1011.8 1017.3 30929.8 32702.5 32832.5 32921.5 33246.8 993.8 1034.7 1050.1 1060.3 1084.0 16204.2 16954.7 17009.3 17054.1 17103.3 518839.0 519494.0 522507.0 522754.0 523650.0 57825.0 58461.0 58507.4 58530.8 58551.0 1228.1 1259.5 1261.6 1313.3 1320.0 29527.4 31422.7 31443.4 31751.0 32032.4 50455.7 50545.7 50753.2 50999.0 51003.7 426470.0 428747.0 429727.0 429852.0 429883.0 27462.7 28462.7 29055.7 29154.0 29509.9 46928.5 46998.5 47236.8 47886.3 47924.3 39643.8 40456.2 40467.4 41174.8 42351.0 40803.4 41192.8 41202.2 42568.4 43407.8 37267.6 38695.2 39189.8 41887.6 46699.0 38505.0 38652.4 38752.8 42605.0 43167.0 32651.0 34601.8 34643.5 34742.8 34937.5 13:03:46 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | [#2] jquery.html Cycles:180 Average:28378.44 Median:419.22 stddev:76972.75 (18361.1%) stddev-sans-first:77160.02 13:03:46 INFO - PROCESS | 6994 | Values: 404.3 407.5 408.4 413.4 425.0 18252.5 19809.5 19893.3 19896.1 20060.1 18448.2 18765.2 19302.4 19921.4 19960.6 5612.6 5631.6 5855.8 5903.8 5986.3 5722.1 5849.9 5864.1 5868.3 5877.9 5872.2 5926.9 5929.8 5942.5 5960.4 5666.3 5807.1 5849.1 5879.4 5922.2 5738.1 5738.8 5739.6 5754.5 5754.9 11979.4 12219.7 12261.1 12565.7 21246.5 2008.7 2118.6 2119.1 2221.8 2272.6 10042.9 10062.5 10202.8 10324.3 10568.9 1874.1 1879.1 1936.2 1946.7 2015.9 80076.0 84163.0 86628.6 86880.0 87974.6 11297.4 11465.5 11604.6 11637.5 11835.9 15850.0 15987.6 16016.9 16039.1 16128.2 7950.6 8048.6 8113.6 8214.2 8539.3 7421.0 7568.6 7663.2 7735.2 8060.5 4743.3 4806.7 4889.4 4918.4 4932.3 1934.6 2002.0 2035.6 2067.1 2072.7 836.4 885.2 892.3 977.2 991.7 18841.0 20283.8 20392.4 20441.8 20525.2 884.7 907.9 942.6 971.9 997.5 10548.8 11270.2 11320.5 11362.4 11448.3 459582.0 459585.0 463281.0 467544.0 474061.0 92997.5 93178.5 93950.5 94831.5 97094.5 992.0 993.9 1032.1 1051.2 1057.7 17148.5 17352.0 17980.3 18112.5 18255.4 42733.6 43037.6 43223.8 43569.1 43658.3 57742.7 58976.7 59298.0 59327.0 60284.7 8364.5 8539.2 8568.8 8688.3 8778.3 12278.4 12933.4 13065.3 13112.2 13207.6 11029.4 11384.4 11431.8 11616.8 11744.6 11325.6 11555.5 11698.0 11910.0 12217.5 11360.0 11391.5 11485.9 11748.5 11959.7 8478.9 8482.6 8760.5 8768.7 9140.5 8456.5 10738.9 11341.9 11854.6 11855.4 13:03:46 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | [#3] mootools.html Cycles:180 Average:5769.29 Median:2507.96 stddev:3305.31 (131.8%) stddev-sans-first:3298.58 13:03:46 INFO - PROCESS | 6994 | Values: 1441.2 1488.1 1588.0 1673.1 1706.6 7841.5 8110.9 8383.2 9065.2 9082.5 8360.4 8673.4 8709.1 8795.3 8862.3 2292.9 2332.7 2334.6 2335.0 2336.6 2282.4 2309.5 2318.7 2322.0 2332.6 2333.3 2345.4 2349.8 2389.5 2389.8 2252.3 2281.5 2285.7 2289.4 2291.9 2179.5 2190.6 2191.2 2191.7 2194.5 8905.3 9023.1 9048.6 9050.0 9079.1 5117.9 5194.0 5263.4 5279.3 5288.2 3172.6 3231.1 3366.0 3379.4 3402.0 1202.8 1212.4 1233.0 1234.2 1241.2 12141.2 12328.8 12333.3 12380.4 12395.4 4376.4 4561.5 4671.2 4724.1 4759.1 10410.8 10423.5 10424.1 10426.5 10431.1 5224.7 5260.0 5295.0 5298.3 5310.6 4256.8 4379.5 4696.5 4843.7 4883.8 3896.0 4043.2 4069.3 4127.4 4134.9 1318.7 1322.9 1324.7 1329.3 1343.2 727.6 907.9 922.2 942.9 946.1 5799.4 5887.9 5944.3 6000.8 6155.4 451.2 452.1 454.4 935.7 1019.2 4004.3 4013.9 4055.6 4092.9 4163.7 10663.6 10817.8 10931.7 10938.8 10946.8 10785.1 10832.8 10846.9 10872.0 10876.7 8103.8 8112.0 8226.5 8333.8 8377.7 5868.6 5883.6 5935.9 6063.6 6192.9 9924.0 10002.2 10009.4 10088.9 10109.5 10013.5 10435.6 10448.6 10482.3 10488.8 6435.5 6621.6 7186.6 7538.1 7689.7 8404.2 8580.4 8637.0 8660.4 8667.7 7589.5 7631.8 7809.5 7912.1 7943.5 7160.3 7384.3 7392.0 7451.0 7595.4 6914.4 7035.3 7049.3 7056.9 7067.0 4930.1 4985.3 5007.4 5040.3 5158.8 5170.4 5249.6 5259.8 5266.6 5296.2 13:03:46 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | [#4] prototype.html Cycles:180 Average:4626.14 Median:5155.87 stddev:1343.46 (26.1%) stddev-sans-first:1307.94 13:03:46 INFO - PROCESS | 6994 | Values: 329.0 334.6 335.7 339.6 341.5 5391.0 5406.2 5532.9 5582.7 5598.8 5420.8 5470.5 5481.4 5495.2 5507.4 4286.1 4288.4 4292.5 4296.7 4306.0 4224.8 4246.5 4253.8 4264.1 4307.3 4216.7 4222.9 4237.5 4245.7 4246.2 4209.9 4215.8 4218.5 4219.0 4264.2 3730.4 3741.1 3744.7 3745.8 3755.6 5131.4 5339.5 5342.3 5370.9 5376.1 4841.5 4861.3 4870.3 4873.4 4874.8 5465.8 5753.5 5768.2 5771.3 5788.6 4059.5 4072.6 4073.9 4086.5 4103.2 6007.9 6027.7 6034.4 6047.6 6049.4 3912.0 4128.4 4134.7 4163.2 4170.3 4144.5 4161.7 4193.9 4205.4 4213.5 4801.2 4828.5 4834.9 4840.9 4852.2 5524.4 5729.0 5767.1 5787.0 5804.4 1424.4 1433.2 1439.2 1441.4 1448.9 874.9 915.0 925.3 926.5 927.7 4819.8 4850.6 4906.8 4935.3 4944.3 5188.1 5218.0 5223.8 5231.7 5240.5 4613.4 4862.3 4917.9 4954.7 4956.3 2752.9 2760.2 2775.9 2775.9 2784.8 5272.7 5315.6 5333.6 5377.5 5387.4 4908.0 5151.0 5212.6 5287.6 5315.7 5284.2 5291.7 5305.4 5308.3 5336.7 5123.6 5148.4 5151.9 5152.9 5174.5 4698.9 5081.9 5116.2 5138.5 5158.8 5254.8 5302.0 5315.5 5326.7 5357.5 3799.7 3948.9 4012.5 4030.8 4097.4 5830.5 5849.7 5856.2 5885.4 5885.4 5570.0 5726.5 5751.3 5761.3 5762.7 5640.9 5680.5 5682.2 5714.4 5722.8 5634.9 5672.6 5733.0 5736.6 5759.6 5493.7 5690.5 5699.1 5780.4 5789.3 5568.8 5578.5 5581.7 5586.9 5593.7 13:03:46 INFO - PROCESS | 6994 | 13:03:46 INFO - PROCESS | 6994 | [#5] yui.html Cycles:180 Average:20204.70 Median:4543.20 stddev:29035.56 (639.1%) stddev-sans-first:29079.84 13:03:46 INFO - PROCESS | 6994 | Values: 638.2 648.0 724.2 730.6 742.4 14026.3 14312.9 14479.9 14506.5 15376.9 14683.3 14989.5 15000.2 15019.2 15035.5 793.4 805.3 823.3 824.8 824.9 818.7 825.5 825.9 828.3 828.4 857.5 859.6 860.2 860.5 861.2 849.0 850.3 851.6 852.3 855.0 620.6 625.5 625.8 626.1 628.2 14732.6 14907.9 14922.9 14929.7 14957.3 13037.8 13058.6 13351.3 13556.3 13567.1 10412.5 10498.3 10660.5 10694.7 10847.5 3753.7 3764.9 3794.2 3800.9 3888.7 83475.0 83755.0 84204.2 84466.2 85090.0 9951.5 10176.5 10231.4 10349.5 10586.3 19926.8 19961.7 20235.2 20438.5 20457.4 7886.8 7923.6 7933.0 7983.9 8168.0 4434.1 4509.8 4605.3 4629.0 4666.6 3427.9 3500.0 3505.5 3523.9 3551.9 571.8 572.8 578.9 597.8 610.4 703.8 719.3 723.1 729.4 765.2 8869.0 9168.5 9780.2 9807.1 10073.0 579.5 739.9 747.4 753.7 758.5 4576.6 4587.4 4587.8 4743.3 4810.1 76083.6 109430.9 115046.4 120498.0 124979.0 79305.0 80051.2 82564.0 103393.5 104354.0 59473.4 61559.4 76135.0 82875.6 84767.0 9208.6 9997.6 10116.3 10134.5 10357.5 52795.0 53709.5 55085.7 55633.0 56671.6 69059.7 76732.6 77721.6 79696.6 82025.0 12866.7 12926.7 13040.8 13338.3 13684.7 13394.1 14100.6 14102.6 14371.3 14772.7 12675.2 12894.5 13014.5 13123.2 14790.0 13503.8 13696.2 14034.6 14076.0 14131.9 11684.4 11698.2 12239.3 12250.1 12492.7 11029.3 11053.4 11139.2 11262.9 11362.2 11739.5 11912.8 11966.3 12097.2 12278.6 13:03:46 INFO - PROCESS | 6994 | -------- Summary: end -------- 13:03:46 INFO - PROCESS | 6994 | 13:03:47 INFO - TEST-INFO | 6994: exit 0 13:03:47 INFO - TEST-OK | dromaeo_css | took 1114027ms 13:03:47 INFO - TEST-START | kraken 13:03:47 INFO - operating with platform_type : linux_ 13:03:47 INFO - Initialising browser for kraken test... 13:03:47 INFO - TEST-INFO | started process 7348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA4y5j/profile http://localhost:43634/getInfo.html) 13:03:52 INFO - PROCESS | 7348 | __metrics Screen width/height:1600/1200 13:03:52 INFO - PROCESS | 7348 | colorDepth:24 13:03:52 INFO - PROCESS | 7348 | Browser inner width/height: 1024/697 13:03:52 INFO - PROCESS | 7348 | __metrics 13:03:52 ERROR - PROCESS | 7348 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 13:03:53 INFO - TEST-INFO | 7348: exit 0 13:03:53 INFO - Browser initialized. 13:03:53 INFO - Running cycle 1/1 for kraken test... 13:03:53 INFO - TEST-INFO | started process 7473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA4y5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:06 INFO - PROCESS | 7473 | RSS: Main: 185790464 13:04:06 INFO - PROCESS | 7473 | 13:04:08 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43634/tests/kraken/driver.html?testName=audio-beat-detection) 13:04:09 INFO - PROCESS | 7473 | RSS: Main: 199823360 13:04:09 INFO - PROCESS | 7473 | 13:04:12 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43634/tests/kraken/driver.html?testName=audio-dft) 13:04:13 INFO - PROCESS | 7473 | RSS: Main: 197349376 13:04:13 INFO - PROCESS | 7473 | 13:04:15 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43634/tests/kraken/driver.html?testName=audio-fft) 13:04:16 INFO - PROCESS | 7473 | RSS: Main: 193114112 13:04:16 INFO - PROCESS | 7473 | 13:04:18 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43634/tests/kraken/driver.html?testName=audio-oscillator) 13:04:19 INFO - PROCESS | 7473 | RSS: Main: 193466368 13:04:19 INFO - PROCESS | 7473 | 13:04:21 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:04:22 INFO - PROCESS | 7473 | RSS: Main: 193691648 13:04:22 INFO - PROCESS | 7473 | 13:04:25 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43634/tests/kraken/driver.html?testName=imaging-darkroom) 13:04:25 INFO - PROCESS | 7473 | RSS: Main: 193867776 13:04:25 INFO - PROCESS | 7473 | 13:04:29 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43634/tests/kraken/driver.html?testName=imaging-desaturate) 13:04:29 INFO - PROCESS | 7473 | RSS: Main: 191840256 13:04:29 INFO - PROCESS | 7473 | 13:04:32 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43634/tests/kraken/driver.html?testName=json-parse-financial) 13:04:33 INFO - PROCESS | 7473 | RSS: Main: 193212416 13:04:33 INFO - PROCESS | 7473 | 13:04:34 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:04:35 INFO - PROCESS | 7473 | RSS: Main: 193691648 13:04:35 INFO - PROCESS | 7473 | 13:04:37 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:04:37 INFO - PROCESS | 7473 | RSS: Main: 193748992 13:04:37 INFO - PROCESS | 7473 | 13:04:39 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:04:40 INFO - PROCESS | 7473 | RSS: Main: 193859584 13:04:40 INFO - PROCESS | 7473 | 13:04:43 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:04:43 INFO - PROCESS | 7473 | RSS: Main: 193949696 13:04:43 INFO - PROCESS | 7473 | 13:04:46 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:04:47 INFO - PROCESS | 7473 | RSS: Main: 194478080 13:04:47 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43634/tests/kraken/driver.html?testName=ai-astar) 13:04:49 INFO - PROCESS | 7473 | RSS: Main: 195981312 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | __start_tp_report 13:04:49 INFO - PROCESS | 7473 | _x_x_mozilla_page_load 13:04:49 INFO - PROCESS | 7473 | _x_x_mozilla_page_load_details 13:04:49 INFO - PROCESS | 7473 | |i|pagename|runs| 13:04:49 INFO - PROCESS | 7473 | |0;ai-astar;106;112;113;113;117;113;114;112;112;112 13:04:49 INFO - PROCESS | 7473 | |1;audio-beat-detection;159;130;121;176;126;121;126;121;150;122 13:04:49 INFO - PROCESS | 7473 | |2;audio-dft;163;170;168;175;165;161;163;164;162;162 13:04:49 INFO - PROCESS | 7473 | |3;audio-fft;75;77;76;127;77;77;76;75;101;75 13:04:49 INFO - PROCESS | 7473 | |4;audio-oscillator;84;82;105;84;82;83;100;83;83;110 13:04:49 INFO - PROCESS | 7473 | |5;imaging-gaussian-blur;118;118;117;117;119;117;117;117;118;118 13:04:49 INFO - PROCESS | 7473 | |6;imaging-darkroom;148;146;147;147;148;147;149;147;146;151 13:04:49 INFO - PROCESS | 7473 | |7;imaging-desaturate;96;96;95;95;97;96;97;95;96;96 13:04:49 INFO - PROCESS | 7473 | |8;json-parse-financial;53;52;55;52;56;58;53;53;53;53 13:04:49 INFO - PROCESS | 7473 | |9;json-stringify-tinderbox;62;61;61;62;62;61;60;60;60;61 13:04:49 INFO - PROCESS | 7473 | |10;stanford-crypto-aes;80;81;82;79;80;79;80;79;84;86 13:04:49 INFO - PROCESS | 7473 | |11;stanford-crypto-ccm;131;127;134;123;124;127;143;133;157;126 13:04:49 INFO - PROCESS | 7473 | |12;stanford-crypto-pbkdf2;176;164;167;168;166;165;164;162;167;163 13:04:49 INFO - PROCESS | 7473 | |13;stanford-crypto-sha256-iterative;64;67;64;68;65;66;65;65;64;62 13:04:49 INFO - PROCESS | 7473 | __end_tp_report 13:04:49 INFO - PROCESS | 7473 | __start_cc_report 13:04:49 INFO - PROCESS | 7473 | _x_x_mozilla_cycle_collect,758 13:04:49 INFO - PROCESS | 7473 | __end_cc_report 13:04:49 INFO - PROCESS | 7473 | __startTimestamp1474661089331__endTimestamp 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | ------- Summary: start ------- 13:04:49 INFO - PROCESS | 7473 | Number of tests: 14 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.72 (2.4%) stddev-sans-first:1.62 13:04:49 INFO - PROCESS | 7473 | Values: 106.0 112.0 113.0 113.0 117.0 113.0 114.0 112.0 112.0 112.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:128.00 stddev:19.51 (15.2%) stddev-sans-first:18.70 13:04:49 INFO - PROCESS | 7473 | Values: 159.0 130.0 121.0 176.0 126.0 121.0 126.0 121.0 150.0 122.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:4.42 (2.7%) stddev-sans-first:4.61 13:04:49 INFO - PROCESS | 7473 | Values: 163.0 170.0 168.0 175.0 165.0 161.0 163.0 164.0 162.0 162.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:17.17 (22.6%) stddev-sans-first:17.93 13:04:49 INFO - PROCESS | 7473 | Values: 75.0 77.0 76.0 127.0 77.0 77.0 76.0 75.0 101.0 75.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:10.91 (13.1%) stddev-sans-first:11.38 13:04:49 INFO - PROCESS | 7473 | Values: 84.0 82.0 105.0 84.0 82.0 83.0 100.0 83.0 83.0 110.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:04:49 INFO - PROCESS | 7473 | Values: 118.0 118.0 117.0 117.0 119.0 117.0 117.0 117.0 118.0 118.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.51 (1.0%) stddev-sans-first:1.59 13:04:49 INFO - PROCESS | 7473 | Values: 148.0 146.0 147.0 147.0 148.0 147.0 149.0 147.0 146.0 151.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 13:04:49 INFO - PROCESS | 7473 | Values: 96.0 96.0 95.0 95.0 97.0 96.0 97.0 95.0 96.0 96.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.00 stddev:1.93 (3.6%) stddev-sans-first:2.03 13:04:49 INFO - PROCESS | 7473 | Values: 53.0 52.0 55.0 52.0 56.0 58.0 53.0 53.0 53.0 53.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 13:04:49 INFO - PROCESS | 7473 | Values: 62.0 61.0 61.0 62.0 62.0 61.0 60.0 60.0 60.0 61.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:2.36 (2.9%) stddev-sans-first:2.47 13:04:49 INFO - PROCESS | 7473 | Values: 80.0 81.0 82.0 79.0 80.0 79.0 80.0 79.0 84.0 86.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:132.00 stddev:10.44 (7.9%) stddev-sans-first:11.06 13:04:49 INFO - PROCESS | 7473 | Values: 131.0 127.0 134.0 123.0 124.0 127.0 143.0 133.0 157.0 126.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:3.94 (2.4%) stddev-sans-first:2.03 13:04:49 INFO - PROCESS | 7473 | Values: 176.0 164.0 167.0 168.0 166.0 165.0 164.0 162.0 167.0 163.0 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.70 (2.6%) stddev-sans-first:1.76 13:04:49 INFO - PROCESS | 7473 | Values: 64.0 67.0 64.0 68.0 65.0 66.0 65.0 65.0 64.0 62.0 13:04:49 INFO - PROCESS | 7473 | -------- Summary: end -------- 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | 13:04:49 INFO - PROCESS | 7473 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:04:49 INFO - PROCESS | 7473 | 13:04:50 INFO - TEST-INFO | 7473: exit 0 13:04:50 INFO - TEST-OK | kraken | took 62707ms 13:04:50 INFO - SUITE-END | took 1176s 13:04:50 INFO - Completed test suite (00:19:37) 13:04:50 INFO - javascript benchmark 13:04:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.544801925339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.938081238375, 3102.7207551320375, 3121.5785868907706, 3132.232603012262, 3146.669599692032, 5336.9199462008, 5467.535259502942, 5480.26016487774, 5536.114221724525, 5543.223948647187, 5421.9457805421935, 5425.02349577076, 5430.0768869292215, 5482.506574408302, 5547.694876781786, 4877.073356062355, 5017.9247311290355, 5053.393592768873, 5076.84769456915, 5140.0490909181735, 5018.84943451697, 5048.6465947383695, 5055.671381360218, 5069.315642388286, 5092.694438333712, 4912.7297998610065, 4941.431735350445, 4976.477469865685, 5028.044671512401, 5033.194688849803, 5039.47085556015, 5040.899182016339, 5043.949560504385, 5045.747712614391, 5112.3865136183895, 4986.152354099811, 4999.0, 5016.372953380827, 5019.397672279313, 5060.291559181717, 5288.418273989896, 5369.785208591652, 5399.379071406799, 5440.809571665012, 5539.169124631298, 5857.794977175821, 5863.736131874076, 5865.736041878125, 5916.940830591682, 5933.199018132583, 5866.472017518444, 5889.263842019747, 5891.8527036824, 5893.528517718572, 5907.881842363172, 5394.190871369326, 5400.1899715043055, 5443.074677304868, 5444.210589464545, 5484.451554844483, 5955.464008239279, 6021.066734656135, 6025.487833534111, 6078.75684972605, 6082.2701275847185, 5755.971220143872, 5767.942320576824, 5775.8556036099435, 5775.942240577624, 5776.277965254343, 5735.885282294331, 5799.739011744482, 5842.357340692521, 5852.151438041546, 5855.824325270249, 5784.855378615568, 5856.326522449887, 5862.618929769551, 5873.471387575139, 5896.941030589639, 5819.127130930309, 5868.647881127146, 5874.50066744323, 5878.118282257696, 5910.34986151523, 4445.177642136216, 4483.50681425043, 4487.282034874404, 4521.389612402284, 4535.455745310518, 3959.703022273341, 3972.781497017692, 3982.123932734794, 4012.598740126022, 4024.597540245952, 5559.861003474945, 5561.165825126182, 5609.326880774333, 5616.887662246814, 5622.240997465372, 5827.970860145672, 5847.795327163529, 5894.145348924382, 5942.851428714231, 5948.613340132878, 5588.2455868458055, 5591.664500130005, 5607.299087614048, 5656.5757568181725, 5719.370869204384, 4945.134601444733, 4994.375703037121, 4998.1253280676465, 5005.9749701251985, 5051.444341122474, 6056.121862329937, 6061.212042434543, 6084.452399284086, 6101.694915254131, 6112.786052488142, 5756.251687280626, 5839.124131380327, 5840.386759390372, 5865.501432378295, 5946.1972633693895, 6060.696965151813, 6083.9136610884925, 6084.269887613337, 6111.5110791137495, 6113.57204995646, 5816.738246778989, 5818.854528636818, 5860.941390586039, 5879.911801323069, 5916.171735956884, 5938.376470470538, 5964.493018093511, 5972.641641501524, 5993.861166378374, 5994.820155395345, 5599.104143337209, 5702.572307077069, 5772.682502462405, 5774.82675519735, 5791.710414479344, 5685.687287199078, 5748.166515855261, 5754.4533269339345, 5769.932562475956, 5842.211301474246, 5666.688332141772, 5722.084466485342, 5731.828045158652, 5756.510696590837, 5782.826515204551, 5674.602777805679, 5764.164196191445, 5817.185594016756, 5821.76712931478, 5824.359320474659, 5484.670919744828, 5622.887542249214, 5632.88734225305, 5639.774409023593, 5751.396103409082], "value": 5418.313743634988, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.7225849907385, 565.7482420322958, 572.7394035713751, 584.780707234787, 602.0667964654785, 42644.57355426448, 43904.99999999996, 43941.340879886826, 48410.0, 48534.0, 44361.0, 44614.55385446153, 44728.77635611826, 45005.0, 45073.0, 8946.329025323093, 9030.548472576378, 9031.95484022579, 9086.091390860895, 9147.496887671176, 8922.687705930293, 8965.641374345018, 8966.955165224164, 8995.785568948173, 9002.099790021011, 8971.327150463709, 9018.68434604789, 9051.637934482613, 9078.86381704275, 9119.316051296146, 8973.865392019125, 8981.640734370618, 8986.14631609996, 9022.86465703015, 9043.773905652411, 8871.55642217893, 8876.911230887674, 8900.065493123193, 8951.776205594912, 8962.775930601721, 43931.560684393386, 44446.777766111285, 44465.55534444679, 44727.0, 44763.552364476265, 3384.187794929224, 3495.9126021849656, 3538.5930617979006, 3773.6792372648356, 3957.9010524736823, 32406.837965810257, 32435.837820810746, 32487.51268730971, 32757.672423275937, 32892.83553582217, 4263.637590804786, 4267.0900802388605, 4390.648748100144, 4446.954965583085, 4477.574630410106, 237935.0, 239030.0, 239683.0, 240341.0, 240520.0, 57443.13835292474, 58277.0, 58284.70857645769, 58365.41634583685, 58426.0, 37130.44304335383, 38459.42310865339, 61667.38332616706, 61687.0, 61828.0, 16377.181140942905, 16511.917440412722, 16733.497995060166, 16736.6652666946, 16769.496915092568, 11909.047276217882, 11933.28400295985, 11949.283043017447, 11962.162648614514, 11963.64109076729, 19193.136308866135, 19253.518662033563, 19262.4221273362, 19298.517537061685, 19433.31983380575, 7092.893606595905, 7151.604212588841, 7210.351068403764, 7249.673764680602, 7264.782056538313, 835.6406745099665, 901.2519608724742, 974.9122578967927, 1011.7672935224939, 1017.3438132404558, 30929.845350773103, 32702.509462358084, 32832.50751238733, 32921.506177407355, 33246.83376583102, 993.8360170571775, 1034.7464871106627, 1050.0759331787979, 1060.3319908457777, 1083.9945800270948, 16204.189790510427, 16954.660906781795, 17009.319627214772, 17054.147292635567, 17103.315867365167, 518839.0, 519494.0, 522507.0, 522754.0, 523650.0, 57825.0, 58461.0, 58507.41492585105, 58530.82938341209, 58551.0, 1228.121892846619, 1259.515086691612, 1261.6025951825145, 1313.2842600782787, 1319.9868001320056, 29527.409451811272, 31422.685773141977, 31443.37113257768, 31751.0, 32032.359352812346, 50455.747721262625, 50545.74727126341, 50753.23870141877, 50999.0, 51003.74498127485, 426470.0, 428747.0, 429727.0, 429852.0, 429883.0, 27462.725372746816, 28462.715372846007, 29055.7094429053, 29154.0, 29509.85245073761, 46928.530714693785, 46998.53001470078, 47236.7638161807, 47886.28170577374, 47924.281135782294, 39643.78167134724, 40456.190876181725, 40467.3929891046, 41174.79412602918, 42351.0, 40803.38794918019, 41192.79403602963, 41202.175956481304, 42568.36147457852, 43407.782961084995, 37267.62732372642, 38695.22609547737, 39189.80405097956, 41887.58112418837, 46699.0, 38505.0, 38652.420213696256, 38752.80623596864, 42605.0, 43167.0, 32651.0, 34601.82699086489, 34643.48034779531, 34742.82628586841, 34937.47593786146], "value": 19923.286717539744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.31065034116835, 407.5231978585057, 408.3772247322834, 413.3881854854816, 425.0457722413183, 18252.45242642721, 19809.504762380948, 19893.3037343693, 19896.10467528961, 20060.097295621694, 18448.169832357544, 18765.249390024383, 19302.420927372164, 19921.402357929248, 19960.600787984233, 5612.550995920337, 5631.60578759487, 5855.76576936922, 5903.822885313426, 5986.341502434729, 5722.084466485363, 5849.8830023399505, 5864.149698293745, 5868.325142608591, 5877.941220587803, 5872.17789509469, 5926.911096333559, 5929.822105336847, 5942.465178133967, 5960.374160713128, 5666.263385759866, 5807.128930660392, 5849.093390524476, 5879.353271140171, 5922.2005029321135, 5738.0532212184935, 5738.8278351649515, 5739.62692424991, 5754.539636829044, 5754.942450575482, 11979.401029948554, 12219.694507637292, 12261.080418968613, 12565.748685026248, 21246.468838279012, 2008.658528050235, 2118.6186486432434, 2119.0993827623197, 2221.833362497803, 2272.5909336319455, 10042.89957100427, 10062.547185376676, 10202.795944081077, 10324.328918620266, 10568.947155264175, 1874.1191639929211, 1879.1168150969022, 1936.244864502845, 1946.6690662587393, 2015.939521814348, 80076.0, 84163.0, 86628.56685716531, 86880.0, 87974.5601271996, 11297.435128243555, 11465.484053217626, 11604.593839215588, 11637.53449861996, 11835.940820296015, 15850.0, 15987.60030999211, 16016.919915400582, 16039.11784851821, 16128.193590320438, 7950.6422211000645, 8048.637811298506, 8113.594320283963, 8214.219649133323, 8539.316854651614, 7420.9628951855975, 7568.583727894908, 7663.157052724196, 7735.22647735222, 8060.516369017878, 4743.292414730694, 4806.735629540339, 4889.4377146627885, 4918.385201849769, 4932.284818701268, 1934.5937353155714, 2002.0390212697696, 2035.5827055453597, 2067.0904801887123, 2072.699458578498, 836.3727204596553, 885.1853699915148, 892.3396686451979, 977.154761131616, 991.7024892532212, 18841.0, 20283.79716202819, 20392.388228353175, 20441.795582044288, 20525.178992840418, 884.6903583745766, 907.8638204269413, 942.6465075596651, 971.9222462203007, 997.5112195024386, 10548.789024219474, 11270.154738394653, 11320.490577924013, 11362.375069371265, 11448.313101213955, 459582.0, 459585.0, 463281.0, 467544.0, 474061.0, 92997.5350123245, 93178.53410732903, 93950.53024734833, 94831.52584237173, 97094.51452742692, 991.9504024798731, 993.9006099390148, 1032.0969151992008, 1051.1748277602046, 1057.746140926172, 17148.485545433658, 17352.0, 17980.2807887683, 18112.45662630123, 18255.361062362754, 42733.57266427296, 43037.56962430335, 43223.783881081654, 43569.128617428105, 43658.34512482379, 57742.7112864433, 58976.70511647414, 59298.0, 59327.0, 60284.69857650684, 8364.53995030255, 8539.188777066418, 8568.779534624071, 8688.261497772508, 8778.297736181217, 12278.386080695751, 12933.417996190006, 13065.346732663138, 13112.213267203999, 13207.60377188686, 11029.44852757343, 11384.373859437479, 11431.828522572334, 11616.767664646828, 11744.58893938708, 11325.603603873826, 11555.537778489102, 11698.0, 11910.0, 12217.45021474018, 11360.0, 11391.544338226378, 11485.885141148816, 11748.530058797895, 11959.701007474534, 8478.877296134906, 8482.57587120629, 8760.51817150063, 8768.736937891874, 9140.537513997728, 8456.534890580831, 10738.892611073788, 11341.886581134084, 11854.58508952217, 11855.407229638311], "value": 9141.633880295592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.2361448432334, 1488.1145718297614, 1588.0, 1673.1466951854566, 1706.6416052628947, 7841.4903031303065, 8110.878336824938, 8383.245507904287, 9065.18413342799, 9082.500462474569, 8360.372972027108, 8673.436226645264, 8709.129087091287, 8795.296376289898, 8862.291016718664, 2292.862428254302, 2332.720073591163, 2334.6498025296173, 2334.976650233493, 2336.6378211377264, 2282.4065742906882, 2309.4919117794143, 2318.6637937499054, 2322.0, 2332.615118505453, 2333.2766842278947, 2345.3550273674705, 2349.788519033287, 2389.5220955808823, 2389.832711710181, 2252.3468194223656, 2281.4638559938403, 2285.657151427291, 2289.404754763765, 2291.8510296830736, 2179.5314007488464, 2190.58378908007, 2191.2111639809655, 2191.6822060801096, 2194.4513871532117, 8905.332100092453, 9023.052579479192, 9048.592813323416, 9049.954750226272, 9079.092090790868, 5117.8720531987, 5194.0, 5263.368395792491, 5279.260903473517, 5288.1803320485005, 3172.587563616738, 3231.0791424444155, 3366.0, 3379.4423920053164, 3402.0474267205223, 1202.7534355457199, 1212.4422765527868, 1232.975340493185, 1234.154604096197, 1241.2304371289767, 12141.15011949164, 12328.753424931541, 12333.260004399675, 12380.380980950917, 12395.442205100791, 4376.431063961728, 4561.498235194126, 4671.229247174178, 4724.078804633064, 4759.095771803346, 10410.843837342445, 10423.478826058667, 10424.061834434937, 10426.530806113591, 10431.113355364727, 5224.686518808883, 5259.974305010486, 5295.0, 5298.311219541512, 5310.60170487215, 4256.787160641956, 4379.4525684289465, 4696.459907110658, 4843.709377437365, 4883.780229889663, 3895.96104038956, 4043.1913617276073, 4069.267531844237, 4127.442795222607, 4134.937975930364, 1318.7032917593656, 1322.907396482237, 1324.7414955792035, 1329.2954733991, 1343.1605246720799, 727.6034561164179, 907.8683590879285, 922.1700469577299, 942.8727121838601, 946.1059298962415, 5799.391063938226, 5887.941120588825, 5944.3164036136395, 6000.759969601254, 6155.415235552616, 451.17209919796886, 452.08227298583927, 454.4138061900178, 935.7473482159915, 1019.2202964731986, 4004.2592120457225, 4013.8795836124964, 4055.6349928506575, 4092.9181416371507, 4163.708540402204, 10663.573457061631, 10817.78364432707, 10931.672049838518, 10938.835917461245, 10946.781064378667, 10785.083267922315, 10832.78334433307, 10846.945765271123, 10872.0, 10876.673699789018, 8103.756887293391, 8111.986001749781, 8226.465279756916, 8333.79165520879, 8377.748667539983, 5868.647881127146, 5883.646981181143, 5935.851603709769, 6063.636181829104, 6192.907106393498, 9923.950380248341, 10002.199824014207, 10009.399436033862, 10088.949555252177, 10109.49452527356, 10013.549390277309, 10435.634752783617, 10448.58205671795, 10482.318649287772, 10488.842667359842, 6435.51733619971, 6621.602703837785, 7186.568805871664, 7538.133114691661, 7689.692412303445, 8404.20160084791, 8580.412623664392, 8637.049924508174, 8660.437071590326, 8667.653293868427, 7589.544627322378, 7631.847363052597, 7809.531428114331, 7912.0505539335645, 7943.523388596703, 7160.319769621878, 7384.298491643285, 7392.0, 7450.96274518624, 7595.430342724208, 6914.4468442525485, 7035.296470353129, 7049.29507049291, 7056.8588628226125, 7067.0459487968465, 4930.112579735682, 4985.3020577118505, 5007.39911210657, 5040.319556859777, 5158.819441319536, 5170.40540337866, 5249.580033597226, 5259.815906443256, 5266.605004624746, 5296.152615581643], "value": 4579.581845379633, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9621693505248, 334.58344361270224, 335.70122590894107, 339.6314998226924, 341.482653779524, 5391.0, 5406.216098665696, 5532.917006244909, 5582.748776305071, 5598.7962588043565, 5420.810271640494, 5470.452954704538, 5481.369642491115, 5495.175723641446, 5507.428834067714, 4286.142771445708, 4288.356746488021, 4292.549282325358, 4296.699231053827, 4305.98809279819, 4224.831006759726, 4246.540780940045, 4253.766042867641, 4264.061906380592, 4307.289297265963, 4216.704830661855, 4222.873313800591, 4237.470316210473, 4245.7240279381895, 4246.214450326684, 4209.936850947238, 4215.768132752697, 4218.49378074633, 4219.0, 4264.211120942636, 3730.4404339349044, 3741.1021354874906, 3744.719146064056, 3745.8127093645207, 3755.6244375562496, 5131.4098878629065, 5339.466053394668, 5342.332208473941, 5370.91943620846, 5376.1398176292, 4841.491643377465, 4861.319415281828, 4870.342503761982, 4873.439554451248, 4874.829380971649, 5465.808696695636, 5753.510951569122, 5768.183022347989, 5771.278590176228, 5788.565857560658, 4059.451973983504, 4072.572379900127, 4073.877783666495, 4086.468759061303, 4103.158852435274, 6007.939920600782, 6027.728752206117, 6034.36639152887, 6047.606905551125, 6049.395060493959, 3911.9608803912165, 4128.401381799622, 4134.669226461936, 4163.188178305201, 4170.270202714573, 4144.52337981136, 4161.729487583298, 4193.895152621209, 4205.422966387605, 4213.494380674339, 4801.159797035505, 4828.46886842447, 4834.903301934012, 4840.927386089212, 4852.1508735971065, 5524.392316845144, 5728.971355143198, 5767.134929760486, 5787.0, 5804.419558044162, 1424.4088703188268, 1433.1974094506902, 1439.1868594244218, 1441.3802065112102, 1448.8840892728556, 874.9387542871938, 914.9542522873962, 925.2551695884742, 926.5182105305204, 927.7124091531647, 4819.807207711652, 4850.587700045536, 4906.828261010847, 4935.3090567320605, 4944.25836124577, 5188.11801993662, 5217.973910130501, 5223.817166399158, 5231.686098834082, 5240.502152295526, 4613.446386433649, 4862.319275301461, 4917.9426423319155, 4954.653174277766, 4956.330895329156, 2752.944941101167, 2760.1920741914078, 2775.8889644414403, 2775.9167224983285, 2784.818986765854, 5272.657277276965, 5315.601329900195, 5333.626646134733, 5377.462253774669, 5387.353517577837, 4908.0, 5150.969806038807, 5212.609054320866, 5287.5677188492955, 5315.73421328932, 5284.207368894619, 5291.708956007456, 5305.44292849253, 5308.336457942757, 5336.67979921206, 5123.590112790893, 5148.382194136578, 5151.948480515297, 5152.948470515247, 5174.534291913746, 4698.906021879475, 5081.92377114351, 5116.155834287301, 5138.511841375063, 5158.793648254028, 5254.7898084076205, 5301.985245606645, 5315.548178404879, 5326.733663316896, 5357.491038351351, 3799.6511238511034, 3948.9210215794947, 4012.518497780285, 4030.8387664493093, 4097.364908439196, 5830.475257226701, 5849.678267695147, 5856.180134781049, 5885.3820348862755, 5885.440883116097, 5570.0, 5726.455986681259, 5751.332113686984, 5761.337446193741, 5762.654240745569, 5640.85897852557, 5680.5230640034715, 5682.204491371129, 5714.428507171706, 5722.828315150552, 5634.915476267777, 5672.631278966854, 5732.971335143297, 5736.627119237403, 5759.596828221985, 5493.725313734377, 5690.459406356389, 5699.145128230799, 5780.364159942319, 5789.334226563999, 5568.77724891016, 5578.525825304894, 5581.665100094007, 5586.944130558805, 5593.67176529964], "value": 4197.867269981907, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.1608185236414, 647.9902801457978, 724.1997592660107, 730.6237287796786, 742.380112605974, 14026.298685065743, 14312.856871431282, 14479.855201447983, 14506.492272770454, 15376.923115384436, 14683.265836708175, 14989.47536836211, 15000.249987500609, 15019.249037548107, 15035.473758418457, 793.4247670438914, 805.2631841864687, 823.2508417340222, 824.7938015496126, 824.8803923431099, 818.6766227340197, 825.5211977053294, 825.9256666899978, 828.2876726015652, 828.3745771942175, 857.5455008845322, 859.5573279760928, 860.1527495417009, 860.4622111180512, 861.1732736572866, 848.9915100848974, 850.336737344872, 851.6082602003086, 852.2925971443686, 854.9615267312923, 620.5935112501319, 625.4871005775266, 625.7715933684173, 626.092166358777, 628.2021832272987, 14732.631684207981, 14907.925460372737, 14922.925385373112, 14929.701405971928, 14957.252137393196, 13037.804432933419, 13058.608241752667, 13351.332433378293, 13556.254406007665, 13567.118137321042, 10412.531436085319, 10498.317609355443, 10660.466976651136, 10694.679159625224, 10847.51186196623, 3753.680937120321, 3764.870538838365, 3794.2221844522082, 3800.923981520382, 3888.650021498079, 83475.0, 83755.0, 84204.15795842024, 84466.15533844645, 85090.0, 9951.452670103214, 10176.491175441346, 10231.386116833013, 10349.482525873827, 10586.311889727298, 19926.800731992786, 19961.700574491395, 20235.19059237614, 20438.489037773877, 20457.38627841167, 7886.763397098096, 7923.564203968837, 7932.960335198402, 7983.880241796378, 8168.0, 4434.11317736454, 4509.843109823071, 4605.332226827091, 4628.95371046292, 4666.626669866402, 3427.9314413711586, 3499.9825000874835, 3505.4741788731894, 3523.94714079289, 3551.8579256829953, 571.7512881896388, 572.7680289482767, 578.9276340457443, 597.8087012156068, 610.4109534299422, 703.7712743358429, 719.2879049740719, 723.106962900817, 729.4018904498366, 765.1927216786344, 8868.955655221682, 9168.541572921327, 9780.217582593375, 9807.117359437685, 10073.0, 579.5189992306375, 739.9408047356198, 747.4431548496297, 753.6683859101978, 758.518340853562, 4576.565226303496, 4587.3807036050375, 4587.816487340469, 4743.288506724019, 4810.067444322403, 76083.61958190284, 109430.88699234524, 115046.4247678773, 120498.0, 124979.0, 79305.0, 80051.19948800554, 82564.0, 103393.48303258586, 104354.0, 59473.40526594765, 61559.38440615626, 76135.0, 82875.5856220715, 84766.99999999876, 9208.631654733736, 9997.55011024491, 10116.342437741523, 10134.493275336055, 10357.533910973874, 52795.0, 53709.46290537201, 55085.724571376886, 55633.0, 56671.58321041842, 69059.65470172818, 76732.6163369202, 77721.61139194494, 79696.60151699204, 82025.0, 12866.742665146832, 12926.676833078873, 13040.804387934379, 13338.26639534835, 13684.726305474034, 13394.050635436546, 14100.647483812576, 14102.647433814236, 14371.281435927953, 14772.704545908806, 12675.239485630891, 12894.548690795777, 13014.544490942772, 13123.212607243597, 14790.0, 13503.797443038558, 13696.246706431242, 14034.649133771329, 14076.0, 14131.87172288815, 11684.415779210836, 11698.239614425034, 12239.32683702405, 12250.081243906565, 12492.687682808002, 11029.338239705643, 11053.392063436588, 11139.220254582102, 11262.8768406162, 11362.204645674723, 11739.530418783495, 11912.76174476523, 11966.341851198267, 12097.2136811107, 12278.570250041563], "value": 7394.982417230089, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 113.0, 113.0, 117.0, 113.0, 114.0, 112.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 121.0, 176.0, 126.0, 121.0, 126.0, 121.0, 150.0, 122.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 170.0, 168.0, 175.0, 165.0, 161.0, 163.0, 164.0, 162.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 127.0, 77.0, 77.0, 76.0, 75.0, 101.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 105.0, 84.0, 82.0, 83.0, 100.0, 83.0, 83.0, 110.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 148.0, 147.0, 149.0, 147.0, 146.0, 151.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 97.0, 96.0, 97.0, 95.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 55.0, 52.0, 56.0, 58.0, 53.0, 53.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 60.0, 60.0, 60.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 82.0, 79.0, 80.0, 79.0, 80.0, 79.0, 84.0, 86.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 134.0, 123.0, 124.0, 127.0, 143.0, 133.0, 157.0, 126.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 164.0, 167.0, 168.0, 166.0, 165.0, 164.0, 162.0, 167.0, 163.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 64.0, 68.0, 65.0, 66.0, 65.0, 65.0, 64.0, 62.0], "value": 65.0, "unit": "score"}]}]} 13:04:51 INFO - Return code: 0 13:04:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:04:51 ERROR - # TBPL SUCCESS # 13:04:51 INFO - Running post-action listener: _resource_record_post_action 13:04:51 INFO - [mozharness: 2016-09-23 20:04:51.153072Z] Finished run-tests step (success) 13:04:51 INFO - Running post-run listener: _resource_record_post_run 13:04:51 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400265216; Read time: 164; Write time: 255596 13:04:51 INFO - TinderboxPrint: CPU usage
13.5% 13:04:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 164 13:04:51 INFO - TinderboxPrint: I/O write bytes / time
400,265,216 / 255,596 13:04:51 INFO - TinderboxPrint: CPU idle
8,239.8 (86.5%) 13:04:51 INFO - TinderboxPrint: CPU user
1,217.4 (12.8%) 13:04:51 INFO - TinderboxPrint: Swap in / out
0 / 0 13:04:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111099904; Read time: 0; Write time: 86392 13:04:51 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289165312; Read time: 164; Write time: 169204 13:04:51 INFO - Running post-run listener: _upload_blobber_files 13:04:51 INFO - Blob upload gear active. 13:04:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:04:51 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 13:04:51 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'] 13:04:51 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 13:04:52 INFO - (blobuploader) - INFO - Open directory for files ... 13:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:57 INFO - (blobuploader) - INFO - Done attempting. 13:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:04:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:58 INFO - (blobuploader) - INFO - Done attempting. 13:04:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:59 INFO - (blobuploader) - INFO - Done attempting. 13:04:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:04:59 INFO - Return code: 0 13:04:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:04:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:04:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d48ae28acdb752da675a0dfbacb2bf2e74e23575a0d512c3fab29588b06bdb4d57260c1648166ef56a2bd99c5501ab40d6fd4863703bb00ade3548afb217e06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8da90fca38310f2d6c9cba7ab2f494bff54f8e6360d08b640b4971ed6421b5d853bf6f38e6ef47f64025c0f04b0278d9ff6e74a91e5ecb10cc6c191e98af23a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e43eb01d5eee03c2ece9954ff95b5f37d31f482c6a3e73ace071454437ccf7e2c09e24a47e8b6ed22bcaf055cd580d851f8ef20a8152babe2f93a5ced4c5873"} 13:04:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:04:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:04:59 INFO - Contents: 13:04:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d48ae28acdb752da675a0dfbacb2bf2e74e23575a0d512c3fab29588b06bdb4d57260c1648166ef56a2bd99c5501ab40d6fd4863703bb00ade3548afb217e06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8da90fca38310f2d6c9cba7ab2f494bff54f8e6360d08b640b4971ed6421b5d853bf6f38e6ef47f64025c0f04b0278d9ff6e74a91e5ecb10cc6c191e98af23a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e43eb01d5eee03c2ece9954ff95b5f37d31f482c6a3e73ace071454437ccf7e2c09e24a47e8b6ed22bcaf055cd580d851f8ef20a8152babe2f93a5ced4c5873"} 13:04:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:04:59 INFO - Copying logs to upload dir... 13:04:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:04:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.610796 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-23 13:04:59.733649) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 13:04:59.737124) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071 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/7d48ae28acdb752da675a0dfbacb2bf2e74e23575a0d512c3fab29588b06bdb4d57260c1648166ef56a2bd99c5501ab40d6fd4863703bb00ade3548afb217e06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8da90fca38310f2d6c9cba7ab2f494bff54f8e6360d08b640b4971ed6421b5d853bf6f38e6ef47f64025c0f04b0278d9ff6e74a91e5ecb10cc6c191e98af23a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e43eb01d5eee03c2ece9954ff95b5f37d31f482c6a3e73ace071454437ccf7e2c09e24a47e8b6ed22bcaf055cd580d851f8ef20a8152babe2f93a5ced4c5873"} build_url:https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/bpY3qbD8REKo6wtuyntI8A/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/7d48ae28acdb752da675a0dfbacb2bf2e74e23575a0d512c3fab29588b06bdb4d57260c1648166ef56a2bd99c5501ab40d6fd4863703bb00ade3548afb217e06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8da90fca38310f2d6c9cba7ab2f494bff54f8e6360d08b640b4971ed6421b5d853bf6f38e6ef47f64025c0f04b0278d9ff6e74a91e5ecb10cc6c191e98af23a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e43eb01d5eee03c2ece9954ff95b5f37d31f482c6a3e73ace071454437ccf7e2c09e24a47e8b6ed22bcaf055cd580d851f8ef20a8152babe2f93a5ced4c5873"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 13:04:59.763951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 13:04:59.764330) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1474659857.687726-1702623071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 13:04:59.846612) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 13:04:59.846937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 13:04:59.847232) ========= ========= Total master_lag: 0.17 =========