builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1471629696.23 results: success (0) buildid: 20160819080504 builduid: 808397dc8fdb414a803f5946048d6522 revision: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:36.228547) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:36.229101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:36.229425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:36.271782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:36.272139) ========= 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=6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 11:01:36-- 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% 219M=0s 2016-08-19 11:01:36 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:36.394011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:36.394588) ========= 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=6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018391 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:36.464193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 11:01:36.464557) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c --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=6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 11:01:36,847 truncating revision to first 12 chars 2016-08-19 11:01:36,847 Setting DEBUG logging. 2016-08-19 11:01:36,848 attempt 1/10 2016-08-19 11:01:36,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23c2ec5544b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 11:01:38,165 unpacking tar archive at: mozilla-central-23c2ec5544b9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.660459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 11:01:38.148050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:38.148371) ========= script_repo_revision: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:38.148785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:38.149053) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:01:38.159340) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-19 11:01:38.159651) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:01:38 INFO - MultiFileLogger online at 20160819 11:01:38 in /builds/slave/test 11:01:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:01:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:01:38 INFO - {'append_to_log': False, 11:01:38 INFO - 'base_work_dir': '/builds/slave/test', 11:01:38 INFO - 'blob_upload_branch': 'Firefox', 11:01:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:01:38 INFO - 'branch': 'Firefox', 11:01:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:38 INFO - 'config_files': ('talos/linux_config.py',), 11:01:38 INFO - 'default_actions': ('clobber', 11:01:38 INFO - 'read-buildbot-config', 11:01:38 INFO - 'download-and-extract', 11:01:38 INFO - 'populate-webroot', 11:01:38 INFO - 'create-virtualenv', 11:01:38 INFO - 'install', 11:01:38 INFO - 'run-tests'), 11:01:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:38 INFO - 'download_minidump_stackwalk': True, 11:01:38 INFO - 'download_symbols': 'ondemand', 11:01:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:38 INFO - 'installer_path': 'installer.exe', 11:01:38 INFO - 'log_level': 'info', 11:01:38 INFO - 'log_name': 'talos', 11:01:38 INFO - 'log_to_console': True, 11:01:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:01:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:01:38 INFO - 'opt_config_files': (), 11:01:38 INFO - 'pip_index': False, 11:01:38 INFO - 'sps_profile': False, 11:01:38 INFO - 'sps_profile_interval': 0, 11:01:38 INFO - 'suite': 'dromaeojs', 11:01:38 INFO - 'system_bits': '32', 11:01:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:38 INFO - 'title': 'talos-linux64-ix-050', 11:01:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:38 INFO - 'use_talos_json': True, 11:01:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:01:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:38 INFO - 'work_dir': 'build'} 11:01:38 INFO - [mozharness: 2016-08-19 18:01:38.627817Z] Running clobber step. 11:01:38 INFO - Running pre-action listener: _resource_record_pre_action 11:01:38 INFO - Running main action method: clobber 11:01:38 INFO - rmtree: /builds/slave/test/build 11:01:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:01:39 INFO - Running post-action listener: _resource_record_post_action 11:01:39 INFO - [mozharness: 2016-08-19 18:01:39.094428Z] Finished clobber step (success) 11:01:39 INFO - [mozharness: 2016-08-19 18:01:39.094530Z] Running read-buildbot-config step. 11:01:39 INFO - Running pre-action listener: _resource_record_pre_action 11:01:39 INFO - Running main action method: read_buildbot_config 11:01:39 INFO - Using buildbot properties: 11:01:39 INFO - { 11:01:39 INFO - "project": "", 11:01:39 INFO - "product": "firefox", 11:01:39 INFO - "script_repo_revision": "production", 11:01:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:01:39 INFO - "repository": "", 11:01:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 11:01:39 INFO - "buildid": "20160819080504", 11:01:39 INFO - "stage_platform": "linux64-pgo", 11:01:39 INFO - "basedir": "/builds/slave/test", 11:01:39 INFO - "nightly_build": "True", 11:01:39 INFO - "buildnumber": 837, 11:01:39 INFO - "slavename": "talos-linux64-ix-050", 11:01:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:01:39 INFO - "platform": "ubuntu64_hw", 11:01:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:01:39 INFO - "branch": "mozilla-central", 11:01:39 INFO - "repo_path": "mozilla-central", 11:01:39 INFO - "revision": "23c2ec5544b9e0a74a047b87b594e4c36a8fe95c", 11:01:39 INFO - "pgo_build": "True", 11:01:39 INFO - "builduid": "808397dc8fdb414a803f5946048d6522", 11:01:39 INFO - "slavebuilddir": "test" 11:01:39 INFO - } 11:01:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:01:39 INFO - Running post-action listener: _resource_record_post_action 11:01:39 INFO - [mozharness: 2016-08-19 18:01:39.097048Z] Finished read-buildbot-config step (success) 11:01:39 INFO - [mozharness: 2016-08-19 18:01:39.097137Z] Running download-and-extract step. 11:01:39 INFO - Running pre-action listener: _resource_record_pre_action 11:01:39 INFO - Running main action method: download_and_extract 11:01:39 INFO - mkdir: /builds/slave/test/build/tests 11:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:39 INFO - trying https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:01:39 INFO - Downloading https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:01:39 INFO - Downloaded 1361 bytes. 11:01:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:01:39 INFO - Using the following test package requirements: 11:01:39 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:01:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:01:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:39 INFO - u'jsshell-linux-x86_64.zip'], 11:01:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:01:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:01:39 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:01:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:01:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:01:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:39 INFO - trying https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:01:39 INFO - Downloading https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:01:40 INFO - Downloaded 21918972 bytes. 11:01:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:01:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:01: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')]} 11:01:44 INFO - trying https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:01:44 INFO - Downloading https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:01:45 INFO - Downloaded 21918972 bytes. 11:01:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:01:50 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')]} 11:01:50 INFO - trying https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:50 INFO - Downloading https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:01:51 INFO - Downloaded 14413981 bytes. 11:01:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:01: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')]} 11:01:51 INFO - trying https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:01:51 INFO - Downloading https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:01:53 INFO - Downloaded 59648261 bytes. 11:01:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:01:53 INFO - mkdir: /builds/slave/test/properties 11:01:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:01:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:01:53 INFO - Contents: 11:01:53 INFO - build_url:https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:01:54 INFO - Running post-action listener: _resource_record_post_action 11:01:54 INFO - Running post-action listener: set_extra_try_arguments 11:01:54 INFO - [mozharness: 2016-08-19 18:01:54.316232Z] Finished download-and-extract step (success) 11:01:54 INFO - [mozharness: 2016-08-19 18:01:54.316477Z] Running populate-webroot step. 11:01:54 INFO - Running pre-action listener: _resource_record_pre_action 11:01:54 INFO - Running main action method: populate_webroot 11:01:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:54 INFO - '--tppagecycles', 11:01:54 INFO - '7'], 11:01:54 INFO - 'tests': ['tsvgm']}}, 11:01:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:01:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:01:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:01:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:54 INFO - 'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:54 INFO - 'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['damp', 'tps']}, 11:01:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:54 INFO - 'tests': ['damp', 'tps']}, 11:01:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['dromaeo_dom']}, 11:01:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['basic_compositor_video']}, 11:01:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:01:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['a11yr', 11:01:54 INFO - 'ts_paint', 11:01:54 INFO - 'tpaint', 11:01:54 INFO - 'sessionrestore', 11:01:54 INFO - 'sessionrestore_no_auto_restore', 11:01:54 INFO - 'tabpaint']}, 11:01:54 INFO - 'other-e10s': {'tests': ['a11yr', 11:01:54 INFO - 'ts_paint', 11:01:54 INFO - 'tpaint', 11:01:54 INFO - 'sessionrestore', 11:01:54 INFO - 'sessionrestore_no_auto_restore', 11:01:54 INFO - 'tabpaint']}, 11:01:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:01:54 INFO - 'ts_paint', 11:01:54 INFO - 'tpaint', 11:01:54 INFO - 'sessionrestore', 11:01:54 INFO - 'sessionrestore_no_auto_restore', 11:01:54 INFO - 'tabpaint']}, 11:01:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:01:54 INFO - 'ts_paint', 11:01:54 INFO - 'tpaint', 11:01:54 INFO - 'sessionrestore', 11:01:54 INFO - 'sessionrestore_no_auto_restore', 11:01:54 INFO - 'tabpaint']}, 11:01:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['a11yr', 11:01:54 INFO - 'ts_paint', 11:01:54 INFO - 'tpaint', 11:01:54 INFO - 'sessionrestore', 11:01:54 INFO - 'sessionrestore_no_auto_restore', 11:01:54 INFO - 'tabpaint']}, 11:01:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['a11yr', 11:01:54 INFO - 'ts_paint', 11:01:54 INFO - 'tpaint', 11:01:54 INFO - 'sessionrestore', 11:01:54 INFO - 'sessionrestore_no_auto_restore', 11:01:54 INFO - 'tabpaint']}, 11:01:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['tsvgx', 11:01:54 INFO - 'tsvgr_opacity', 11:01:54 INFO - 'tart', 11:01:54 INFO - 'tscrollx', 11:01:54 INFO - 'cart']}, 11:01:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:01:54 INFO - 'tsvgr_opacity', 11:01:54 INFO - 'tart', 11:01:54 INFO - 'tscrollx', 11:01:54 INFO - 'cart']}, 11:01:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:54 INFO - 'talos_options': ['--disable-e10s'], 11:01:54 INFO - 'tests': ['tp5o']}, 11:01:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:54 INFO - 'tests': ['tp5o']}, 11:01:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:54 INFO - 'talos_options': ['--disable-e10s', 11:01:54 INFO - '--xperf_path', 11:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:54 INFO - 'tests': ['tp5n']}, 11:01:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:54 INFO - 'talos_options': ['--xperf_path', 11:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:54 INFO - 'tests': ['tp5n']}}, 11:01:54 INFO - 'talos.zip': {'path': '', 11:01:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:54 INFO - Running post-action listener: _resource_record_post_action 11:01:54 INFO - [mozharness: 2016-08-19 18:01:54.333049Z] Finished populate-webroot step (success) 11:01:54 INFO - [mozharness: 2016-08-19 18:01:54.333138Z] Running create-virtualenv step. 11:01:54 INFO - Running pre-action listener: _resource_record_pre_action 11:01:54 INFO - Running main action method: create_virtualenv 11:01:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:01:54 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 11:01:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:01:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:54 INFO - Using real prefix '/usr' 11:01:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:01:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:56 INFO - Installing pip.................done. 11:01:56 INFO - Return code: 0 11:01:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:01:56 INFO - Using env: {'DISPLAY': ':0', 11:01:56 INFO - 'HOME': '/home/cltbld', 11:01:56 INFO - 'LANG': 'en_US.UTF-8', 11:01:56 INFO - 'LANGUAGE': 'en_US:en', 11:01:56 INFO - 'LOGNAME': 'cltbld', 11:01:56 INFO - 'MAIL': '/var/mail/cltbld', 11:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:56 INFO - 'MOZ_NO_REMOTE': '1', 11:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:56 INFO - 'NO_EM_RESTART': '1', 11:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:56 INFO - 'PWD': '/builds/slave/test', 11:01:56 INFO - 'SHELL': '/bin/bash', 11:01:56 INFO - 'SHLVL': '1', 11:01:56 INFO - 'TERM': 'linux', 11:01:56 INFO - 'TMOUT': '86400', 11:01:56 INFO - 'USER': 'cltbld', 11:01:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:56 INFO - '_': '/tools/buildbot/bin/python'} 11:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:57 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 11:01:57 INFO - Cleaning up... 11:01:57 INFO - Return code: 0 11:01:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:01:57 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')]} 11:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:57 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')]} 11:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:57 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 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:01:57 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 11:01:57 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 11:01:57 INFO - Using env: {'DISPLAY': ':0', 11:01:57 INFO - 'HOME': '/home/cltbld', 11:01:57 INFO - 'LANG': 'en_US.UTF-8', 11:01:57 INFO - 'LANGUAGE': 'en_US:en', 11:01:57 INFO - 'LOGNAME': 'cltbld', 11:01:57 INFO - 'MAIL': '/var/mail/cltbld', 11:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:57 INFO - 'MOZ_NO_REMOTE': '1', 11:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:57 INFO - 'NO_EM_RESTART': '1', 11:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:57 INFO - 'PWD': '/builds/slave/test', 11:01:57 INFO - 'SHELL': '/bin/bash', 11:01:57 INFO - 'SHLVL': '1', 11:01:57 INFO - 'TERM': 'linux', 11:01:57 INFO - 'TMOUT': '86400', 11:01:57 INFO - 'USER': 'cltbld', 11:01:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:57 INFO - '_': '/tools/buildbot/bin/python'} 11:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:57 INFO - Downloading/unpacking psutil>=3.1.1 11:01:57 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 11:01:57 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 11:01:57 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 11:01:57 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 11:01:57 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 11:01:57 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 11:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:59 INFO - Installing collected packages: psutil 11:01:59 INFO - Running setup.py install for psutil 11:01:59 INFO - building 'psutil._psutil_linux' extension 11:01:59 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 11:01:59 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 11:01:59 INFO - building 'psutil._psutil_posix' extension 11:01:59 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 11:01:59 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 11:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:59 INFO - Successfully installed psutil 11:01:59 INFO - Cleaning up... 11:01:59 INFO - Return code: 0 11:01:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:59 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 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:01:59 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 11:01:59 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 11:01:59 INFO - Using env: {'DISPLAY': ':0', 11:01:59 INFO - 'HOME': '/home/cltbld', 11:01:59 INFO - 'LANG': 'en_US.UTF-8', 11:01:59 INFO - 'LANGUAGE': 'en_US:en', 11:01:59 INFO - 'LOGNAME': 'cltbld', 11:01:59 INFO - 'MAIL': '/var/mail/cltbld', 11:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:59 INFO - 'MOZ_NO_REMOTE': '1', 11:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:59 INFO - 'NO_EM_RESTART': '1', 11:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:59 INFO - 'PWD': '/builds/slave/test', 11:01:59 INFO - 'SHELL': '/bin/bash', 11:01:59 INFO - 'SHLVL': '1', 11:01:59 INFO - 'TERM': 'linux', 11:01:59 INFO - 'TMOUT': '86400', 11:01:59 INFO - 'USER': 'cltbld', 11:01:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:59 INFO - '_': '/tools/buildbot/bin/python'} 11:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:02:00 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 11:02:00 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 11:02:00 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 11:02:00 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 11:02:00 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 11:02:00 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 11:02:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:02:02 INFO - Installing collected packages: mozsystemmonitor 11:02:02 INFO - Running setup.py install for mozsystemmonitor 11:02:02 INFO - Successfully installed mozsystemmonitor 11:02:02 INFO - Cleaning up... 11:02:02 INFO - Return code: 0 11:02:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:02 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 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:02:02 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 11:02:02 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 11:02:02 INFO - Using env: {'DISPLAY': ':0', 11:02:02 INFO - 'HOME': '/home/cltbld', 11:02:02 INFO - 'LANG': 'en_US.UTF-8', 11:02:02 INFO - 'LANGUAGE': 'en_US:en', 11:02:02 INFO - 'LOGNAME': 'cltbld', 11:02:02 INFO - 'MAIL': '/var/mail/cltbld', 11:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:02 INFO - 'MOZ_NO_REMOTE': '1', 11:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:02 INFO - 'NO_EM_RESTART': '1', 11:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:02 INFO - 'PWD': '/builds/slave/test', 11:02:02 INFO - 'SHELL': '/bin/bash', 11:02:02 INFO - 'SHLVL': '1', 11:02:02 INFO - 'TERM': 'linux', 11:02:02 INFO - 'TMOUT': '86400', 11:02:02 INFO - 'USER': 'cltbld', 11:02:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:02 INFO - '_': '/tools/buildbot/bin/python'} 11:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:02:02 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 11:02:02 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 11:02:02 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 11:02:02 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 11:02:02 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 11:02:02 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 11:02:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:02:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:02:04 INFO - warning: no files found matching '*.txt' 11:02:04 INFO - no previously-included directories found matching 'build' 11:02:04 INFO - no previously-included directories found matching 'dist' 11:02:04 INFO - no previously-included directories found matching '.git*' 11:02:04 INFO - Installing collected packages: jsonschema, functools32 11:02:04 INFO - Running setup.py install for functools32 11:02:04 INFO - warning: no files found matching '*.txt' 11:02:04 INFO - no previously-included directories found matching 'build' 11:02:04 INFO - no previously-included directories found matching 'dist' 11:02:04 INFO - no previously-included directories found matching '.git*' 11:02:04 INFO - Successfully installed jsonschema functools32 11:02:04 INFO - Cleaning up... 11:02:04 INFO - Return code: 0 11:02:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:02:04 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')]} 11:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:04 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')]} 11:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:04 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 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:02:04 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 11:02:04 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 11:02:04 INFO - Using env: {'DISPLAY': ':0', 11:02:04 INFO - 'HOME': '/home/cltbld', 11:02:04 INFO - 'LANG': 'en_US.UTF-8', 11:02:04 INFO - 'LANGUAGE': 'en_US:en', 11:02:04 INFO - 'LOGNAME': 'cltbld', 11:02:04 INFO - 'MAIL': '/var/mail/cltbld', 11:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:04 INFO - 'MOZ_NO_REMOTE': '1', 11:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:04 INFO - 'NO_EM_RESTART': '1', 11:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:04 INFO - 'PWD': '/builds/slave/test', 11:02:04 INFO - 'SHELL': '/bin/bash', 11:02:04 INFO - 'SHLVL': '1', 11:02:04 INFO - 'TERM': 'linux', 11:02:04 INFO - 'TMOUT': '86400', 11:02:04 INFO - 'USER': 'cltbld', 11:02:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:04 INFO - '_': '/tools/buildbot/bin/python'} 11:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:02:04 INFO - Cleaning up... 11:02:04 INFO - Return code: 0 11:02:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:02:04 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')]} 11:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:04 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')]} 11:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:04 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 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:02:04 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 11:02:04 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 11:02:04 INFO - Using env: {'DISPLAY': ':0', 11:02:04 INFO - 'HOME': '/home/cltbld', 11:02:04 INFO - 'LANG': 'en_US.UTF-8', 11:02:04 INFO - 'LANGUAGE': 'en_US:en', 11:02:04 INFO - 'LOGNAME': 'cltbld', 11:02:04 INFO - 'MAIL': '/var/mail/cltbld', 11:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:04 INFO - 'MOZ_NO_REMOTE': '1', 11:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:04 INFO - 'NO_EM_RESTART': '1', 11:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:04 INFO - 'PWD': '/builds/slave/test', 11:02:04 INFO - 'SHELL': '/bin/bash', 11:02:04 INFO - 'SHLVL': '1', 11:02:04 INFO - 'TERM': 'linux', 11:02:04 INFO - 'TMOUT': '86400', 11:02:04 INFO - 'USER': 'cltbld', 11:02:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:04 INFO - '_': '/tools/buildbot/bin/python'} 11:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:02:05 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 11:02:05 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 11:02:05 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 11:02:05 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 11:02:05 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 11:02:05 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 11:02:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:02:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:02:07 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 11:02:07 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 11:02:07 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 11:02:07 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 11:02:07 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 11:02:07 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 11:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:02:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:02:07 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 11:02:07 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 11:02:07 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 11:02:07 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 11:02:07 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 11:02:07 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 11:02:07 INFO - Downloading docopt-0.6.1.tar.gz 11:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:02:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:02:07 INFO - Running setup.py install for blobuploader 11:02:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:02:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:02:07 INFO - Running setup.py install for requests 11:02:08 INFO - Running setup.py install for docopt 11:02:08 INFO - Successfully installed blobuploader requests docopt 11:02:08 INFO - Cleaning up... 11:02:08 INFO - Return code: 0 11:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:08 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 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:02:08 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 11:02:08 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 11:02:08 INFO - Using env: {'DISPLAY': ':0', 11:02:08 INFO - 'HOME': '/home/cltbld', 11:02:08 INFO - 'LANG': 'en_US.UTF-8', 11:02:08 INFO - 'LANGUAGE': 'en_US:en', 11:02:08 INFO - 'LOGNAME': 'cltbld', 11:02:08 INFO - 'MAIL': '/var/mail/cltbld', 11:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:08 INFO - 'MOZ_NO_REMOTE': '1', 11:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:08 INFO - 'NO_EM_RESTART': '1', 11:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:08 INFO - 'PWD': '/builds/slave/test', 11:02:08 INFO - 'SHELL': '/bin/bash', 11:02:08 INFO - 'SHLVL': '1', 11:02:08 INFO - 'TERM': 'linux', 11:02:08 INFO - 'TMOUT': '86400', 11:02:08 INFO - 'USER': 'cltbld', 11:02:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:08 INFO - '_': '/tools/buildbot/bin/python'} 11:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:08 INFO - Running setup.py (path:/tmp/pip-81SGNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:08 INFO - Running setup.py (path:/tmp/pip-IEh6Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:08 INFO - Running setup.py (path:/tmp/pip-umDJB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:08 INFO - Running setup.py (path:/tmp/pip-2mVsTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:08 INFO - Running setup.py (path:/tmp/pip-Wil6jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:09 INFO - Running setup.py (path:/tmp/pip-XIicUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:09 INFO - Running setup.py (path:/tmp/pip-EJ7NLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:09 INFO - Running setup.py (path:/tmp/pip-JPaTyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:09 INFO - Running setup.py (path:/tmp/pip-4C0p6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:09 INFO - Running setup.py (path:/tmp/pip-EqfPlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:09 INFO - Running setup.py (path:/tmp/pip-kuuIFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:09 INFO - Running setup.py (path:/tmp/pip-wKosjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:09 INFO - Running setup.py (path:/tmp/pip-3plFpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:09 INFO - Running setup.py (path:/tmp/pip-H7zFVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:09 INFO - Running setup.py (path:/tmp/pip-Br_5tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:09 INFO - Running setup.py (path:/tmp/pip-qwqcHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:09 INFO - Running setup.py (path:/tmp/pip-zKhmed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:02:09 INFO - Running setup.py install for manifestparser 11:02:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:02:09 INFO - Running setup.py install for mozcrash 11:02:10 INFO - Running setup.py install for mozdebug 11:02:10 INFO - Running setup.py install for mozdevice 11:02:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Running setup.py install for mozfile 11:02:10 INFO - Running setup.py install for mozhttpd 11:02:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Running setup.py install for mozinfo 11:02:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Running setup.py install for mozInstall 11:02:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Running setup.py install for mozleak 11:02:10 INFO - Running setup.py install for mozlog 11:02:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:02:10 INFO - Running setup.py install for moznetwork 11:02:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:02:11 INFO - Running setup.py install for mozprocess 11:02:11 INFO - Running setup.py install for mozprofile 11:02:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:02:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:02:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:02:11 INFO - Running setup.py install for mozrunner 11:02:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:02:11 INFO - Running setup.py install for mozscreenshot 11:02:11 INFO - Running setup.py install for moztest 11:02:11 INFO - Running setup.py install for mozversion 11:02:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:02:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:02:11 INFO - Cleaning up... 11:02:11 INFO - Return code: 0 11:02:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:11 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')]} 11:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:11 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')]} 11:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:11 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 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:02:11 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 11:02:11 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 11:02:11 INFO - Using env: {'DISPLAY': ':0', 11:02:11 INFO - 'HOME': '/home/cltbld', 11:02:11 INFO - 'LANG': 'en_US.UTF-8', 11:02:11 INFO - 'LANGUAGE': 'en_US:en', 11:02:11 INFO - 'LOGNAME': 'cltbld', 11:02:11 INFO - 'MAIL': '/var/mail/cltbld', 11:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:11 INFO - 'MOZ_NO_REMOTE': '1', 11:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:11 INFO - 'NO_EM_RESTART': '1', 11:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:11 INFO - 'PWD': '/builds/slave/test', 11:02:11 INFO - 'SHELL': '/bin/bash', 11:02:11 INFO - 'SHLVL': '1', 11:02:11 INFO - 'TERM': 'linux', 11:02:11 INFO - 'TMOUT': '86400', 11:02:11 INFO - 'USER': 'cltbld', 11:02:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:11 INFO - '_': '/tools/buildbot/bin/python'} 11:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:11 INFO - Running setup.py (path:/tmp/pip-RaTrq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:11 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)) 11:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:11 INFO - Running setup.py (path:/tmp/pip-SES0vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:12 INFO - Running setup.py (path:/tmp/pip-MNj2ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:12 INFO - Running setup.py (path:/tmp/pip-mk9TJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:12 INFO - Running setup.py (path:/tmp/pip-QAFiVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:12 INFO - Running setup.py (path:/tmp/pip-dO6Rvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:12 INFO - Running setup.py (path:/tmp/pip-MIhG5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:12 INFO - Running setup.py (path:/tmp/pip-Ej7cAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:12 INFO - Running setup.py (path:/tmp/pip-bP8XLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:12 INFO - Running setup.py (path:/tmp/pip-uhWuaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:12 INFO - Running setup.py (path:/tmp/pip-O18h0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:12 INFO - Running setup.py (path:/tmp/pip-I7Ozik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:12 INFO - Running setup.py (path:/tmp/pip-ZiLSS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:12 INFO - Running setup.py (path:/tmp/pip-v1Iym6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:12 INFO - Running setup.py (path:/tmp/pip-cxTygP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:12 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)) 11:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:12 INFO - Running setup.py (path:/tmp/pip-CniYyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:13 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)) 11:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:13 INFO - Running setup.py (path:/tmp/pip-zSYCKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:13 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)) 11:02:13 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)) 11:02:13 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)) 11:02:13 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)) 11:02:13 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)) 11:02:13 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)) 11:02:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:14 INFO - Downloading blessings-1.6.tar.gz 11:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:02:15 INFO - Installing collected packages: blessings 11:02:15 INFO - Running setup.py install for blessings 11:02:15 INFO - Successfully installed blessings 11:02:15 INFO - Cleaning up... 11:02:15 INFO - Return code: 0 11:02:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:02:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:15 INFO - Reading from file tmpfile_stdout 11:02:15 INFO - Current package versions: 11:02:15 INFO - argparse == 1.2.1 11:02:15 INFO - blessings == 1.6 11:02:15 INFO - blobuploader == 1.2.4 11:02:15 INFO - docopt == 0.6.1 11:02:15 INFO - functools32 == 3.2.3-2 11:02:15 INFO - jsonschema == 2.5.1 11:02:15 INFO - manifestparser == 1.1 11:02:15 INFO - mozInstall == 1.12 11:02:15 INFO - mozcrash == 0.17 11:02:15 INFO - mozdebug == 0.1 11:02:15 INFO - mozdevice == 0.48 11:02:15 INFO - mozfile == 1.2 11:02:15 INFO - mozhttpd == 0.7 11:02:15 INFO - mozinfo == 0.9 11:02:15 INFO - mozleak == 0.1 11:02:15 INFO - mozlog == 3.3 11:02:15 INFO - moznetwork == 0.27 11:02:15 INFO - mozprocess == 0.23 11:02:15 INFO - mozprofile == 0.28 11:02:15 INFO - mozrunner == 6.12 11:02:15 INFO - mozscreenshot == 0.1 11:02:15 INFO - mozsystemmonitor == 0.3 11:02:15 INFO - moztest == 0.7 11:02:15 INFO - mozversion == 1.4 11:02:15 INFO - psutil == 3.1.1 11:02:15 INFO - requests == 1.2.3 11:02:15 INFO - wsgiref == 0.1.2 11:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:15 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 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:02:15 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 11:02:15 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 11:02:15 INFO - Using env: {'DISPLAY': ':0', 11:02:15 INFO - 'HOME': '/home/cltbld', 11:02:15 INFO - 'LANG': 'en_US.UTF-8', 11:02:15 INFO - 'LANGUAGE': 'en_US:en', 11:02:15 INFO - 'LOGNAME': 'cltbld', 11:02:15 INFO - 'MAIL': '/var/mail/cltbld', 11:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:15 INFO - 'MOZ_NO_REMOTE': '1', 11:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:15 INFO - 'NO_EM_RESTART': '1', 11:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:15 INFO - 'PWD': '/builds/slave/test', 11:02:15 INFO - 'SHELL': '/bin/bash', 11:02:15 INFO - 'SHLVL': '1', 11:02:15 INFO - 'TERM': 'linux', 11:02:15 INFO - 'TMOUT': '86400', 11:02:15 INFO - 'USER': 'cltbld', 11:02:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:15 INFO - '_': '/tools/buildbot/bin/python'} 11:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 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)) 11:02:15 INFO - Cleaning up... 11:02:15 INFO - Return code: 0 11:02:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a37bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, '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': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', '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 11:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:02:15 INFO - Using env: {'DISPLAY': ':0', 11:02:15 INFO - 'HOME': '/home/cltbld', 11:02:15 INFO - 'LANG': 'en_US.UTF-8', 11:02:15 INFO - 'LANGUAGE': 'en_US:en', 11:02:15 INFO - 'LOGNAME': 'cltbld', 11:02:15 INFO - 'MAIL': '/var/mail/cltbld', 11:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:15 INFO - 'MOZ_NO_REMOTE': '1', 11:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:15 INFO - 'NO_EM_RESTART': '1', 11:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:15 INFO - 'PWD': '/builds/slave/test', 11:02:15 INFO - 'SHELL': '/bin/bash', 11:02:15 INFO - 'SHLVL': '1', 11:02:15 INFO - 'TERM': 'linux', 11:02:15 INFO - 'TMOUT': '86400', 11:02:15 INFO - 'USER': 'cltbld', 11:02:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:15 INFO - '_': '/tools/buildbot/bin/python'} 11:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:02:15 INFO - Cleaning up... 11:02:15 INFO - Return code: 0 11:02:15 INFO - Running post-action listener: _resource_record_post_action 11:02:15 INFO - Running post-action listener: _start_resource_monitoring 11:02:15 INFO - Starting resource monitoring. 11:02:15 INFO - [mozharness: 2016-08-19 18:02:15.939406Z] Finished create-virtualenv step (success) 11:02:15 INFO - [mozharness: 2016-08-19 18:02:15.939870Z] Running install step. 11:02:15 INFO - Running pre-action listener: _resource_record_pre_action 11:02:15 INFO - Running main action method: install 11:02:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:16 INFO - Reading from file tmpfile_stdout 11:02:16 INFO - Detecting whether we're running mozinstall >=1.0... 11:02:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:02:16 INFO - Reading from file tmpfile_stdout 11:02:16 INFO - Output received: 11:02:16 INFO - Usage: mozinstall [options] installer 11:02:16 INFO - Options: 11:02:16 INFO - -h, --help show this help message and exit 11:02:16 INFO - -d DEST, --destination=DEST 11:02:16 INFO - Directory to install application into. [default: 11:02:16 INFO - "/builds/slave/test"] 11:02:16 INFO - --app=APP Application being installed. [default: firefox] 11:02:16 INFO - mkdir: /builds/slave/test/build/application 11:02:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:02:33 INFO - Reading from file tmpfile_stdout 11:02:33 INFO - Output received: 11:02:33 INFO - /builds/slave/test/build/application/firefox/firefox 11:02:33 INFO - Running post-action listener: _resource_record_post_action 11:02:33 INFO - [mozharness: 2016-08-19 18:02:33.190849Z] Finished install step (success) 11:02:33 INFO - [mozharness: 2016-08-19 18:02:33.191098Z] Running run-tests step. 11:02:33 INFO - Running pre-action listener: _resource_record_pre_action 11:02:33 INFO - Running main action method: run_tests 11:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:02:33 INFO - Python 2.7.3 11:02:33 INFO - Return code: 0 11:02:33 INFO - grabbing minidump binary from tooltool 11:02:33 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')]} 11:02:33 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 0x1a98370>, '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 0x1a9b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:02:33 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 11:02:33 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 11:02:33 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 11:02:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:33 INFO - Return code: 0 11:02:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:02:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:02:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:02:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:02:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:02:33 INFO - Using env: {'DISPLAY': ':0', 11:02:33 INFO - 'HOME': '/home/cltbld', 11:02:33 INFO - 'LANG': 'en_US.UTF-8', 11:02:33 INFO - 'LANGUAGE': 'en_US:en', 11:02:33 INFO - 'LOGNAME': 'cltbld', 11:02:33 INFO - 'MAIL': '/var/mail/cltbld', 11:02:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:02:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:33 INFO - 'MOZ_NO_REMOTE': '1', 11:02:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:33 INFO - 'NO_EM_RESTART': '1', 11:02:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:33 INFO - 'PWD': '/builds/slave/test', 11:02:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:02:33 INFO - 'SHELL': '/bin/bash', 11:02:33 INFO - 'SHLVL': '1', 11:02:33 INFO - 'TERM': 'linux', 11:02:33 INFO - 'TMOUT': '86400', 11:02:33 INFO - 'USER': 'cltbld', 11:02:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407', 11:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:33 INFO - '_': '/tools/buildbot/bin/python'} 11:02:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:02:33 INFO - mozversion application_buildid: 20160819080504 11:02:33 INFO - mozversion application_changeset: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c 11:02:33 INFO - mozversion application_display_name: Nightly 11:02:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:33 INFO - mozversion application_name: Firefox 11:02:33 INFO - mozversion application_remotingname: firefox 11:02:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:02:33 INFO - mozversion application_vendor: Mozilla 11:02:33 INFO - mozversion application_version: 51.0a1 11:02:33 INFO - mozversion platform_buildid: 20160819080504 11:02:33 INFO - mozversion platform_changeset: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c 11:02:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:02:33 INFO - mozversion platform_version: 51.0a1 11:02:33 INFO - using testdate: 1471629753 11:02:33 INFO - actual date: 1471629753 11:02:33 INFO - starting webserver on 'localhost:55538' 11:02:33 INFO - SUITE-START | Running 2 tests 11:02:33 INFO - TEST-START | dromaeo_css 11:02:33 INFO - operating with platform_type : linux_ 11:02:33 INFO - Initialising browser for dromaeo_css test... 11:02:33 INFO - TEST-INFO | started process 24053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa3fefh/profile http://localhost:55538/getInfo.html) 11:02:37 INFO - PROCESS | 24053 | __metrics Screen width/height:1600/1200 11:02:37 INFO - PROCESS | 24053 | colorDepth:24 11:02:37 INFO - PROCESS | 24053 | Browser inner width/height: 1024/697 11:02:37 INFO - PROCESS | 24053 | __metrics 11:02:37 INFO - PROCESS | 24053 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:02:37 INFO - PROCESS | 24053 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:02:38 INFO - PROCESS | 24053 | console.error: PushService: 11:02:38 INFO - PROCESS | 24053 | stateChangeProcessEnqueue: Error transitioning state 11:02:38 INFO - PROCESS | 24053 | UnknownError 11:02:39 INFO - TEST-INFO | 24053: exit 0 11:02:39 INFO - Browser initialized. 11:02:39 INFO - Running cycle 1/1 for dromaeo_css test... 11:02:39 INFO - TEST-INFO | started process 24139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa3fefh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:50 INFO - PROCESS | 24139 | RSS: Main: 156209152 11:02:50 INFO - PROCESS | 24139 | 11:03:42 INFO - PROCESS | 24139 | 1471629822390 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] 11:05:51 INFO - PROCESS | 24139 | Cycle 1(1): loaded http://localhost:55538/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55538/tests/dromaeo/cssquery-ext.html) 11:05:52 INFO - PROCESS | 24139 | RSS: Main: 258347008 11:05:52 INFO - PROCESS | 24139 | 11:08:55 INFO - PROCESS | 24139 | Cycle 1(1): loaded http://localhost:55538/tests/dromaeo/cssquery-ext.html (next: http://localhost:55538/tests/dromaeo/cssquery-jquery.html) 11:08:55 INFO - PROCESS | 24139 | RSS: Main: 253820928 11:08:55 INFO - PROCESS | 24139 | 11:11:57 INFO - PROCESS | 24139 | Cycle 1(1): loaded http://localhost:55538/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55538/tests/dromaeo/cssquery-mootools.html) 11:11:58 INFO - PROCESS | 24139 | RSS: Main: 190873600 11:11:58 INFO - PROCESS | 24139 | 11:15:00 INFO - PROCESS | 24139 | Cycle 1(1): loaded http://localhost:55538/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55538/tests/dromaeo/cssquery-prototype.html) 11:15:00 INFO - PROCESS | 24139 | RSS: Main: 190648320 11:15:00 INFO - PROCESS | 24139 | 11:18:03 INFO - PROCESS | 24139 | Cycle 1(1): loaded http://localhost:55538/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55538/tests/dromaeo/cssquery-yui.html) 11:18:04 INFO - PROCESS | 24139 | RSS: Main: 193003520 11:18:04 INFO - PROCESS | 24139 | 11:21:06 INFO - PROCESS | 24139 | Cycle 1(1): loaded http://localhost:55538/tests/dromaeo/cssquery-yui.html (next: http://localhost:55538/tests/dromaeo/cssquery-dojo.html) 11:21:07 INFO - PROCESS | 24139 | RSS: Main: 286679040 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - PROCESS | 24139 | __start_tp_report 11:21:07 INFO - PROCESS | 24139 | _x_x_mozilla_page_load 11:21:07 INFO - PROCESS | 24139 | _x_x_mozilla_page_load_details 11:21:07 INFO - PROCESS | 24139 | |i|pagename|runs| 11:21:07 INFO - PROCESS | 24139 | |0;dojo.html;3020.9848950755245;3050.5424186372047;3057.740092092172;3064.6475655299632;3077.707617776312;5159.793608255665;5278.815241466549;5302.496262855027;5382.327209098863;5425.538829199518;5296.708681022552;5317.308749862513;5344.118220493614;5423.810166644168;5439.646422982503;4820.927686084711;4871.098846713369;4879.853604391874;4919.016196760645;4923.409190897098;4917.655764096515;4937.901241975158;4952.207646776516;4965.230389289666;4980.626453016038;4793.161196790583;4795.6163506919365;4926.9014619707405;4939.407271127488;4972.87567810804;4782.067496838118;4829.3721816164025;4887.902241955141;4889.3888263967;4908.656394052417;4855.490173531799;4901.705897646153;4914.262860570907;4920.212765957465;4923.950760492385;5152.3044389007755;5193.454687257821;5235.947640523584;5409.540189083933;5441.537469315113;5615.410381909882;5663.263775709132;5673.149027645845;5674.205611214392;5679.886402271973;5721.256236689245;5722;5723.227364305807;5728.541716662657;5734.455226753494;5156.484351564851;5220.738963051832;5245.344331958505;5250.343707036621;5319.095753721838;5829.76680932758;5836.88326233473;5845.766169353264;5846.4153584642045;5846.853828654318;5608.6073974821375;5614.101743720985;5614.550835933115;5617.550595952396;5620.747066382022;5537.086380747131;5578.30271216098;5629.324481062217;5630.71846407678;5691.487766100988;5706.828795136153;5707.800226992118;5710.029295019856;5711.971440142773;5718.7426565804635;5659.037963546125;5703.657780533182;5705.885882282331;5712.742926568314;5721.5708821838525;4059.5331536873637;4151.12826306473;4165.271077561415;4171.416001759756;4207.789610519523;3766.246750649881;3769.26499332633;3780.4518344839844;3782.829772660237;3800.8669696560487;5323.387810401853;5325.09473389517;5329.680219186861;5332.760025798849;5393.892122157535;5556.472135147154;5593.049181639131;5628.437156284339;5631.436856314418;5726.685032323262;5342.0384330820825;5345.893082138413;5359.919601205985;5362.51737343641;5377.623566350396;4891.902161956741;4894.720537239987;4900.362952816111;4911.238757992517;4911.533404326583;5752;5844.795432159854;5860.413958604106;5877.500412464903;5891.764329426775;5722.341930677859;5722.771089156554;5730.541556675539;5732.34078081026;5759.424057594207;5951.226340575698;5959;5959.970200149145;5967.373425790403;5973.641581505123;5373.328333958255;5479;5498.642588231752;5508.476694713996;5645.858853528694;5665.3201615806365;5704.258446401941;5705.572082093777;5706.258186435737;5721;5574.693391863487;5578.497935185853;5579.358373786904;5585.301837270341;5591.552675785846;5421.512063914267;5543.5010849022165;5560.66636001825;5592.832215033555;5612.242347283064;5674.546036317167;5675.31896172462;5678.517326027334;5685.488306052475;5685.857853553694;5701.857453563694;5711.8857622848145;5717.22817419643;5721.57088218377;5732.5413966881715;5312.601554883322;5420.647657902224;5465.918011229915;5469.781208751605;5598.10430331145 11:21:07 INFO - PROCESS | 24139 | |1;ext.html;556.2879514221796;571.8598943258902;582.4524946550242;582.6795262605567;584.4681339980618;42914.57085429145;44139.55860441395;44377;48408.51591484084;48497.27254091183;45022.549774502244;45473.77263113688;45524.544754552444;45562.544374556244;45615.771921140346;8118.918810811875;9021.548922553879;9098.727038188832;9177.449353038806;10719.088877445387;10664.573417063308;11176.664700058971;11193;11193.27243729155;11197.104231661488;11186.664400068012;11245.718857028598;11251.381174035425;11251.493682784254;11259.718507037307;11136.053435457996;11160.05139563134;11200.495977681025;11210.047145992601;11215.214934954556;10901.890981090168;10953.397563134024;10970.122390208764;10977.341359518374;10985.780284394268;43532.782336088436;43924;43959;43969.78015109936;44015.11969760587;3371.190914180579;3492.4935884296888;3497.7901325920525;3879.2047630236016;4250.064985703171;32458.675413246037;33527;33951.4907276391;34101.82949085239;34121.658783412095;4411.691181617288;4477.9104417911785;4497.5952164305045;4537.931931021038;4591.563801438858;341143;341460;341585;345379;345842;59756.414615123234;60229;60323;60361.69819150964;60424.697876510334;64233.67883160648;64253.357466424735;64369.67815160988;64375.35624643787;64464;14101;14310.356033978496;14324.785128223086;14399.856001440061;14409.855901440851;9762.853557196648;9972.80054398908;10270.07569318765;10623.893761062445;10637.255392122477;17954.19206135727;18232.179551920195;18406.81593184051;18454.26182952667;18509.5372615683;5929;6022.5784195105925;6114.327423983358;6117.84705382369;6127.295361033449;929.4934260827865;1051.6056478820442;1062.3519653011656;1067.9679609611724;1102.3606308341143;32562.837185813918;33129.83435082809;33308.833455832566;33312.1671958203;33611.66388336085;1094.5293523784849;1120.6469961961957;1145.1010956399186;1162.3258510064143;1201.6995751062234;16489.91755041217;17394.913025435046;17598.180183670458;17671.823281767018;17869.642607147784;530129;751698;759815;761109;764026;60084;60744.696276518334;60779;60843.69578152081;60917.39082609206;1221.7434338788776;1279.8976081913238;1332.4803326702595;1340.993295033538;1369.9315034248248;29739.256518586342;33916;34210.65789342174;34317.22510523791;34698.826505867306;39444.60555394409;39886.800565996986;39895.60104398919;39906.80046599748;39932;377997;381968;382367;382837;383316;26358.20925372242;28448.715512844607;28963.275918102216;29415.26461838471;29433.411331773674;45676.771616141705;46239.537604623525;47434.28848567343;51543.226851598;51705.224421634455;40062.79968600255;41249.587504124574;41351.58648413477;41420.58579414288;43556.56443435525;41209.38185927273;41359.37960930649;41651.583484164774;42556.36165457459;42825.357619635106;40458.79770601128;41917.58082419137;42234.78882605567;42420;42436.78781606072;30178;32962.67037329596;32995.67004329926;33358.83320583479;33622.83188584042;27881.302967425978;28145.87416503317;28199.295017624725;28218.153455396372;28408.43183136367 11:21:07 INFO - PROCESS | 24139 | |2;jquery.html;400.19560683027123;404.4337926902335;409.6108696738099;412.54825965567704;425.2175996167054;13197.934010329935;18472.076396180186;19460.41618751436;20214;20289.59420811583;15247.923760381183;18068.819311806878;18780.71828922564;18864;19033.90483047583;5783.132530120473;5977.193078934353;5980.790672326448;5982.940170598282;5984.88030239395;5740.138979153139;5871.588988770788;5882.382349853268;5964.612300200473;5965.985782416978;5889.322727886283;5920.970395148018;5922.822315330525;5931.406859314077;5933.376995415484;5684.715764211773;5830.621009634403;5879.970600147015;5897.4102589741115;5922.318933322658;5266.526012658879;5267.920981185285;5270.130428479296;5272.525472707436;5274.657147285414;23092.76907230923;23495.76504234953;23670;23896.163634272893;24083;2479.85120892747;2495.563276426618;2589.4562141950214;3118.937621247562;3186.060112266887;9374.156325930699;9634.084761947604;9766.560504777302;9906.306558540906;14586.416543338253;1830.8838852447645;1907.6280125375558;1932.5265309999;1952.511872031992;1994.9202031918705;83189.58405207936;85149.14850851474;85272;86462;86642;10978.890211097947;11085;11223.158263130297;11259.605913793142;11329.2069555132;15726.528204153665;15744.606384840241;15745.291461884242;15773.447929322649;15779.842201578067;6912.758053468105;7493.138289096823;7544;7713.498622589514;7724.6137693115115;6947.444204463732;6973.302669732986;7117.501774875709;7120.0387947626405;7122.145342558926;4415.139047885696;4604.148232576984;4703.717776933327;4869.074875773663;4937.604991600663;1994.411648563677;2010.8190262876412;2038.8063134002246;2048.3035767839006;2052.9076191571417;844.2992316377392;953.4946478366477;968.3463662028103;988.6144403682425;1021.6526381030337;18472.907635461735;19399.127039283267;19500.70748938767;19663.901680491505;19772.505687357643;975.6146322202691;981.8183636027358;986.4673076538588;1000.3647683720744;1018.6231094495084;10310;10746.677599672023;10962.945185274182;10991.670249892515;11003.944980275048;460670;463277;475958;477145;478593;89092;89181.55409223042;90723.54638226767;90736.54631726931;92226;930.0420566816055;939.990600094004;975.1954637424153;981.3572110267786;981.7251169672503;16436;16979.575510612332;17466.30134794645;17501.737473937646;17751.911240443715;44765.552344476135;45010.54989450063;45539.31691024571;46365.304520432896;48007;59378;61949.951704292;62091;62278;65792;12228.510859565518;12586.937065314614;12784.48862045545;12860.678483037998;13185.34073296312;13936.651583710489;13959.953003524573;14336;14396.352164152848;14625.561233163022;12227.572034978733;12524.499020039097;12566.120371573903;12650.810237846625;13009.21944683322;11719.531218751154;12513.562025329069;12727.93636031814;12992.740145197233;13212.471501139848;12478.251304921734;12627.368631568568;12658.240505569695;12853.16454430459;12937.223766574036;12467.875321247035;12668.429920653776;12712.682182945131;12764.234145951272;12790;11117.888821112008;11844.348560829238;12033.157678962389;12483.31341776211;12888.324517812624 11:21:07 INFO - PROCESS | 24139 | |3;mootools.html;1364.5428781358244;1476.453712126513;1531.624751935776;1617.4743208457255;1757.340997126077;8670.219680228778;9120.543972801359;9151.77120571986;9437.622495100188;9439.38643988142;9238.67664631738;9336.766580835483;9336.906630933689;9359.298052646061;9369.063093690627;2099.454141923103;2413.9155129570468;2420.8547487150827;2441.389652586853;2442.206282958037;2187.3219302016346;2206.878621675807;2208.4258092895884;2341.6838726771925;2470.481198948223;2376.0852071952336;2421.6004359280696;2421.806255499556;2423.442608200115;2424.078850036992;2363.5036642305136;2430.4652976345265;2444.8533088014597;2449.0938352809576;2453.7055553333626;2278.111536500766;2286.222684287334;2300.4363930836885;2364.4207169243646;2365.550545396369;9220.21628161607;9289.860652090225;9290;9300.069993000645;9303.116203960613;5046;5192.506711862367;5195.662281951699;5197.194434862565;5199.896002079937;3377.206356506219;3528.770629909048;3567.3066834539754;3619.457081437779;3644.599094099647;1117.1677100560053;1158.9188756787028;1161.872194058653;1167.3871217610738;1198.3708553009653;12979.870201297961;13301;13312.400941957636;13392;13400.5309814157;4651.767411629405;4713;4788.329633851264;4796.736179510091;4928.7289199093675;11164.665060048212;11166.776664466664;11187.384693841754;11194.440277986068;11197.216194866282;5336.42575440246;5339.759710813023;5348.171033489815;5357.0357335679955;5362.249285100089;4809.759512024385;4815.2054910940005;4873.244647079709;4908.141075311806;4908.950910490921;3845.692344612424;4045.1707399982934;4075.3886916962692;4193.958060419418;4194.979025104855;1322.0679421008167;1342.90599658023;1344.6638340414897;1360.9183448993092;1375.126794485509;955.4171955107379;1001.2790790630734;1006.9798604028025;1012.099231683802;1022.0699163761091;6217.751289948352;6243.656598887014;6266.122742816009;6424.783449709843;6480.740770369227;994.990085063661;1003.2024540490328;1020.8621836052038;1029.629333439961;1032.9825122254574;4244.745315281093;4405.317175837687;4416.425864637641;4448.933266001012;4496.1906856765445;11072.446377681084;11508.424578771028;11555.36445495489;11560.595379161858;11578.36319002463;10484.947575262075;10831.729206769736;11023.779524409627;11508.769824603462;11520.366379849022;8244.587770611446;8348.457350272334;8491.575421228914;8500.234978851933;8501.234888859908;6245.687715614292;6372.713227904848;6384.042393640805;6424.2933277338525;6440.774572889926;10385.117265032557;10697.197710171613;10723.463826808473;10728.302660327054;10741.194410419406;10430.530626121994;10664.146868250677;10679.5194216262;10894.400807955639;10941.179411544324;8080.878786818085;8188.976377952756;8284.420090593841;8284.50292982423;8299.08710041907;8825.38222324431;8876;8946.418482798597;8946.821063578562;8951.686690965786;7868.370530357673;8051.798705032421;8120.228578285053;8129.187081291823;8226.218509241851;7736.7678969631;7942.6028698566;8008.919910800817;8040.195980401913;8063.435559510778;7090.716371345088;7182.17404998411;7189.748358807626;7192.820179495555;7196.244394338519;5353.946460535501;5449.509544141047;5502.257195278587;5646.774129034792;5692.658440493584;5443.59173062014;5543.833684989457;5567.610267281251;5647.29408823897;5693.089105743061 11:21:07 INFO - PROCESS | 24139 | |4;prototype.html;323.94169049571076;324.4241471388286;333.55637002786295;335.08354650032175;335.89587227959316;5283.313169287987;5285.312909321783;5286.788528458862;5288.8413347599635;5293.444188360225;5166.819161329354;5207.921881171786;5222.9477705222935;5227.424983251849;5228.738563071841;3863.5750067492622;3929.960700392988;3975.642192202701;4012.1173341864887;4025.5773143819915;3651.9269614607692;4050.989520374837;4073.87778366648;4075.3886916962397;4088.693347998897;4024.4969378827645;4028.858989935353;4034.4150098235737;4056.3509838425857;4083.8570650027254;3888.4361767543833;3989.501312335958;4067.938980915274;4073.165001174752;4080.510338759353;3609.8736544221088;3614.765040272374;3623.691986181178;3639.308531379056;3650.689691376236;4979.253112033188;4985.376827896513;4990.6257030722845;5050.888804463012;5093.414257360414;4341.500727416356;4650.558326918666;4653.115907977473;4672.322513235596;4674.485806561275;5366.490183432567;5375.704336261504;5379.677219366811;5388.43421440747;5408.242846001563;3813.1229817141934;3819.2934307153264;3837.654611085016;3845;3856.325143099946;5076.365454318173;5385.192221166856;5693.491224825383;5725.799597014085;5730.713464326767;3966.3058964681063;3969.1069509360163;3972.205558888234;3979.2837289288204;4018.457508236351;4056.7829651104553;4059.4722686050623;4061.573534778806;4061.7156799024374;4069.4302797608357;4615.95384046162;4629.328747331618;4641.837535686234;4648.465426475998;4664.86005419838;5187;5423.322084739408;5428.4842939920645;5459.12653975362;5515.531179849758;1364.8089267502558;1389.3608939887765;1389.9652508687363;1401.3903951781008;1402.1797248609678;859.9551544873009;901.6032945503957;904.9864252036225;907.8275127725711;909.1045320359441;4657.906841863144;4680.719156850531;4681.180793361148;4684.718916864999;4696.38946936896;4936.605071594264;4946.727929963815;4950.168437678082;4981.701097934136;5010.5240002199735;4378.4745830499905;4621.699589526737;4663.930041049387;4684.5549672781035;4692.1554120258;2600.2849216465247;2604;2618.725033871416;2633.5654616988368;2639.6700412448445;5069.594432445396;5084;5123.846284611468;5129.384473863086;5154.433012368637;4807.927881081787;5016.297718319438;5027.949720502821;5039.5810011194835;5040.344755181803;5060.962502686941;5114.846554603368;5122.769475373691;5126.333576635088;5138.203578445347;4912.5753531475475;4925.408950925912;4960.107180707508;4962.925556116589;4972.383975207999;4921.311016457627;4939.876503087307;4973.776180071833;5204.323437953042;5590.5527557796095;5862.413758624103;5863.706814659336;5866.2373891393845;5869.325027621708;5870.14882841994;4100.446439730598;4128.153728485593;4131.111810960658;4155.148194620036;4158.8336466540995;5330.253764473055;5581.609287349846;5585.832425027255;5667.40492248308;5740.540756739534;5447.918281225864;5522.5858060646415;5525.4474552544425;5531.751071201725;5537.667739935617;5475.561955043667;5476.534494568006;5485.6982865942755;5489.8745757118895;5490.231367608458;5248.580113590827;5439.184122381516;5473.261109750292;5488.588355873405;5489.780408783764;5443.169551832945;5522.392536821027;5525.392206857323;5525.475079867406;5534.308211473566;5213.60897932649;5422.159565267232;5426.321709786277;5426.511613954763;5445.50990410865 11:21:07 INFO - PROCESS | 24139 | |5;yui.html;740.5112625667058;743.8623854586901;773.814284571703;796.2674339607561;867.2758246863868;15241.847581524182;15890.126043067627;15897.761533576977;15899.920500397511;15974.520764377074;14903.478378256763;15409.614759631015;15438.459653912116;15581.376744930218;15623.140727259995;804.6901942752024;825.558326295432;827.0860698927688;827.210014436212;828.4863384701493;617.2993652204757;634.5716641267127;637.6684124255385;639.7409049335004;670.1321788284159;852.4757274276307;853;853.8463076646201;854.5300084953282;854.7521218846528;849.3375167369462;849.9362547808939;849.9915000850036;850.0352100366098;850.3664769746548;509.6941834899031;608.8143116349512;624.8375422390166;628.2931701835436;629.3203340392365;14817.70364592702;14892.851071489255;14951.252437378087;14968.550943471713;14986.850131498764;14292.356843942047;14672.339744711513;15051.623709407353;15125.16811575363;15368.30842612074;13331.600051998359;13425.597232083053;13503.59489215325;13522;13900.16599004063;4430;4493.113456859825;4527.592516673482;4553.385292985437;4660.324252983332;80370;80488.59755701243;81225;81310.46240144818;81773;11557.88442115585;11612.30326180415;11767.584953153411;11789.644190917983;11828.881711182778;23104.884475577852;23140.884295578413;23146.65280020801;23147.88426057859;23155.189568365025;8566.143385661384;8661.696840610675;8732.432391894634;8745.490341085202;8832.690855820016;4696.225122854759;4764.571188593043;4862.82980095702;4893.681910675866;4919.3358896549225;3559.14580500678;3700.4264339027495;3721.330160571069;3722.088088418355;3740.925181496409;627.7394881124374;635.1742734445295;637.8947473666885;640.7308930249307;656.3928366261189;644.6615526848442;659.9448226584341;661.3750006244053;664.7307840324676;679.2697849811473;8774.60514276859;9253.907460925304;9451.810963780687;9638.325317227867;9674.467904265191;637.5632691606172;639.3031595560861;673.8315421144714;686.2211390072304;687.5874475314871;4617.284320930261;4645.976770116128;4665.486796452456;4670.859874203779;4695.107929493453;106876;109538;112975;117572.41213794047;124488;94646;95222.52388738011;99301.50349248208;99679.64796042518;99873.50063249638;53177.46822531803;61027.69486152541;86158.56920715356;86340.56829715811;88628;9299.67451139207;9467.668631598137;9563.234941204826;9875.506224688881;9879.555420006262;50760.23859642034;52233.47766522286;53054.73472632612;53364.73317633542;55433.44566554283;71006;73702;74277.62861185876;75560;77499.2250077492;13252.337383130613;13733.313334333043;13849.16904985704;13903.930480347533;14132.293385330488;15384.769228461359;15468.690626187637;15490.148041857807;15512.612184695021;16169.191540423168;13817;13845.584632461043;14097.224652644203;14099.365528551034;14406.567802965928;13300.041119847076;13660.521881734092;13728.65678358049;13784.586462406143;13927.512537061155;13703.794443083163;14240.430382784987;14241.828275535778;14311.141331520143;14718.77921831152;11282.887171128184;11318.151138664798;11434.485448154686;11445.542178312775;11457;10375.018676228776;10573.62992295266;10605.969851252747;11386.94306528462;11948.820767688665 11:21:07 INFO - PROCESS | 24139 | __end_tp_report 11:21:07 INFO - PROCESS | 24139 | __start_cc_report 11:21:07 INFO - PROCESS | 24139 | _x_x_mozilla_cycle_collect,1009 11:21:07 INFO - PROCESS | 24139 | __end_cc_report 11:21:07 INFO - PROCESS | 24139 | __startTimestamp1471630867202__endTimestamp 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - PROCESS | 24139 | ------- Summary: start ------- 11:21:07 INFO - PROCESS | 24139 | Number of tests: 6 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - PROCESS | 24139 | [#0] dojo.html Cycles:165 Average:5287.37 Median:5498.64 stddev:619.25 (11.3%) stddev-sans-first:595.08 11:21:07 INFO - PROCESS | 24139 | Values: 3021.0 3050.5 3057.7 3064.6 3077.7 5159.8 5278.8 5302.5 5382.3 5425.5 5296.7 5317.3 5344.1 5423.8 5439.6 4820.9 4871.1 4879.9 4919.0 4923.4 4917.7 4937.9 4952.2 4965.2 4980.6 4793.2 4795.6 4926.9 4939.4 4972.9 4782.1 4829.4 4887.9 4889.4 4908.7 4855.5 4901.7 4914.3 4920.2 4924.0 5152.3 5193.5 5235.9 5409.5 5441.5 5615.4 5663.3 5673.1 5674.2 5679.9 5721.3 5722.0 5723.2 5728.5 5734.5 5156.5 5220.7 5245.3 5250.3 5319.1 5829.8 5836.9 5845.8 5846.4 5846.9 5608.6 5614.1 5614.6 5617.6 5620.7 5537.1 5578.3 5629.3 5630.7 5691.5 5706.8 5707.8 5710.0 5712.0 5718.7 5659.0 5703.7 5705.9 5712.7 5721.6 4059.5 4151.1 4165.3 4171.4 4207.8 3766.2 3769.3 3780.5 3782.8 3800.9 5323.4 5325.1 5329.7 5332.8 5393.9 5556.5 5593.0 5628.4 5631.4 5726.7 5342.0 5345.9 5359.9 5362.5 5377.6 4891.9 4894.7 4900.4 4911.2 4911.5 5752.0 5844.8 5860.4 5877.5 5891.8 5722.3 5722.8 5730.5 5732.3 5759.4 5951.2 5959.0 5960.0 5967.4 5973.6 5373.3 5479.0 5498.6 5508.5 5645.9 5665.3 5704.3 5705.6 5706.3 5721.0 5574.7 5578.5 5579.4 5585.3 5591.6 5421.5 5543.5 5560.7 5592.8 5612.2 5674.5 5675.3 5678.5 5685.5 5685.9 5701.9 5711.9 5717.2 5721.6 5732.5 5312.6 5420.6 5465.9 5469.8 5598.1 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - PROCESS | 24139 | [#1] ext.html Cycles:180 Average:63718.00 Median:190747.40 stddev:136688.12 (71.7%) stddev-sans-first:136989.30 11:21:07 INFO - PROCESS | 24139 | Values: 556.3 571.9 582.5 582.7 584.5 42914.6 44139.6 44377.0 48408.5 48497.3 45022.5 45473.8 45524.5 45562.5 45615.8 8118.9 9021.5 9098.7 9177.4 10719.1 10664.6 11176.7 11193.0 11193.3 11197.1 11186.7 11245.7 11251.4 11251.5 11259.7 11136.1 11160.1 11200.5 11210.0 11215.2 10901.9 10953.4 10970.1 10977.3 10985.8 43532.8 43924.0 43959.0 43969.8 44015.1 3371.2 3492.5 3497.8 3879.2 4250.1 32458.7 33527.0 33951.5 34101.8 34121.7 4411.7 4477.9 4497.6 4537.9 4591.6 341143.0 341460.0 341585.0 345379.0 345842.0 59756.4 60229.0 60323.0 60361.7 60424.7 64233.7 64253.4 64369.7 64375.4 64464.0 14101.0 14310.4 14324.8 14399.9 14409.9 9762.9 9972.8 10270.1 10623.9 10637.3 17954.2 18232.2 18406.8 18454.3 18509.5 5929.0 6022.6 6114.3 6117.8 6127.3 929.5 1051.6 1062.4 1068.0 1102.4 32562.8 33129.8 33308.8 33312.2 33611.7 1094.5 1120.6 1145.1 1162.3 1201.7 16489.9 17394.9 17598.2 17671.8 17869.6 530129.0 751698.0 759815.0 761109.0 764026.0 60084.0 60744.7 60779.0 60843.7 60917.4 1221.7 1279.9 1332.5 1341.0 1369.9 29739.3 33916.0 34210.7 34317.2 34698.8 39444.6 39886.8 39895.6 39906.8 39932.0 377997.0 381968.0 382367.0 382837.0 383316.0 26358.2 28448.7 28963.3 29415.3 29433.4 45676.8 46239.5 47434.3 51543.2 51705.2 40062.8 41249.6 41351.6 41420.6 43556.6 41209.4 41359.4 41651.6 42556.4 42825.4 40458.8 41917.6 42234.8 42420.0 42436.8 30178.0 32962.7 32995.7 33358.8 33622.8 27881.3 28145.9 28199.3 28218.2 28408.4 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - PROCESS | 24139 | [#2] jquery.html Cycles:180 Average:29107.41 Median:2542.51 stddev:77845.64 (3061.8%) stddev-sans-first:78034.17 11:21:07 INFO - PROCESS | 24139 | Values: 400.2 404.4 409.6 412.5 425.2 13197.9 18472.1 19460.4 20214.0 20289.6 15247.9 18068.8 18780.7 18864.0 19033.9 5783.1 5977.2 5980.8 5982.9 5984.9 5740.1 5871.6 5882.4 5964.6 5966.0 5889.3 5921.0 5922.8 5931.4 5933.4 5684.7 5830.6 5880.0 5897.4 5922.3 5266.5 5267.9 5270.1 5272.5 5274.7 23092.8 23495.8 23670.0 23896.2 24083.0 2479.9 2495.6 2589.5 3118.9 3186.1 9374.2 9634.1 9766.6 9906.3 14586.4 1830.9 1907.6 1932.5 1952.5 1994.9 83189.6 85149.1 85272.0 86462.0 86642.0 10978.9 11085.0 11223.2 11259.6 11329.2 15726.5 15744.6 15745.3 15773.4 15779.8 6912.8 7493.1 7544.0 7713.5 7724.6 6947.4 6973.3 7117.5 7120.0 7122.1 4415.1 4604.1 4703.7 4869.1 4937.6 1994.4 2010.8 2038.8 2048.3 2052.9 844.3 953.5 968.3 988.6 1021.7 18472.9 19399.1 19500.7 19663.9 19772.5 975.6 981.8 986.5 1000.4 1018.6 10310.0 10746.7 10962.9 10991.7 11003.9 460670.0 463277.0 475958.0 477145.0 478593.0 89092.0 89181.6 90723.5 90736.5 92226.0 930.0 940.0 975.2 981.4 981.7 16436.0 16979.6 17466.3 17501.7 17751.9 44765.6 45010.5 45539.3 46365.3 48007.0 59378.0 61950.0 62091.0 62278.0 65792.0 12228.5 12586.9 12784.5 12860.7 13185.3 13936.7 13960.0 14336.0 14396.4 14625.6 12227.6 12524.5 12566.1 12650.8 13009.2 11719.5 12513.6 12727.9 12992.7 13212.5 12478.3 12627.4 12658.2 12853.2 12937.2 12467.9 12668.4 12712.7 12764.2 12790.0 11117.9 11844.3 12033.2 12483.3 12888.3 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - PROCESS | 24139 | [#3] mootools.html Cycles:180 Average:6076.81 Median:4432.68 stddev:3497.84 (78.9%) stddev-sans-first:3489.72 11:21:07 INFO - PROCESS | 24139 | Values: 1364.5 1476.5 1531.6 1617.5 1757.3 8670.2 9120.5 9151.8 9437.6 9439.4 9238.7 9336.8 9336.9 9359.3 9369.1 2099.5 2413.9 2420.9 2441.4 2442.2 2187.3 2206.9 2208.4 2341.7 2470.5 2376.1 2421.6 2421.8 2423.4 2424.1 2363.5 2430.5 2444.9 2449.1 2453.7 2278.1 2286.2 2300.4 2364.4 2365.6 9220.2 9289.9 9290.0 9300.1 9303.1 5046.0 5192.5 5195.7 5197.2 5199.9 3377.2 3528.8 3567.3 3619.5 3644.6 1117.2 1158.9 1161.9 1167.4 1198.4 12979.9 13301.0 13312.4 13392.0 13400.5 4651.8 4713.0 4788.3 4796.7 4928.7 11164.7 11166.8 11187.4 11194.4 11197.2 5336.4 5339.8 5348.2 5357.0 5362.2 4809.8 4815.2 4873.2 4908.1 4909.0 3845.7 4045.2 4075.4 4194.0 4195.0 1322.1 1342.9 1344.7 1360.9 1375.1 955.4 1001.3 1007.0 1012.1 1022.1 6217.8 6243.7 6266.1 6424.8 6480.7 995.0 1003.2 1020.9 1029.6 1033.0 4244.7 4405.3 4416.4 4448.9 4496.2 11072.4 11508.4 11555.4 11560.6 11578.4 10484.9 10831.7 11023.8 11508.8 11520.4 8244.6 8348.5 8491.6 8500.2 8501.2 6245.7 6372.7 6384.0 6424.3 6440.8 10385.1 10697.2 10723.5 10728.3 10741.2 10430.5 10664.1 10679.5 10894.4 10941.2 8080.9 8189.0 8284.4 8284.5 8299.1 8825.4 8876.0 8946.4 8946.8 8951.7 7868.4 8051.8 8120.2 8129.2 8226.2 7736.8 7942.6 8008.9 8040.2 8063.4 7090.7 7182.2 7189.7 7192.8 7196.2 5353.9 5449.5 5502.3 5646.8 5692.7 5443.6 5543.8 5567.6 5647.3 5693.1 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - PROCESS | 24139 | [#4] prototype.html Cycles:180 Average:4451.74 Median:4973.08 stddev:1296.23 (26.1%) stddev-sans-first:1262.29 11:21:07 INFO - PROCESS | 24139 | Values: 323.9 324.4 333.6 335.1 335.9 5283.3 5285.3 5286.8 5288.8 5293.4 5166.8 5207.9 5222.9 5227.4 5228.7 3863.6 3930.0 3975.6 4012.1 4025.6 3651.9 4051.0 4073.9 4075.4 4088.7 4024.5 4028.9 4034.4 4056.4 4083.9 3888.4 3989.5 4067.9 4073.2 4080.5 3609.9 3614.8 3623.7 3639.3 3650.7 4979.3 4985.4 4990.6 5050.9 5093.4 4341.5 4650.6 4653.1 4672.3 4674.5 5366.5 5375.7 5379.7 5388.4 5408.2 3813.1 3819.3 3837.7 3845.0 3856.3 5076.4 5385.2 5693.5 5725.8 5730.7 3966.3 3969.1 3972.2 3979.3 4018.5 4056.8 4059.5 4061.6 4061.7 4069.4 4616.0 4629.3 4641.8 4648.5 4664.9 5187.0 5423.3 5428.5 5459.1 5515.5 1364.8 1389.4 1390.0 1401.4 1402.2 860.0 901.6 905.0 907.8 909.1 4657.9 4680.7 4681.2 4684.7 4696.4 4936.6 4946.7 4950.2 4981.7 5010.5 4378.5 4621.7 4663.9 4684.6 4692.2 2600.3 2604.0 2618.7 2633.6 2639.7 5069.6 5084.0 5123.8 5129.4 5154.4 4807.9 5016.3 5027.9 5039.6 5040.3 5061.0 5114.8 5122.8 5126.3 5138.2 4912.6 4925.4 4960.1 4962.9 4972.4 4921.3 4939.9 4973.8 5204.3 5590.6 5862.4 5863.7 5866.2 5869.3 5870.1 4100.4 4128.2 4131.1 4155.1 4158.8 5330.3 5581.6 5585.8 5667.4 5740.5 5447.9 5522.6 5525.4 5531.8 5537.7 5475.6 5476.5 5485.7 5489.9 5490.2 5248.6 5439.2 5473.3 5488.6 5489.8 5443.2 5522.4 5525.4 5525.5 5534.3 5213.6 5422.2 5426.3 5426.5 5445.5 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - PROCESS | 24139 | [#5] yui.html Cycles:180 Average:20847.98 Median:4730.40 stddev:29514.23 (623.9%) stddev-sans-first:29558.41 11:21:07 INFO - PROCESS | 24139 | Values: 740.5 743.9 773.8 796.3 867.3 15241.8 15890.1 15897.8 15899.9 15974.5 14903.5 15409.6 15438.5 15581.4 15623.1 804.7 825.6 827.1 827.2 828.5 617.3 634.6 637.7 639.7 670.1 852.5 853.0 853.8 854.5 854.8 849.3 849.9 850.0 850.0 850.4 509.7 608.8 624.8 628.3 629.3 14817.7 14892.9 14951.3 14968.6 14986.9 14292.4 14672.3 15051.6 15125.2 15368.3 13331.6 13425.6 13503.6 13522.0 13900.2 4430.0 4493.1 4527.6 4553.4 4660.3 80370.0 80488.6 81225.0 81310.5 81773.0 11557.9 11612.3 11767.6 11789.6 11828.9 23104.9 23140.9 23146.7 23147.9 23155.2 8566.1 8661.7 8732.4 8745.5 8832.7 4696.2 4764.6 4862.8 4893.7 4919.3 3559.1 3700.4 3721.3 3722.1 3740.9 627.7 635.2 637.9 640.7 656.4 644.7 659.9 661.4 664.7 679.3 8774.6 9253.9 9451.8 9638.3 9674.5 637.6 639.3 673.8 686.2 687.6 4617.3 4646.0 4665.5 4670.9 4695.1 106876.0 109538.0 112975.0 117572.4 124488.0 94646.0 95222.5 99301.5 99679.6 99873.5 53177.5 61027.7 86158.6 86340.6 88628.0 9299.7 9467.7 9563.2 9875.5 9879.6 50760.2 52233.5 53054.7 53364.7 55433.4 71006.0 73702.0 74277.6 75560.0 77499.2 13252.3 13733.3 13849.2 13903.9 14132.3 15384.8 15468.7 15490.1 15512.6 16169.2 13817.0 13845.6 14097.2 14099.4 14406.6 13300.0 13660.5 13728.7 13784.6 13927.5 13703.8 14240.4 14241.8 14311.1 14718.8 11282.9 11318.2 11434.5 11445.5 11457.0 10375.0 10573.6 10606.0 11386.9 11948.8 11:21:07 INFO - PROCESS | 24139 | -------- Summary: end -------- 11:21:07 INFO - PROCESS | 24139 | 11:21:07 INFO - TEST-INFO | 24139: exit 0 11:21:07 INFO - TEST-OK | dromaeo_css | took 1114487ms 11:21:07 INFO - TEST-START | kraken 11:21:07 INFO - operating with platform_type : linux_ 11:21:07 INFO - Initialising browser for kraken test... 11:21:07 INFO - TEST-INFO | started process 24448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8r6tjb/profile http://localhost:55538/getInfo.html) 11:21:11 INFO - PROCESS | 24448 | __metrics Screen width/height:1600/1200 11:21:11 INFO - PROCESS | 24448 | colorDepth:24 11:21:11 INFO - PROCESS | 24448 | Browser inner width/height: 1024/697 11:21:11 INFO - PROCESS | 24448 | __metrics 11:21:12 INFO - PROCESS | 24448 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:21:12 INFO - PROCESS | 24448 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:12 INFO - PROCESS | 24448 | console.error: PushService: 11:21:12 INFO - PROCESS | 24448 | stateChangeProcessEnqueue: Error transitioning state 11:21:12 INFO - PROCESS | 24448 | UnknownError 11:21:13 INFO - TEST-INFO | 24448: exit 0 11:21:13 INFO - Browser initialized. 11:21:13 INFO - Running cycle 1/1 for kraken test... 11:21:13 INFO - TEST-INFO | started process 24532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8r6tjb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:25 INFO - PROCESS | 24532 | RSS: Main: 155209728 11:21:25 INFO - PROCESS | 24532 | 11:21:27 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55538/tests/kraken/driver.html?testName=audio-beat-detection) 11:21:28 INFO - PROCESS | 24532 | RSS: Main: 211451904 11:21:28 INFO - PROCESS | 24532 | 11:21:31 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55538/tests/kraken/driver.html?testName=audio-dft) 11:21:31 INFO - PROCESS | 24532 | RSS: Main: 191229952 11:21:31 INFO - PROCESS | 24532 | 11:21:35 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55538/tests/kraken/driver.html?testName=audio-fft) 11:21:35 INFO - PROCESS | 24532 | RSS: Main: 268050432 11:21:35 INFO - PROCESS | 24532 | 11:21:37 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55538/tests/kraken/driver.html?testName=audio-oscillator) 11:21:38 INFO - PROCESS | 24532 | RSS: Main: 179359744 11:21:38 INFO - PROCESS | 24532 | 11:21:40 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55538/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:41 INFO - PROCESS | 24532 | RSS: Main: 183545856 11:21:41 INFO - PROCESS | 24532 | 11:21:44 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55538/tests/kraken/driver.html?testName=imaging-darkroom) 11:21:44 INFO - PROCESS | 24532 | RSS: Main: 218578944 11:21:44 INFO - PROCESS | 24532 | 11:21:48 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55538/tests/kraken/driver.html?testName=imaging-desaturate) 11:21:48 INFO - PROCESS | 24532 | RSS: Main: 218619904 11:21:48 INFO - PROCESS | 24532 | 11:21:51 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55538/tests/kraken/driver.html?testName=json-parse-financial) 11:21:52 INFO - PROCESS | 24532 | RSS: Main: 218468352 11:21:52 INFO - PROCESS | 24532 | 11:21:53 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55538/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:54 INFO - PROCESS | 24532 | RSS: Main: 181575680 11:21:54 INFO - PROCESS | 24532 | 11:21:55 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55538/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:56 INFO - PROCESS | 24532 | RSS: Main: 188481536 11:21:56 INFO - PROCESS | 24532 | 11:21:58 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55538/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:59 INFO - PROCESS | 24532 | RSS: Main: 193175552 11:21:59 INFO - PROCESS | 24532 | 11:22:01 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55538/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:22:02 INFO - PROCESS | 24532 | RSS: Main: 186855424 11:22:02 INFO - PROCESS | 24532 | 11:22:05 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55538/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:22:05 INFO - PROCESS | 24532 | RSS: Main: 192028672 11:22:05 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | Cycle 1(1): loaded http://localhost:55538/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55538/tests/kraken/driver.html?testName=ai-astar) 11:22:07 INFO - PROCESS | 24532 | RSS: Main: 243798016 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | __start_tp_report 11:22:07 INFO - PROCESS | 24532 | _x_x_mozilla_page_load 11:22:07 INFO - PROCESS | 24532 | _x_x_mozilla_page_load_details 11:22:07 INFO - PROCESS | 24532 | |i|pagename|runs| 11:22:07 INFO - PROCESS | 24532 | |0;ai-astar;102;111;111;110;111;113;109;110;111;111 11:22:07 INFO - PROCESS | 24532 | |1;audio-beat-detection;147;121;119;174;118;118;142;117;162;121 11:22:07 INFO - PROCESS | 24532 | |2;audio-dft;161;160;162;160;161;162;161;161;162;161 11:22:07 INFO - PROCESS | 24532 | |3;audio-fft;75;76;76;114;77;76;76;75;111;75 11:22:07 INFO - PROCESS | 24532 | |4;audio-oscillator;85;85;113;85;86;85;126;84;87;129 11:22:07 INFO - PROCESS | 24532 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;116;117 11:22:07 INFO - PROCESS | 24532 | |6;imaging-darkroom;146;146;146;146;145;146;145;146;145;147 11:22:07 INFO - PROCESS | 24532 | |7;imaging-desaturate;96;95;95;95;96;95;95;95;96;95 11:22:07 INFO - PROCESS | 24532 | |8;json-parse-financial;51;49;51;50;51;52;52;52;51;51 11:22:07 INFO - PROCESS | 24532 | |9;json-stringify-tinderbox;62;62;63;62;64;62;62;62;62;62 11:22:07 INFO - PROCESS | 24532 | |10;stanford-crypto-aes;77;78;81;83;78;77;77;83;78;78 11:22:07 INFO - PROCESS | 24532 | |11;stanford-crypto-ccm;126;125;124;123;129;125;123;124;145;129 11:22:07 INFO - PROCESS | 24532 | |12;stanford-crypto-pbkdf2;166;164;161;164;164;164;164;161;161;163 11:22:07 INFO - PROCESS | 24532 | |13;stanford-crypto-sha256-iterative;64;64;65;63;64;68;64;64;63;63 11:22:07 INFO - PROCESS | 24532 | __end_tp_report 11:22:07 INFO - PROCESS | 24532 | __start_cc_report 11:22:07 INFO - PROCESS | 24532 | _x_x_mozilla_cycle_collect,1645 11:22:07 INFO - PROCESS | 24532 | __end_cc_report 11:22:07 INFO - PROCESS | 24532 | __startTimestamp1471630927579__endTimestamp 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | ------- Summary: start ------- 11:22:07 INFO - PROCESS | 24532 | Number of tests: 14 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.96 (2.7%) stddev-sans-first:1.09 11:22:07 INFO - PROCESS | 24532 | Values: 102.0 111.0 111.0 110.0 111.0 113.0 109.0 110.0 111.0 111.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:131.50 stddev:21.03 (16.0%) stddev-sans-first:21.77 11:22:07 INFO - PROCESS | 24532 | Values: 147.0 121.0 119.0 174.0 118.0 118.0 142.0 117.0 162.0 121.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:22:07 INFO - PROCESS | 24532 | Values: 161.0 160.0 162.0 160.0 161.0 162.0 161.0 161.0 162.0 161.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:15.52 (20.4%) stddev-sans-first:16.19 11:22:07 INFO - PROCESS | 24532 | Values: 75.0 76.0 76.0 114.0 77.0 76.0 76.0 75.0 111.0 75.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:18.51 (21.8%) stddev-sans-first:19.16 11:22:07 INFO - PROCESS | 24532 | Values: 85.0 85.0 113.0 85.0 86.0 85.0 126.0 84.0 87.0 129.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:22:07 INFO - PROCESS | 24532 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 11:22:07 INFO - PROCESS | 24532 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 147.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:22:07 INFO - PROCESS | 24532 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 11:22:07 INFO - PROCESS | 24532 | Values: 51.0 49.0 51.0 50.0 51.0 52.0 52.0 52.0 51.0 51.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 11:22:07 INFO - PROCESS | 24532 | Values: 62.0 62.0 63.0 62.0 64.0 62.0 62.0 62.0 62.0 62.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.00 stddev:2.40 (3.1%) stddev-sans-first:2.44 11:22:07 INFO - PROCESS | 24532 | Values: 77.0 78.0 81.0 83.0 78.0 77.0 77.0 83.0 78.0 78.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:125.50 stddev:6.58 (5.2%) stddev-sans-first:6.97 11:22:07 INFO - PROCESS | 24532 | Values: 126.0 125.0 124.0 123.0 129.0 125.0 123.0 124.0 145.0 129.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:164.00 stddev:1.69 (1.0%) stddev-sans-first:1.45 11:22:07 INFO - PROCESS | 24532 | Values: 166.0 164.0 161.0 164.0 164.0 164.0 164.0 161.0 161.0 163.0 11:22:07 INFO - PROCESS | 24532 | 11:22:07 INFO - PROCESS | 24532 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 11:22:07 INFO - PROCESS | 24532 | Values: 64.0 64.0 65.0 63.0 64.0 68.0 64.0 64.0 63.0 63.0 11:22:07 INFO - PROCESS | 24532 | -------- Summary: end -------- 11:22:07 INFO - PROCESS | 24532 | 11:22:08 INFO - TEST-INFO | 24532: exit 0 11:22:08 INFO - TEST-OK | kraken | took 60670ms 11:22:08 INFO - SUITE-END | took 1175s 11:22:08 INFO - Completed test suite (00:19:35) 11:22:08 INFO - javascript benchmark 11:22:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.9848950755245, 3050.5424186372047, 3057.740092092172, 3064.6475655299632, 3077.707617776312, 5159.793608255665, 5278.815241466549, 5302.496262855027, 5382.327209098863, 5425.538829199518, 5296.708681022552, 5317.308749862513, 5344.118220493614, 5423.810166644168, 5439.646422982503, 4820.927686084711, 4871.098846713369, 4879.853604391874, 4919.016196760645, 4923.409190897098, 4917.655764096515, 4937.901241975158, 4952.207646776516, 4965.230389289666, 4980.626453016038, 4793.161196790583, 4795.6163506919365, 4926.9014619707405, 4939.407271127488, 4972.87567810804, 4782.067496838118, 4829.3721816164025, 4887.902241955141, 4889.3888263967, 4908.656394052417, 4855.490173531799, 4901.705897646153, 4914.262860570907, 4920.212765957465, 4923.950760492385, 5152.3044389007755, 5193.454687257821, 5235.947640523584, 5409.540189083933, 5441.537469315113, 5615.410381909882, 5663.263775709132, 5673.149027645845, 5674.205611214392, 5679.886402271973, 5721.256236689245, 5722.0, 5723.227364305807, 5728.541716662657, 5734.455226753494, 5156.484351564851, 5220.738963051832, 5245.344331958505, 5250.343707036621, 5319.095753721838, 5829.76680932758, 5836.88326233473, 5845.766169353264, 5846.4153584642045, 5846.853828654318, 5608.6073974821375, 5614.101743720985, 5614.550835933115, 5617.550595952396, 5620.747066382022, 5537.086380747131, 5578.30271216098, 5629.324481062217, 5630.71846407678, 5691.487766100988, 5706.828795136153, 5707.800226992118, 5710.029295019856, 5711.971440142773, 5718.7426565804635, 5659.037963546125, 5703.657780533182, 5705.885882282331, 5712.742926568314, 5721.5708821838525, 4059.5331536873637, 4151.12826306473, 4165.271077561415, 4171.416001759756, 4207.789610519523, 3766.246750649881, 3769.26499332633, 3780.4518344839844, 3782.829772660237, 3800.8669696560487, 5323.387810401853, 5325.09473389517, 5329.680219186861, 5332.760025798849, 5393.892122157535, 5556.472135147154, 5593.049181639131, 5628.437156284339, 5631.436856314418, 5726.685032323262, 5342.0384330820825, 5345.893082138413, 5359.919601205985, 5362.51737343641, 5377.623566350396, 4891.902161956741, 4894.720537239987, 4900.362952816111, 4911.238757992517, 4911.533404326583, 5752.0, 5844.795432159854, 5860.413958604106, 5877.500412464903, 5891.764329426775, 5722.341930677859, 5722.771089156554, 5730.541556675539, 5732.34078081026, 5759.424057594207, 5951.226340575698, 5959.0, 5959.970200149145, 5967.373425790403, 5973.641581505123, 5373.328333958255, 5479.0, 5498.642588231752, 5508.476694713996, 5645.858853528694, 5665.3201615806365, 5704.258446401941, 5705.572082093777, 5706.258186435737, 5721.0, 5574.693391863487, 5578.497935185853, 5579.358373786904, 5585.301837270341, 5591.552675785846, 5421.512063914267, 5543.5010849022165, 5560.66636001825, 5592.832215033555, 5612.242347283064, 5674.546036317167, 5675.31896172462, 5678.517326027334, 5685.488306052475, 5685.857853553694, 5701.857453563694, 5711.8857622848145, 5717.22817419643, 5721.57088218377, 5732.5413966881715, 5312.601554883322, 5420.647657902224, 5465.918011229915, 5469.781208751605, 5598.10430331145], "value": 5243.878621121144, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.2879514221796, 571.8598943258902, 582.4524946550242, 582.6795262605567, 584.4681339980618, 42914.57085429145, 44139.55860441395, 44377.0, 48408.51591484084, 48497.27254091183, 45022.549774502244, 45473.77263113688, 45524.544754552444, 45562.544374556244, 45615.771921140346, 8118.918810811875, 9021.548922553879, 9098.727038188832, 9177.449353038806, 10719.088877445387, 10664.573417063308, 11176.664700058971, 11193.0, 11193.27243729155, 11197.104231661488, 11186.664400068012, 11245.718857028598, 11251.381174035425, 11251.493682784254, 11259.718507037307, 11136.053435457996, 11160.05139563134, 11200.495977681025, 11210.047145992601, 11215.214934954556, 10901.890981090168, 10953.397563134024, 10970.122390208764, 10977.341359518374, 10985.780284394268, 43532.782336088436, 43924.0, 43959.0, 43969.78015109936, 44015.11969760587, 3371.190914180579, 3492.4935884296888, 3497.7901325920525, 3879.2047630236016, 4250.064985703171, 32458.675413246037, 33527.0, 33951.4907276391, 34101.82949085239, 34121.658783412095, 4411.691181617288, 4477.9104417911785, 4497.5952164305045, 4537.931931021038, 4591.563801438858, 341143.0, 341460.0, 341585.0, 345379.0, 345842.0, 59756.414615123234, 60229.0, 60323.0, 60361.69819150964, 60424.697876510334, 64233.67883160648, 64253.357466424735, 64369.67815160988, 64375.35624643787, 64464.0, 14101.0, 14310.356033978496, 14324.785128223086, 14399.856001440061, 14409.855901440851, 9762.853557196648, 9972.80054398908, 10270.07569318765, 10623.893761062445, 10637.255392122477, 17954.19206135727, 18232.179551920195, 18406.81593184051, 18454.26182952667, 18509.5372615683, 5929.0, 6022.5784195105925, 6114.327423983358, 6117.84705382369, 6127.295361033449, 929.4934260827865, 1051.6056478820442, 1062.3519653011656, 1067.9679609611724, 1102.3606308341143, 32562.837185813918, 33129.83435082809, 33308.833455832566, 33312.1671958203, 33611.66388336085, 1094.5293523784849, 1120.6469961961957, 1145.1010956399186, 1162.3258510064143, 1201.6995751062234, 16489.91755041217, 17394.913025435046, 17598.180183670458, 17671.823281767018, 17869.642607147784, 530129.0, 751698.0, 759815.0, 761109.0, 764026.0, 60084.0, 60744.696276518334, 60779.0, 60843.69578152081, 60917.39082609206, 1221.7434338788776, 1279.8976081913238, 1332.4803326702595, 1340.993295033538, 1369.9315034248248, 29739.256518586342, 33916.0, 34210.65789342174, 34317.22510523791, 34698.826505867306, 39444.60555394409, 39886.800565996986, 39895.60104398919, 39906.80046599748, 39932.0, 377997.0, 381968.0, 382367.0, 382837.0, 383316.0, 26358.20925372242, 28448.715512844607, 28963.275918102216, 29415.26461838471, 29433.411331773674, 45676.771616141705, 46239.537604623525, 47434.28848567343, 51543.226851598, 51705.224421634455, 40062.79968600255, 41249.587504124574, 41351.58648413477, 41420.58579414288, 43556.56443435525, 41209.38185927273, 41359.37960930649, 41651.583484164774, 42556.36165457459, 42825.357619635106, 40458.79770601128, 41917.58082419137, 42234.78882605567, 42420.0, 42436.78781606072, 30178.0, 32962.67037329596, 32995.67004329926, 33358.83320583479, 33622.83188584042, 27881.302967425978, 28145.87416503317, 28199.295017624725, 28218.153455396372, 28408.43183136367], "value": 20493.57263178893, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.19560683027123, 404.4337926902335, 409.6108696738099, 412.54825965567704, 425.2175996167054, 13197.934010329935, 18472.076396180186, 19460.41618751436, 20214.0, 20289.59420811583, 15247.923760381183, 18068.819311806878, 18780.71828922564, 18864.0, 19033.90483047583, 5783.132530120473, 5977.193078934353, 5980.790672326448, 5982.940170598282, 5984.88030239395, 5740.138979153139, 5871.588988770788, 5882.382349853268, 5964.612300200473, 5965.985782416978, 5889.322727886283, 5920.970395148018, 5922.822315330525, 5931.406859314077, 5933.376995415484, 5684.715764211773, 5830.621009634403, 5879.970600147015, 5897.4102589741115, 5922.318933322658, 5266.526012658879, 5267.920981185285, 5270.130428479296, 5272.525472707436, 5274.657147285414, 23092.76907230923, 23495.76504234953, 23670.0, 23896.163634272893, 24083.0, 2479.85120892747, 2495.563276426618, 2589.4562141950214, 3118.937621247562, 3186.060112266887, 9374.156325930699, 9634.084761947604, 9766.560504777302, 9906.306558540906, 14586.416543338253, 1830.8838852447645, 1907.6280125375558, 1932.5265309999, 1952.511872031992, 1994.9202031918705, 83189.58405207936, 85149.14850851474, 85272.0, 86462.0, 86642.0, 10978.890211097947, 11085.0, 11223.158263130297, 11259.605913793142, 11329.2069555132, 15726.528204153665, 15744.606384840241, 15745.291461884242, 15773.447929322649, 15779.842201578067, 6912.758053468105, 7493.138289096823, 7544.0, 7713.498622589514, 7724.6137693115115, 6947.444204463732, 6973.302669732986, 7117.501774875709, 7120.0387947626405, 7122.145342558926, 4415.139047885696, 4604.148232576984, 4703.717776933327, 4869.074875773663, 4937.604991600663, 1994.411648563677, 2010.8190262876412, 2038.8063134002246, 2048.3035767839006, 2052.9076191571417, 844.2992316377392, 953.4946478366477, 968.3463662028103, 988.6144403682425, 1021.6526381030337, 18472.907635461735, 19399.127039283267, 19500.70748938767, 19663.901680491505, 19772.505687357643, 975.6146322202691, 981.8183636027358, 986.4673076538588, 1000.3647683720744, 1018.6231094495084, 10310.0, 10746.677599672023, 10962.945185274182, 10991.670249892515, 11003.944980275048, 460670.0, 463277.0, 475958.0, 477145.0, 478593.0, 89092.0, 89181.55409223042, 90723.54638226767, 90736.54631726931, 92226.0, 930.0420566816055, 939.990600094004, 975.1954637424153, 981.3572110267786, 981.7251169672503, 16436.0, 16979.575510612332, 17466.30134794645, 17501.737473937646, 17751.911240443715, 44765.552344476135, 45010.54989450063, 45539.31691024571, 46365.304520432896, 48007.0, 59378.0, 61949.951704292, 62091.0, 62278.0, 65792.0, 12228.510859565518, 12586.937065314614, 12784.48862045545, 12860.678483037998, 13185.34073296312, 13936.651583710489, 13959.953003524573, 14336.0, 14396.352164152848, 14625.561233163022, 12227.572034978733, 12524.499020039097, 12566.120371573903, 12650.810237846625, 13009.21944683322, 11719.531218751154, 12513.562025329069, 12727.93636031814, 12992.740145197233, 13212.471501139848, 12478.251304921734, 12627.368631568568, 12658.240505569695, 12853.16454430459, 12937.223766574036, 12467.875321247035, 12668.429920653776, 12712.682182945131, 12764.234145951272, 12790.0, 11117.888821112008, 11844.348560829238, 12033.157678962389, 12483.31341776211, 12888.324517812624], "value": 9560.986967515644, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.5428781358244, 1476.453712126513, 1531.624751935776, 1617.4743208457255, 1757.340997126077, 8670.219680228778, 9120.543972801359, 9151.77120571986, 9437.622495100188, 9439.38643988142, 9238.67664631738, 9336.766580835483, 9336.906630933689, 9359.298052646061, 9369.063093690627, 2099.454141923103, 2413.9155129570468, 2420.8547487150827, 2441.389652586853, 2442.206282958037, 2187.3219302016346, 2206.878621675807, 2208.4258092895884, 2341.6838726771925, 2470.481198948223, 2376.0852071952336, 2421.6004359280696, 2421.806255499556, 2423.442608200115, 2424.078850036992, 2363.5036642305136, 2430.4652976345265, 2444.8533088014597, 2449.0938352809576, 2453.7055553333626, 2278.111536500766, 2286.222684287334, 2300.4363930836885, 2364.4207169243646, 2365.550545396369, 9220.21628161607, 9289.860652090225, 9290.0, 9300.069993000645, 9303.116203960613, 5046.0, 5192.506711862367, 5195.662281951699, 5197.194434862565, 5199.896002079937, 3377.206356506219, 3528.770629909048, 3567.3066834539754, 3619.457081437779, 3644.599094099647, 1117.1677100560053, 1158.9188756787028, 1161.872194058653, 1167.3871217610738, 1198.3708553009653, 12979.870201297961, 13301.0, 13312.400941957636, 13392.0, 13400.5309814157, 4651.767411629405, 4713.0, 4788.329633851264, 4796.736179510091, 4928.7289199093675, 11164.665060048212, 11166.776664466664, 11187.384693841754, 11194.440277986068, 11197.216194866282, 5336.42575440246, 5339.759710813023, 5348.171033489815, 5357.0357335679955, 5362.249285100089, 4809.759512024385, 4815.2054910940005, 4873.244647079709, 4908.141075311806, 4908.950910490921, 3845.692344612424, 4045.1707399982934, 4075.3886916962692, 4193.958060419418, 4194.979025104855, 1322.0679421008167, 1342.90599658023, 1344.6638340414897, 1360.9183448993092, 1375.126794485509, 955.4171955107379, 1001.2790790630734, 1006.9798604028025, 1012.099231683802, 1022.0699163761091, 6217.751289948352, 6243.656598887014, 6266.122742816009, 6424.783449709843, 6480.740770369227, 994.990085063661, 1003.2024540490328, 1020.8621836052038, 1029.629333439961, 1032.9825122254574, 4244.745315281093, 4405.317175837687, 4416.425864637641, 4448.933266001012, 4496.1906856765445, 11072.446377681084, 11508.424578771028, 11555.36445495489, 11560.595379161858, 11578.36319002463, 10484.947575262075, 10831.729206769736, 11023.779524409627, 11508.769824603462, 11520.366379849022, 8244.587770611446, 8348.457350272334, 8491.575421228914, 8500.234978851933, 8501.234888859908, 6245.687715614292, 6372.713227904848, 6384.042393640805, 6424.2933277338525, 6440.774572889926, 10385.117265032557, 10697.197710171613, 10723.463826808473, 10728.302660327054, 10741.194410419406, 10430.530626121994, 10664.146868250677, 10679.5194216262, 10894.400807955639, 10941.179411544324, 8080.878786818085, 8188.976377952756, 8284.420090593841, 8284.50292982423, 8299.08710041907, 8825.38222324431, 8876.0, 8946.418482798597, 8946.821063578562, 8951.686690965786, 7868.370530357673, 8051.798705032421, 8120.228578285053, 8129.187081291823, 8226.218509241851, 7736.7678969631, 7942.6028698566, 8008.919910800817, 8040.195980401913, 8063.435559510778, 7090.716371345088, 7182.17404998411, 7189.748358807626, 7192.820179495555, 7196.244394338519, 5353.946460535501, 5449.509544141047, 5502.257195278587, 5646.774129034792, 5692.658440493584, 5443.59173062014, 5543.833684989457, 5567.610267281251, 5647.29408823897, 5693.089105743061], "value": 4838.618970400591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.94169049571076, 324.4241471388286, 333.55637002786295, 335.08354650032175, 335.89587227959316, 5283.313169287987, 5285.312909321783, 5286.788528458862, 5288.8413347599635, 5293.444188360225, 5166.819161329354, 5207.921881171786, 5222.9477705222935, 5227.424983251849, 5228.738563071841, 3863.5750067492622, 3929.960700392988, 3975.642192202701, 4012.1173341864887, 4025.5773143819915, 3651.9269614607692, 4050.989520374837, 4073.87778366648, 4075.3886916962397, 4088.693347998897, 4024.4969378827645, 4028.858989935353, 4034.4150098235737, 4056.3509838425857, 4083.8570650027254, 3888.4361767543833, 3989.501312335958, 4067.938980915274, 4073.165001174752, 4080.510338759353, 3609.8736544221088, 3614.765040272374, 3623.691986181178, 3639.308531379056, 3650.689691376236, 4979.253112033188, 4985.376827896513, 4990.6257030722845, 5050.888804463012, 5093.414257360414, 4341.500727416356, 4650.558326918666, 4653.115907977473, 4672.322513235596, 4674.485806561275, 5366.490183432567, 5375.704336261504, 5379.677219366811, 5388.43421440747, 5408.242846001563, 3813.1229817141934, 3819.2934307153264, 3837.654611085016, 3845.0, 3856.325143099946, 5076.365454318173, 5385.192221166856, 5693.491224825383, 5725.799597014085, 5730.713464326767, 3966.3058964681063, 3969.1069509360163, 3972.205558888234, 3979.2837289288204, 4018.457508236351, 4056.7829651104553, 4059.4722686050623, 4061.573534778806, 4061.7156799024374, 4069.4302797608357, 4615.95384046162, 4629.328747331618, 4641.837535686234, 4648.465426475998, 4664.86005419838, 5187.0, 5423.322084739408, 5428.4842939920645, 5459.12653975362, 5515.531179849758, 1364.8089267502558, 1389.3608939887765, 1389.9652508687363, 1401.3903951781008, 1402.1797248609678, 859.9551544873009, 901.6032945503957, 904.9864252036225, 907.8275127725711, 909.1045320359441, 4657.906841863144, 4680.719156850531, 4681.180793361148, 4684.718916864999, 4696.38946936896, 4936.605071594264, 4946.727929963815, 4950.168437678082, 4981.701097934136, 5010.5240002199735, 4378.4745830499905, 4621.699589526737, 4663.930041049387, 4684.5549672781035, 4692.1554120258, 2600.2849216465247, 2604.0, 2618.725033871416, 2633.5654616988368, 2639.6700412448445, 5069.594432445396, 5084.0, 5123.846284611468, 5129.384473863086, 5154.433012368637, 4807.927881081787, 5016.297718319438, 5027.949720502821, 5039.5810011194835, 5040.344755181803, 5060.962502686941, 5114.846554603368, 5122.769475373691, 5126.333576635088, 5138.203578445347, 4912.5753531475475, 4925.408950925912, 4960.107180707508, 4962.925556116589, 4972.383975207999, 4921.311016457627, 4939.876503087307, 4973.776180071833, 5204.323437953042, 5590.5527557796095, 5862.413758624103, 5863.706814659336, 5866.2373891393845, 5869.325027621708, 5870.14882841994, 4100.446439730598, 4128.153728485593, 4131.111810960658, 4155.148194620036, 4158.8336466540995, 5330.253764473055, 5581.609287349846, 5585.832425027255, 5667.40492248308, 5740.540756739534, 5447.918281225864, 5522.5858060646415, 5525.4474552544425, 5531.751071201725, 5537.667739935617, 5475.561955043667, 5476.534494568006, 5485.6982865942755, 5489.8745757118895, 5490.231367608458, 5248.580113590827, 5439.184122381516, 5473.261109750292, 5488.588355873405, 5489.780408783764, 5443.169551832945, 5522.392536821027, 5525.392206857323, 5525.475079867406, 5534.308211473566, 5213.60897932649, 5422.159565267232, 5426.321709786277, 5426.511613954763, 5445.50990410865], "value": 4042.6351508509233, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.5112625667058, 743.8623854586901, 773.814284571703, 796.2674339607561, 867.2758246863868, 15241.847581524182, 15890.126043067627, 15897.761533576977, 15899.920500397511, 15974.520764377074, 14903.478378256763, 15409.614759631015, 15438.459653912116, 15581.376744930218, 15623.140727259995, 804.6901942752024, 825.558326295432, 827.0860698927688, 827.210014436212, 828.4863384701493, 617.2993652204757, 634.5716641267127, 637.6684124255385, 639.7409049335004, 670.1321788284159, 852.4757274276307, 853.0, 853.8463076646201, 854.5300084953282, 854.7521218846528, 849.3375167369462, 849.9362547808939, 849.9915000850036, 850.0352100366098, 850.3664769746548, 509.6941834899031, 608.8143116349512, 624.8375422390166, 628.2931701835436, 629.3203340392365, 14817.70364592702, 14892.851071489255, 14951.252437378087, 14968.550943471713, 14986.850131498764, 14292.356843942047, 14672.339744711513, 15051.623709407353, 15125.16811575363, 15368.30842612074, 13331.600051998359, 13425.597232083053, 13503.59489215325, 13522.0, 13900.16599004063, 4430.0, 4493.113456859825, 4527.592516673482, 4553.385292985437, 4660.324252983332, 80370.0, 80488.59755701243, 81225.0, 81310.46240144818, 81773.0, 11557.88442115585, 11612.30326180415, 11767.584953153411, 11789.644190917983, 11828.881711182778, 23104.884475577852, 23140.884295578413, 23146.65280020801, 23147.88426057859, 23155.189568365025, 8566.143385661384, 8661.696840610675, 8732.432391894634, 8745.490341085202, 8832.690855820016, 4696.225122854759, 4764.571188593043, 4862.82980095702, 4893.681910675866, 4919.3358896549225, 3559.14580500678, 3700.4264339027495, 3721.330160571069, 3722.088088418355, 3740.925181496409, 627.7394881124374, 635.1742734445295, 637.8947473666885, 640.7308930249307, 656.3928366261189, 644.6615526848442, 659.9448226584341, 661.3750006244053, 664.7307840324676, 679.2697849811473, 8774.60514276859, 9253.907460925304, 9451.810963780687, 9638.325317227867, 9674.467904265191, 637.5632691606172, 639.3031595560861, 673.8315421144714, 686.2211390072304, 687.5874475314871, 4617.284320930261, 4645.976770116128, 4665.486796452456, 4670.859874203779, 4695.107929493453, 106876.0, 109538.0, 112975.0, 117572.41213794047, 124488.0, 94646.0, 95222.52388738011, 99301.50349248208, 99679.64796042518, 99873.50063249638, 53177.46822531803, 61027.69486152541, 86158.56920715356, 86340.56829715811, 88628.0, 9299.67451139207, 9467.668631598137, 9563.234941204826, 9875.506224688881, 9879.555420006262, 50760.23859642034, 52233.47766522286, 53054.73472632612, 53364.73317633542, 55433.44566554283, 71006.0, 73702.0, 74277.62861185876, 75560.0, 77499.2250077492, 13252.337383130613, 13733.313334333043, 13849.16904985704, 13903.930480347533, 14132.293385330488, 15384.769228461359, 15468.690626187637, 15490.148041857807, 15512.612184695021, 16169.191540423168, 13817.0, 13845.584632461043, 14097.224652644203, 14099.365528551034, 14406.567802965928, 13300.041119847076, 13660.521881734092, 13728.65678358049, 13784.586462406143, 13927.512537061155, 13703.794443083163, 14240.430382784987, 14241.828275535778, 14311.141331520143, 14718.77921831152, 11282.887171128184, 11318.151138664798, 11434.485448154686, 11445.542178312775, 11457.0, 10375.018676228776, 10573.62992295266, 10605.969851252747, 11386.94306528462, 11948.820767688665], "value": 7629.451846424641, "unit": "score"}], "name": "dromaeo_css", "value": 7316.161505053347, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 111.0, 113.0, 109.0, 110.0, 111.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 119.0, 174.0, 118.0, 118.0, 142.0, 117.0, 162.0, 121.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 77.0, 76.0, 76.0, 75.0, 111.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 85.0, 86.0, 85.0, 126.0, 84.0, 87.0, 129.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 51.0, 50.0, 51.0, 52.0, 52.0, 52.0, 51.0, 51.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 81.0, 83.0, 78.0, 77.0, 77.0, 83.0, 78.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 124.0, 123.0, 129.0, 125.0, 123.0, 124.0, 145.0, 129.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 161.0, 164.0, 164.0, 164.0, 164.0, 161.0, 161.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 64.0, 68.0, 64.0, 64.0, 63.0, 63.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1489.3, "alertThreshold": 2.0}]} 11:22:08 INFO - Return code: 0 11:22:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:22:08 INFO - # TBPL SUCCESS # 11:22:08 INFO - Running post-action listener: _resource_record_post_action 11:22:08 INFO - [mozharness: 2016-08-19 18:22:08.880785Z] Finished run-tests step (success) 11:22:08 INFO - Running post-run listener: _resource_record_post_run 11:22:08 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418336768; Read time: 12; Write time: 318320 11:22:08 INFO - TinderboxPrint: CPU usage
13.0% 11:22:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:22:08 INFO - TinderboxPrint: I/O write bytes / time
418,336,768 / 318,320 11:22:08 INFO - TinderboxPrint: CPU idle
8,270.8 (86.9%) 11:22:08 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 11:22:08 INFO - TinderboxPrint: Swap in / out
0 / 0 11:22:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 127483904; Read time: 0; Write time: 97748 11:22:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290504704; Read time: 0; Write time: 220532 11:22:09 INFO - Running post-run listener: _upload_blobber_files 11:22:09 INFO - Blob upload gear active. 11:22:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:22:09 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 11:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:22:09 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:22:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:22:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:10 INFO - (blobuploader) - INFO - Done attempting. 11:22:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:22:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:22:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:14 INFO - (blobuploader) - INFO - Done attempting. 11:22:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:22:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:15 INFO - (blobuploader) - INFO - Done attempting. 11:22:15 INFO - (blobuploader) - INFO - Iteration through files over. 11:22:15 INFO - Return code: 0 11:22:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:22:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:22:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e75214af0fe9a31c609c0b7da73fa565dfe116a28487e49a0b065f104eafc6cc1d07c8b83e84f5f7745726546564cbaef7cbb1247e2ce4b648d25b3c0e861941", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/312dc80b3aab8fa1f0cb58ab0bab96466ef489890b8321d78ddbf5152bdd3bac7cf2849afbe1f89efc59d0d3f1db3cd6da65c32afd874134ab93380e9ee95883", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e52743b065eb7ec91aa931d9b37408acc8ea6feccd5ecd6b9e410c922b7c331e093fe3a3396045785bd31acb3c66ea10350c2b5354c85caacbfafc845513459"} 11:22:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:22:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:22:15 INFO - Contents: 11:22:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e75214af0fe9a31c609c0b7da73fa565dfe116a28487e49a0b065f104eafc6cc1d07c8b83e84f5f7745726546564cbaef7cbb1247e2ce4b648d25b3c0e861941", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/312dc80b3aab8fa1f0cb58ab0bab96466ef489890b8321d78ddbf5152bdd3bac7cf2849afbe1f89efc59d0d3f1db3cd6da65c32afd874134ab93380e9ee95883", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e52743b065eb7ec91aa931d9b37408acc8ea6feccd5ecd6b9e410c922b7c331e093fe3a3396045785bd31acb3c66ea10350c2b5354c85caacbfafc845513459"} 11:22:15 INFO - Running post-run listener: copy_logs_to_upload_dir 11:22:15 INFO - Copying logs to upload dir... 11:22:15 INFO - mkdir: /builds/slave/test/build/upload/logs 11:22:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.355875 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-19 11:22:15.522061) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 11:22:15.526195) ========= 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=6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e75214af0fe9a31c609c0b7da73fa565dfe116a28487e49a0b065f104eafc6cc1d07c8b83e84f5f7745726546564cbaef7cbb1247e2ce4b648d25b3c0e861941", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/312dc80b3aab8fa1f0cb58ab0bab96466ef489890b8321d78ddbf5152bdd3bac7cf2849afbe1f89efc59d0d3f1db3cd6da65c32afd874134ab93380e9ee95883", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e52743b065eb7ec91aa931d9b37408acc8ea6feccd5ecd6b9e410c922b7c331e093fe3a3396045785bd31acb3c66ea10350c2b5354c85caacbfafc845513459"} build_url:https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/eVww5Q7xRjugubw0HGSXDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e75214af0fe9a31c609c0b7da73fa565dfe116a28487e49a0b065f104eafc6cc1d07c8b83e84f5f7745726546564cbaef7cbb1247e2ce4b648d25b3c0e861941", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/312dc80b3aab8fa1f0cb58ab0bab96466ef489890b8321d78ddbf5152bdd3bac7cf2849afbe1f89efc59d0d3f1db3cd6da65c32afd874134ab93380e9ee95883", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e52743b065eb7ec91aa931d9b37408acc8ea6feccd5ecd6b9e410c922b7c331e093fe3a3396045785bd31acb3c66ea10350c2b5354c85caacbfafc845513459"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 11:22:15.552912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:22:15.553254) ========= 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=6dbc10da6d83fee962c624be000001a8-1471629221.291545-1511277407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:22:15.636741) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 11:22:15.637052) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 11:22:15.637370) ========= ========= Total master_lag: 0.20 =========