builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1483667730.53 results: success (0) revision: 53193729a50b40c00889b1fa07df8dffab7781f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:30.530830) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:30.531307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:30.531611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:30.546051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:30.546371) ========= 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=ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 17:55:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-01-05 17:55:30 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:30.678834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:30.679193) ========= 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=ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015606 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:30.729276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 17:55:30.729614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 53193729a50b40c00889b1fa07df8dffab7781f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 53193729a50b40c00889b1fa07df8dffab7781f9 --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=ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 17:55:31,020 truncating revision to first 12 chars 2017-01-05 17:55:31,020 Setting DEBUG logging. 2017-01-05 17:55:31,020 attempt 1/10 2017-01-05 17:55:31,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/53193729a50b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 17:55:32,307 unpacking tar archive at: mozilla-central-53193729a50b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.683476 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 17:55:32.427469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:32.427787) ========= script_repo_revision: 53193729a50b40c00889b1fa07df8dffab7781f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:32.428183) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:32.428449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 17:55:32.438283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-05 17:55:32.438642) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:55:32 INFO - MultiFileLogger online at 20170105 17:55:32 in /builds/slave/test 17:55:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:55:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:55:32 INFO - {'append_to_log': False, 17:55:32 INFO - 'base_work_dir': '/builds/slave/test', 17:55:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:55:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:55:32 INFO - 'branch': 'Firefox-Non-PGO', 17:55:32 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:32 INFO - 'config_files': ('talos/linux_config.py',), 17:55:32 INFO - 'default_actions': ('clobber', 17:55:32 INFO - 'read-buildbot-config', 17:55:32 INFO - 'download-and-extract', 17:55:32 INFO - 'populate-webroot', 17:55:32 INFO - 'create-virtualenv', 17:55:32 INFO - 'install', 17:55:32 INFO - 'run-tests'), 17:55:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:32 INFO - 'download_minidump_stackwalk': True, 17:55:32 INFO - 'download_symbols': 'ondemand', 17:55:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:55:32 INFO - 'tooltool.py': '/tools/tooltool.py', 17:55:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:55:32 INFO - '/tools/misc-python/virtualenv.py')}, 17:55:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:32 INFO - 'installer_path': 'installer.exe', 17:55:32 INFO - 'log_level': 'info', 17:55:32 INFO - 'log_name': 'talos', 17:55:32 INFO - 'log_to_console': True, 17:55:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:55:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:55:32 INFO - 'opt_config_files': (), 17:55:32 INFO - 'pip_index': False, 17:55:32 INFO - 'sps_profile': False, 17:55:32 INFO - 'sps_profile_interval': 0, 17:55:32 INFO - 'suite': 'dromaeojs-e10s', 17:55:32 INFO - 'system_bits': '32', 17:55:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:32 INFO - 'title': 'talos-linux64-ix-029', 17:55:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:32 INFO - 'use_talos_json': True, 17:55:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:55:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:32 INFO - 'work_dir': 'build'} 17:55:32 INFO - [mozharness: 2017-01-06 01:55:32.825514Z] Running clobber step. 17:55:32 INFO - Running pre-action listener: _resource_record_pre_action 17:55:32 INFO - Running main action method: clobber 17:55:32 INFO - rmtree: /builds/slave/test/build 17:55:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:33 INFO - Running post-action listener: _resource_record_post_action 17:55:33 INFO - [mozharness: 2017-01-06 01:55:33.827410Z] Finished clobber step (success) 17:55:33 INFO - [mozharness: 2017-01-06 01:55:33.827507Z] Running read-buildbot-config step. 17:55:33 INFO - Running pre-action listener: _resource_record_pre_action 17:55:33 INFO - Running main action method: read_buildbot_config 17:55:33 INFO - Using buildbot properties: 17:55:33 INFO - { 17:55:33 INFO - "project": "", 17:55:33 INFO - "product": "firefox", 17:55:33 INFO - "who": "kwierso@gmail.com", 17:55:33 INFO - "installer_path": "public/build/target.tar.bz2", 17:55:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:55:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:55:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:55:33 INFO - "stage_platform": "linux64", 17:55:33 INFO - "basedir": "/builds/slave/test", 17:55:33 INFO - "buildnumber": 600, 17:55:33 INFO - "platform": "ubuntu64_hw", 17:55:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:55:33 INFO - "slavebuilddir": "test", 17:55:33 INFO - "taskId": "WguWtYgGRoyTaXCWP5pkPQ", 17:55:33 INFO - "branch": "mozilla-central", 17:55:33 INFO - "script_repo_revision": "production", 17:55:33 INFO - "revision": "53193729a50b40c00889b1fa07df8dffab7781f9", 17:55:33 INFO - "slavename": "talos-linux64-ix-029", 17:55:33 INFO - "repo_path": "mozilla-central" 17:55:33 INFO - } 17:55:33 INFO - Finding installer, test and symbols from parent task. 17:55:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WguWtYgGRoyTaXCWP5pkPQ'}, attempt #1 17:55:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WguWtYgGRoyTaXCWP5pkPQ'}, attempt #1 17:55:34 INFO - Task dependencies: evJgljTzQC-5Qt9CU749Qw 17:55:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw'}, attempt #1 17:55:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.tar.bz2 17:55:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/test_packages.json 17:55:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.crashreporter-symbols.zip 17:55:35 INFO - Running post-action listener: _resource_record_post_action 17:55:35 INFO - [mozharness: 2017-01-06 01:55:35.202647Z] Finished read-buildbot-config step (success) 17:55:35 INFO - [mozharness: 2017-01-06 01:55:35.202864Z] Running download-and-extract step. 17:55:35 INFO - Running pre-action listener: _resource_record_pre_action 17:55:35 INFO - Running main action method: download_and_extract 17:55:35 INFO - mkdir: /builds/slave/test/build/tests 17:55:35 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')]} 17:55:35 INFO - trying https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.test_packages.json 17:55:35 INFO - Downloading https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:55:35 INFO - Downloaded 896 bytes. 17:55:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:55:35 INFO - Using the following test package requirements: 17:55:35 INFO - {u'common': [u'target.common.tests.zip'], 17:55:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:55:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:55:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:55:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:55:35 INFO - u'mozbase': [u'target.common.tests.zip'], 17:55:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:55:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:55:35 INFO - u'web-platform': [u'target.common.tests.zip', 17:55:35 INFO - u'target.web-platform.tests.zip'], 17:55:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:55:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:55:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.common.tests.zip 17:55:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:55:35 INFO - Fetch https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.common.tests.zip into memory 17:55:36 INFO - Expected file size: 20245540 17:55:36 INFO - Obtained file size: 20245540 17:55:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:55:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.common.tests.zip 17:55:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:55:40 INFO - Fetch https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.common.tests.zip into memory 17:55:41 INFO - Expected file size: 20245540 17:55:41 INFO - Obtained file size: 20245540 17:55:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.talos.tests.zip 17:55:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:55:46 INFO - Fetch https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.talos.tests.zip into memory 17:55:47 INFO - Expected file size: 14403730 17:55:47 INFO - Obtained file size: 14403730 17:55:47 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')]} 17:55:47 INFO - trying https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.tar.bz2 17:55:47 INFO - Downloading https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:55:49 INFO - Downloaded 55861260 bytes. 17:55:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.tar.bz2 17:55:49 INFO - mkdir: /builds/slave/test/properties 17:55:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:55:49 INFO - Writing to file /builds/slave/test/properties/build_url 17:55:49 INFO - Contents: 17:55:49 INFO - build_url:https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.tar.bz2 17:55:49 INFO - Running post-action listener: _resource_record_post_action 17:55:49 INFO - Running post-action listener: set_extra_try_arguments 17:55:49 INFO - [mozharness: 2017-01-06 01:55:49.033211Z] Finished download-and-extract step (success) 17:55:49 INFO - [mozharness: 2017-01-06 01:55:49.033436Z] Running populate-webroot step. 17:55:49 INFO - Running pre-action listener: _resource_record_pre_action 17:55:49 INFO - Running main action method: populate_webroot 17:55:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:55:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:55:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:55:49 INFO - '--tppagecycles', 17:55:49 INFO - '7'], 17:55:49 INFO - 'tests': ['tsvgm']}}, 17:55:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:55:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:55:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:55:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:55:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:55:49 INFO - 'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:55:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:55:49 INFO - 'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['damp', 'tps']}, 17:55:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:55:49 INFO - 'tests': ['damp', 'tps']}, 17:55:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['dromaeo_dom']}, 17:55:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:55:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['basic_compositor_video']}, 17:55:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:55:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['a11yr', 17:55:49 INFO - 'ts_paint', 17:55:49 INFO - 'tpaint', 17:55:49 INFO - 'sessionrestore', 17:55:49 INFO - 'sessionrestore_no_auto_restore', 17:55:49 INFO - 'tabpaint']}, 17:55:49 INFO - 'other-e10s': {'tests': ['a11yr', 17:55:49 INFO - 'ts_paint', 17:55:49 INFO - 'tpaint', 17:55:49 INFO - 'sessionrestore', 17:55:49 INFO - 'sessionrestore_no_auto_restore', 17:55:49 INFO - 'tabpaint']}, 17:55:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:55:49 INFO - 'ts_paint', 17:55:49 INFO - 'tpaint', 17:55:49 INFO - 'sessionrestore', 17:55:49 INFO - 'sessionrestore_no_auto_restore', 17:55:49 INFO - 'tabpaint']}, 17:55:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:55:49 INFO - 'ts_paint', 17:55:49 INFO - 'tpaint', 17:55:49 INFO - 'sessionrestore', 17:55:49 INFO - 'sessionrestore_no_auto_restore', 17:55:49 INFO - 'tabpaint']}, 17:55:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['a11yr', 17:55:49 INFO - 'ts_paint', 17:55:49 INFO - 'tpaint', 17:55:49 INFO - 'sessionrestore', 17:55:49 INFO - 'sessionrestore_no_auto_restore', 17:55:49 INFO - 'tabpaint']}, 17:55:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['a11yr', 17:55:49 INFO - 'ts_paint', 17:55:49 INFO - 'tpaint', 17:55:49 INFO - 'sessionrestore', 17:55:49 INFO - 'sessionrestore_no_auto_restore', 17:55:49 INFO - 'tabpaint']}, 17:55:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['tsvgx', 17:55:49 INFO - 'tsvgr_opacity', 17:55:49 INFO - 'tart', 17:55:49 INFO - 'tscrollx', 17:55:49 INFO - 'cart', 17:55:49 INFO - 'tsvg_static']}, 17:55:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:55:49 INFO - 'tsvgr_opacity', 17:55:49 INFO - 'tart', 17:55:49 INFO - 'tscrollx', 17:55:49 INFO - 'cart', 17:55:49 INFO - 'tsvg_static']}, 17:55:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:55:49 INFO - 'talos_options': ['--disable-e10s'], 17:55:49 INFO - 'tests': ['tp5o']}, 17:55:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:55:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:55:49 INFO - 'talos_options': ['--disable-e10s', 17:55:49 INFO - '--xperf_path', 17:55:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:49 INFO - 'tests': ['tp5n']}, 17:55:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:55:49 INFO - 'talos_options': ['--xperf_path', 17:55:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:49 INFO - 'tests': ['tp5n']}}, 17:55:49 INFO - 'talos.zip': {'path': '', 17:55:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:55:49 INFO - Running post-action listener: _resource_record_post_action 17:55:49 INFO - [mozharness: 2017-01-06 01:55:49.046949Z] Finished populate-webroot step (success) 17:55:49 INFO - [mozharness: 2017-01-06 01:55:49.047039Z] Running create-virtualenv step. 17:55:49 INFO - Running pre-action listener: _resource_record_pre_action 17:55:49 INFO - Running main action method: create_virtualenv 17:55:49 INFO - Creating virtualenv /builds/slave/test/build/venv 17:55:49 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 17:55:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:55:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:55:49 INFO - Using real prefix '/usr' 17:55:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:55:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:55:51 INFO - Installing pip.................done. 17:55:51 INFO - Return code: 0 17:55:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:55:51 INFO - Reading from file tmpfile_stdout 17:55:51 INFO - Output received: 17:55:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:55:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55: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')]} 17:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:55:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:55:51 INFO - Using env: {'DISPLAY': ':0', 17:55:51 INFO - 'HOME': '/home/cltbld', 17:55:51 INFO - 'LANG': 'en_US.UTF-8', 17:55:51 INFO - 'LANGUAGE': 'en_US:en', 17:55:51 INFO - 'LOGNAME': 'cltbld', 17:55:51 INFO - 'MAIL': '/var/mail/cltbld', 17:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:51 INFO - 'MOZ_NO_REMOTE': '1', 17:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:51 INFO - 'NO_EM_RESTART': '1', 17:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:51 INFO - 'PWD': '/builds/slave/test', 17:55:51 INFO - 'SHELL': '/bin/bash', 17:55:51 INFO - 'SHLVL': '1', 17:55:51 INFO - 'TERM': 'linux', 17:55:51 INFO - 'TMOUT': '86400', 17:55:51 INFO - 'USER': 'cltbld', 17:55:51 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:51 INFO - '_': '/tools/buildbot/bin/python'} 17:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:52 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 17:55:52 INFO - Cleaning up... 17:55:52 INFO - Return code: 0 17:55:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:55:52 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')]} 17:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:52 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')]} 17:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:52 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:55:52 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 17:55:52 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 17:55:52 INFO - Using env: {'DISPLAY': ':0', 17:55:52 INFO - 'HOME': '/home/cltbld', 17:55:52 INFO - 'LANG': 'en_US.UTF-8', 17:55:52 INFO - 'LANGUAGE': 'en_US:en', 17:55:52 INFO - 'LOGNAME': 'cltbld', 17:55:52 INFO - 'MAIL': '/var/mail/cltbld', 17:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:52 INFO - 'MOZ_NO_REMOTE': '1', 17:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:52 INFO - 'NO_EM_RESTART': '1', 17:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:52 INFO - 'PWD': '/builds/slave/test', 17:55:52 INFO - 'SHELL': '/bin/bash', 17:55:52 INFO - 'SHLVL': '1', 17:55:52 INFO - 'TERM': 'linux', 17:55:52 INFO - 'TMOUT': '86400', 17:55:52 INFO - 'USER': 'cltbld', 17:55:52 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:52 INFO - '_': '/tools/buildbot/bin/python'} 17:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:52 INFO - Downloading/unpacking psutil>=3.1.1 17:55:52 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 17:55:52 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 17:55:52 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 17:55:52 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 17:55:52 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 17:55:52 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 17:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:55:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:54 INFO - Installing collected packages: psutil 17:55:54 INFO - Running setup.py install for psutil 17:55:54 INFO - building 'psutil._psutil_linux' extension 17:55:54 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 17:55:54 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 17:55:54 INFO - building 'psutil._psutil_posix' extension 17:55:54 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 17:55:54 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 17:55:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:54 INFO - Successfully installed psutil 17:55:54 INFO - Cleaning up... 17:55:54 INFO - Return code: 0 17:55:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:55:54 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')]} 17:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:54 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')]} 17:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:54 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:55:54 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 17:55:54 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 17:55:54 INFO - Using env: {'DISPLAY': ':0', 17:55:54 INFO - 'HOME': '/home/cltbld', 17:55:54 INFO - 'LANG': 'en_US.UTF-8', 17:55:54 INFO - 'LANGUAGE': 'en_US:en', 17:55:54 INFO - 'LOGNAME': 'cltbld', 17:55:54 INFO - 'MAIL': '/var/mail/cltbld', 17:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:54 INFO - 'MOZ_NO_REMOTE': '1', 17:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:54 INFO - 'NO_EM_RESTART': '1', 17:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:54 INFO - 'PWD': '/builds/slave/test', 17:55:54 INFO - 'SHELL': '/bin/bash', 17:55:54 INFO - 'SHLVL': '1', 17:55:54 INFO - 'TERM': 'linux', 17:55:54 INFO - 'TMOUT': '86400', 17:55:54 INFO - 'USER': 'cltbld', 17:55:54 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:54 INFO - '_': '/tools/buildbot/bin/python'} 17:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:55:57 INFO - Installing collected packages: mozsystemmonitor 17:55:57 INFO - Running setup.py install for mozsystemmonitor 17:55:57 INFO - Successfully installed mozsystemmonitor 17:55:57 INFO - Cleaning up... 17:55:57 INFO - Return code: 0 17:55:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55: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')]} 17:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55: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', '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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:55: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:55: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 jsonschema==2.5.1 17:55:57 INFO - Using env: {'DISPLAY': ':0', 17:55:57 INFO - 'HOME': '/home/cltbld', 17:55:57 INFO - 'LANG': 'en_US.UTF-8', 17:55:57 INFO - 'LANGUAGE': 'en_US:en', 17:55:57 INFO - 'LOGNAME': 'cltbld', 17:55:57 INFO - 'MAIL': '/var/mail/cltbld', 17:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:57 INFO - 'MOZ_NO_REMOTE': '1', 17:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:57 INFO - 'NO_EM_RESTART': '1', 17:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:57 INFO - 'PWD': '/builds/slave/test', 17:55:57 INFO - 'SHELL': '/bin/bash', 17:55:57 INFO - 'SHLVL': '1', 17:55:57 INFO - 'TERM': 'linux', 17:55:57 INFO - 'TMOUT': '86400', 17:55:57 INFO - 'USER': 'cltbld', 17:55:57 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:57 INFO - '_': '/tools/buildbot/bin/python'} 17:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:57 INFO - Downloading/unpacking jsonschema==2.5.1 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:55:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:55:59 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 17:55:59 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 17:55:59 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 17:55:59 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 17:55:59 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 17:55:59 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 17:55:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:55:59 INFO - warning: no files found matching '*.txt' 17:55:59 INFO - no previously-included directories found matching 'build' 17:55:59 INFO - no previously-included directories found matching 'dist' 17:55:59 INFO - no previously-included directories found matching '.git*' 17:55:59 INFO - Installing collected packages: jsonschema, functools32 17:55:59 INFO - Running setup.py install for functools32 17:55:59 INFO - warning: no files found matching '*.txt' 17:55:59 INFO - no previously-included directories found matching 'build' 17:55:59 INFO - no previously-included directories found matching 'dist' 17:55:59 INFO - no previously-included directories found matching '.git*' 17:55:59 INFO - Successfully installed jsonschema functools32 17:55:59 INFO - Cleaning up... 17:56:00 INFO - Return code: 0 17:56:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:00 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:56:00 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 17:56:00 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 17:56:00 INFO - Using env: {'DISPLAY': ':0', 17:56:00 INFO - 'HOME': '/home/cltbld', 17:56:00 INFO - 'LANG': 'en_US.UTF-8', 17:56:00 INFO - 'LANGUAGE': 'en_US:en', 17:56:00 INFO - 'LOGNAME': 'cltbld', 17:56:00 INFO - 'MAIL': '/var/mail/cltbld', 17:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:00 INFO - 'MOZ_NO_REMOTE': '1', 17:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:00 INFO - 'NO_EM_RESTART': '1', 17:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:00 INFO - 'PWD': '/builds/slave/test', 17:56:00 INFO - 'SHELL': '/bin/bash', 17:56:00 INFO - 'SHLVL': '1', 17:56:00 INFO - 'TERM': 'linux', 17:56:00 INFO - 'TMOUT': '86400', 17:56:00 INFO - 'USER': 'cltbld', 17:56:00 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:00 INFO - '_': '/tools/buildbot/bin/python'} 17:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:56:00 INFO - Cleaning up... 17:56:00 INFO - Return code: 0 17:56:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:00 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:56:00 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 17:56:00 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 17:56:00 INFO - Using env: {'DISPLAY': ':0', 17:56:00 INFO - 'HOME': '/home/cltbld', 17:56:00 INFO - 'LANG': 'en_US.UTF-8', 17:56:00 INFO - 'LANGUAGE': 'en_US:en', 17:56:00 INFO - 'LOGNAME': 'cltbld', 17:56:00 INFO - 'MAIL': '/var/mail/cltbld', 17:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:00 INFO - 'MOZ_NO_REMOTE': '1', 17:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:00 INFO - 'NO_EM_RESTART': '1', 17:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:00 INFO - 'PWD': '/builds/slave/test', 17:56:00 INFO - 'SHELL': '/bin/bash', 17:56:00 INFO - 'SHLVL': '1', 17:56:00 INFO - 'TERM': 'linux', 17:56:00 INFO - 'TMOUT': '86400', 17:56:00 INFO - 'USER': 'cltbld', 17:56:00 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:00 INFO - '_': '/tools/buildbot/bin/python'} 17:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56:02 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56:03 INFO - Downloading docopt-0.6.1.tar.gz 17:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:03 INFO - Running setup.py install for blobuploader 17:56:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:03 INFO - Running setup.py install for requests 17:56:03 INFO - Running setup.py install for docopt 17:56:03 INFO - Successfully installed blobuploader requests docopt 17:56:03 INFO - Cleaning up... 17:56:03 INFO - Return code: 0 17:56:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:03 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')]} 17:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:03 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')]} 17:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:03 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:56:03 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 17:56:03 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 17:56:03 INFO - Using env: {'DISPLAY': ':0', 17:56:03 INFO - 'HOME': '/home/cltbld', 17:56:03 INFO - 'LANG': 'en_US.UTF-8', 17:56:03 INFO - 'LANGUAGE': 'en_US:en', 17:56:03 INFO - 'LOGNAME': 'cltbld', 17:56:03 INFO - 'MAIL': '/var/mail/cltbld', 17:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:03 INFO - 'MOZ_NO_REMOTE': '1', 17:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:03 INFO - 'NO_EM_RESTART': '1', 17:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:03 INFO - 'PWD': '/builds/slave/test', 17:56:03 INFO - 'SHELL': '/bin/bash', 17:56:03 INFO - 'SHLVL': '1', 17:56:03 INFO - 'TERM': 'linux', 17:56:03 INFO - 'TMOUT': '86400', 17:56:03 INFO - 'USER': 'cltbld', 17:56:03 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:03 INFO - '_': '/tools/buildbot/bin/python'} 17:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:04 INFO - Running setup.py (path:/tmp/pip-XG4wby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:04 INFO - Running setup.py (path:/tmp/pip-Uf4EOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:04 INFO - Running setup.py (path:/tmp/pip-4MJ7zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:04 INFO - Running setup.py (path:/tmp/pip-lZyNxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:04 INFO - Running setup.py (path:/tmp/pip-2MmJ7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:04 INFO - Running setup.py (path:/tmp/pip-Rm3F3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:04 INFO - Running setup.py (path:/tmp/pip-7mVLQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:04 INFO - Running setup.py (path:/tmp/pip-2WthIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:04 INFO - Running setup.py (path:/tmp/pip-_0Kx8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:04 INFO - Running setup.py (path:/tmp/pip-mhkOfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:04 INFO - Running setup.py (path:/tmp/pip-cNSDJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:04 INFO - Running setup.py (path:/tmp/pip-CJ89Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:04 INFO - Running setup.py (path:/tmp/pip-njQLKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:05 INFO - Running setup.py (path:/tmp/pip-9SQEAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:05 INFO - Running setup.py (path:/tmp/pip-ZRG853-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:05 INFO - Running setup.py (path:/tmp/pip-mllB32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:05 INFO - Running setup.py (path:/tmp/pip-c3Naud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:05 INFO - Running setup.py install for manifestparser 17:56:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:05 INFO - Running setup.py install for mozcrash 17:56:05 INFO - Running setup.py install for mozdebug 17:56:05 INFO - Running setup.py install for mozdevice 17:56:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:56:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:05 INFO - Running setup.py install for mozfile 17:56:05 INFO - Running setup.py install for mozhttpd 17:56:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:56:05 INFO - Running setup.py install for mozinfo 17:56:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Running setup.py install for mozInstall 17:56:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Running setup.py install for mozleak 17:56:06 INFO - Running setup.py install for mozlog 17:56:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Running setup.py install for moznetwork 17:56:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Running setup.py install for mozprocess 17:56:06 INFO - Running setup.py install for mozprofile 17:56:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Running setup.py install for mozrunner 17:56:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:56:06 INFO - Running setup.py install for mozscreenshot 17:56:06 INFO - Running setup.py install for moztest 17:56:07 INFO - Running setup.py install for mozversion 17:56:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:56:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:56:07 INFO - Cleaning up... 17:56:07 INFO - Return code: 0 17:56:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:07 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')]} 17:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:07 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')]} 17:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:07 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:56:07 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 17:56:07 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 17:56:07 INFO - Using env: {'DISPLAY': ':0', 17:56:07 INFO - 'HOME': '/home/cltbld', 17:56:07 INFO - 'LANG': 'en_US.UTF-8', 17:56:07 INFO - 'LANGUAGE': 'en_US:en', 17:56:07 INFO - 'LOGNAME': 'cltbld', 17:56:07 INFO - 'MAIL': '/var/mail/cltbld', 17:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:07 INFO - 'MOZ_NO_REMOTE': '1', 17:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:07 INFO - 'NO_EM_RESTART': '1', 17:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:07 INFO - 'PWD': '/builds/slave/test', 17:56:07 INFO - 'SHELL': '/bin/bash', 17:56:07 INFO - 'SHLVL': '1', 17:56:07 INFO - 'TERM': 'linux', 17:56:07 INFO - 'TMOUT': '86400', 17:56:07 INFO - 'USER': 'cltbld', 17:56:07 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:07 INFO - '_': '/tools/buildbot/bin/python'} 17:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:07 INFO - Running setup.py (path:/tmp/pip-lVqWWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:07 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)) 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:07 INFO - Running setup.py (path:/tmp/pip-QkGYHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:07 INFO - Running setup.py (path:/tmp/pip-5afHBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:07 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)) 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:07 INFO - Running setup.py (path:/tmp/pip-jI_n8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:07 INFO - Running setup.py (path:/tmp/pip-A3F0X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:07 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)) 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:07 INFO - Running setup.py (path:/tmp/pip-5pL1vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:07 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)) 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:07 INFO - Running setup.py (path:/tmp/pip-ugcVsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:07 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)) 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:07 INFO - Running setup.py (path:/tmp/pip-Mz5oSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:07 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)) 17:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:07 INFO - Running setup.py (path:/tmp/pip-VCEjr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:08 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)) 17:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:08 INFO - Running setup.py (path:/tmp/pip-SCwueR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:08 INFO - Running setup.py (path:/tmp/pip-ly2W0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:08 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)) 17:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:08 INFO - Running setup.py (path:/tmp/pip-CiNFi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:08 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)) 17:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:08 INFO - Running setup.py (path:/tmp/pip-BYemyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:08 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)) 17:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:08 INFO - Running setup.py (path:/tmp/pip-I1uC7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:08 INFO - Running setup.py (path:/tmp/pip-S9azAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:08 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)) 17:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:08 INFO - Running setup.py (path:/tmp/pip-fTPwnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:08 INFO - Running setup.py (path:/tmp/pip-eGbKOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:08 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)) 17:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:56:08 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)) 17:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:56:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:08 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 17:56:08 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 17:56:08 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 17:56:08 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 17:56:08 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 17:56:08 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 17:56:10 INFO - Downloading blessings-1.6.tar.gz 17:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:10 INFO - Installing collected packages: blessings 17:56:10 INFO - Running setup.py install for blessings 17:56:10 INFO - Successfully installed blessings 17:56:10 INFO - Cleaning up... 17:56:10 INFO - Return code: 0 17:56:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:11 INFO - Reading from file tmpfile_stdout 17:56:11 INFO - Current package versions: 17:56:11 INFO - argparse == 1.2.1 17:56:11 INFO - blessings == 1.6 17:56:11 INFO - blobuploader == 1.2.4 17:56:11 INFO - docopt == 0.6.1 17:56:11 INFO - functools32 == 3.2.3-2 17:56:11 INFO - jsonschema == 2.5.1 17:56:11 INFO - manifestparser == 1.1 17:56:11 INFO - mozInstall == 1.12 17:56:11 INFO - mozcrash == 1.0 17:56:11 INFO - mozdebug == 0.1 17:56:11 INFO - mozdevice == 0.49 17:56:11 INFO - mozfile == 1.2 17:56:11 INFO - mozhttpd == 0.7 17:56:11 INFO - mozinfo == 0.9 17:56:11 INFO - mozleak == 0.1 17:56:11 INFO - mozlog == 3.4 17:56:11 INFO - moznetwork == 0.27 17:56:11 INFO - mozprocess == 0.23 17:56:11 INFO - mozprofile == 0.28 17:56:11 INFO - mozrunner == 6.13 17:56:11 INFO - mozscreenshot == 0.1 17:56:11 INFO - mozsystemmonitor == 0.3 17:56:11 INFO - moztest == 0.8 17:56:11 INFO - mozversion == 1.4 17:56:11 INFO - psutil == 3.1.1 17:56:11 INFO - requests == 1.2.3 17:56:11 INFO - wsgiref == 0.1.2 17:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:11 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:56:11 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 17:56:11 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 17:56:11 INFO - Using env: {'DISPLAY': ':0', 17:56:11 INFO - 'HOME': '/home/cltbld', 17:56:11 INFO - 'LANG': 'en_US.UTF-8', 17:56:11 INFO - 'LANGUAGE': 'en_US:en', 17:56:11 INFO - 'LOGNAME': 'cltbld', 17:56:11 INFO - 'MAIL': '/var/mail/cltbld', 17:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:11 INFO - 'MOZ_NO_REMOTE': '1', 17:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:11 INFO - 'NO_EM_RESTART': '1', 17:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:11 INFO - 'PWD': '/builds/slave/test', 17:56:11 INFO - 'SHELL': '/bin/bash', 17:56:11 INFO - 'SHLVL': '1', 17:56:11 INFO - 'TERM': 'linux', 17:56:11 INFO - 'TMOUT': '86400', 17:56:11 INFO - 'USER': 'cltbld', 17:56:11 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:11 INFO - '_': '/tools/buildbot/bin/python'} 17:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 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)) 17:56:11 INFO - Cleaning up... 17:56:11 INFO - Return code: 0 17:56:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:11 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1983480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', '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 17:56:11 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 17:56:11 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 17:56:11 INFO - Using env: {'DISPLAY': ':0', 17:56:11 INFO - 'HOME': '/home/cltbld', 17:56:11 INFO - 'LANG': 'en_US.UTF-8', 17:56:11 INFO - 'LANGUAGE': 'en_US:en', 17:56:11 INFO - 'LOGNAME': 'cltbld', 17:56:11 INFO - 'MAIL': '/var/mail/cltbld', 17:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:11 INFO - 'MOZ_NO_REMOTE': '1', 17:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:11 INFO - 'NO_EM_RESTART': '1', 17:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:11 INFO - 'PWD': '/builds/slave/test', 17:56:11 INFO - 'SHELL': '/bin/bash', 17:56:11 INFO - 'SHLVL': '1', 17:56:11 INFO - 'TERM': 'linux', 17:56:11 INFO - 'TMOUT': '86400', 17:56:11 INFO - 'USER': 'cltbld', 17:56:11 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:11 INFO - '_': '/tools/buildbot/bin/python'} 17:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:56:11 INFO - Cleaning up... 17:56:11 INFO - Return code: 0 17:56:11 INFO - Running post-action listener: _resource_record_post_action 17:56:11 INFO - Running post-action listener: _start_resource_monitoring 17:56:11 INFO - Starting resource monitoring. 17:56:11 INFO - [mozharness: 2017-01-06 01:56:11.588364Z] Finished create-virtualenv step (success) 17:56:11 INFO - [mozharness: 2017-01-06 01:56:11.588861Z] Running install step. 17:56:11 INFO - Running pre-action listener: _resource_record_pre_action 17:56:11 INFO - Running main action method: install 17:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:11 INFO - Reading from file tmpfile_stdout 17:56:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:11 INFO - Reading from file tmpfile_stdout 17:56:11 INFO - Output received: 17:56:11 INFO - Usage: mozinstall [options] installer 17:56:11 INFO - Options: 17:56:11 INFO - -h, --help show this help message and exit 17:56:11 INFO - -d DEST, --destination=DEST 17:56:11 INFO - Directory to install application into. [default: 17:56:11 INFO - "/builds/slave/test"] 17:56:11 INFO - --app=APP Application being installed. [default: firefox] 17:56:11 INFO - mkdir: /builds/slave/test/build/application 17:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:56:27 INFO - Reading from file tmpfile_stdout 17:56:27 INFO - Output received: 17:56:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:56:27 INFO - Running post-action listener: _resource_record_post_action 17:56:27 INFO - [mozharness: 2017-01-06 01:56:27.962453Z] Finished install step (success) 17:56:27 INFO - [mozharness: 2017-01-06 01:56:27.962729Z] Running run-tests step. 17:56:27 INFO - Running pre-action listener: _resource_record_pre_action 17:56:27 INFO - Running main action method: run_tests 17:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:56:27 INFO - Python 2.7.3 17:56:27 INFO - Return code: 0 17:56:27 INFO - grabbing minidump binary from tooltool 17:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:27 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 0x1980820>, '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 0x1981520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19819b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:56:27 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 17:56:27 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 17:56:27 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 17:56:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:56:28 INFO - Return code: 0 17:56:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:56:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:56:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:56:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:56:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:56:28 INFO - Using env: {'DISPLAY': ':0', 17:56:28 INFO - 'HOME': '/home/cltbld', 17:56:28 INFO - 'LANG': 'en_US.UTF-8', 17:56:28 INFO - 'LANGUAGE': 'en_US:en', 17:56:28 INFO - 'LOGNAME': 'cltbld', 17:56:28 INFO - 'MAIL': '/var/mail/cltbld', 17:56:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:28 INFO - 'MOZ_NO_REMOTE': '1', 17:56:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:28 INFO - 'NO_EM_RESTART': '1', 17:56:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:28 INFO - 'PWD': '/builds/slave/test', 17:56:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:28 INFO - 'SHELL': '/bin/bash', 17:56:28 INFO - 'SHLVL': '1', 17:56:28 INFO - 'TERM': 'linux', 17:56:28 INFO - 'TMOUT': '86400', 17:56:28 INFO - 'USER': 'cltbld', 17:56:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792', 17:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:28 INFO - '_': '/tools/buildbot/bin/python'} 17:56:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:56:28 INFO - mozversion application_buildid: 20170106012421 17:56:28 INFO - mozversion application_changeset: 53193729a50b40c00889b1fa07df8dffab7781f9 17:56:28 INFO - mozversion application_display_name: Nightly 17:56:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:56:28 INFO - mozversion application_name: Firefox 17:56:28 INFO - mozversion application_remotingname: firefox 17:56:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:56:28 INFO - mozversion application_vendor: Mozilla 17:56:28 INFO - mozversion application_version: 53.0a1 17:56:28 INFO - mozversion platform_buildid: 20170106012421 17:56:28 INFO - mozversion platform_changeset: 53193729a50b40c00889b1fa07df8dffab7781f9 17:56:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:56:28 INFO - mozversion platform_version: 53.0a1 17:56:28 INFO - using testdate: 1483667788 17:56:28 INFO - actual date: 1483667788 17:56:28 INFO - starting webserver on 'localhost:58479' 17:56:28 INFO - SUITE-START | Running 2 tests 17:56:28 INFO - TEST-START | dromaeo_css 17:56:28 INFO - operating with platform_type : linux_ 17:56:28 INFO - Initialising browser for dromaeo_css test... 17:56:28 INFO - TEST-INFO | started process 11188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY8Bclb/profile http://localhost:58479/getInfo.html) 17:56:28 INFO - PROCESS | 11188 | 1483667788760 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 17:56:32 INFO - PROCESS | 11188 | __metrics Screen width/height:1600/1200 17:56:32 INFO - PROCESS | 11188 | colorDepth:24 17:56:32 INFO - PROCESS | 11188 | Browser inner width/height: 1024/697 17:56:32 INFO - PROCESS | 11188 | __metrics 17:56:33 ERROR - PROCESS | 11188 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 17:56:34 INFO - TEST-INFO | 11188: exit 0 17:56:34 INFO - Browser initialized. 17:56:34 INFO - Running cycle 1/1 for dromaeo_css test... 17:56:34 INFO - TEST-INFO | started process 11308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY8Bclb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:46 INFO - PROCESS | 11308 | RSS: Main: 158470144 17:56:46 INFO - PROCESS | 11308 | 17:59:50 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:58479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58479/tests/dromaeo/cssquery-ext.html) 17:59:51 INFO - PROCESS | 11308 | RSS: Main: 174596096 17:59:51 INFO - PROCESS | 11308 | 18:01:35 INFO - PROCESS | 11308 | ************************* 18:01:35 INFO - PROCESS | 11308 | A coding exception was thrown and uncaught in a Task. 18:01:35 INFO - PROCESS | 11308 | 18:01:35 INFO - PROCESS | 11308 | Full message: ReferenceError: fetch is not defined 18:01:35 INFO - PROCESS | 11308 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 18:01:35 INFO - PROCESS | 11308 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 18:01:35 INFO - PROCESS | 11308 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 18:01:35 INFO - PROCESS | 11308 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 18:01:35 INFO - PROCESS | 11308 | TaskImpl@resource://gre/modules/Task.jsm:277:3 18:01:35 INFO - PROCESS | 11308 | asyncFunction@resource://gre/modules/Task.jsm:252:14 18:01:35 INFO - PROCESS | 11308 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 18:01:35 INFO - PROCESS | 11308 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 18:01:35 INFO - PROCESS | 11308 | TaskImpl@resource://gre/modules/Task.jsm:277:3 18:01:35 INFO - PROCESS | 11308 | asyncFunction@resource://gre/modules/Task.jsm:252:14 18:01:35 INFO - PROCESS | 11308 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 18:01:35 INFO - PROCESS | 11308 | 18:01:35 INFO - PROCESS | 11308 | ************************* 18:02:54 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:58479/tests/dromaeo/cssquery-ext.html (next: http://localhost:58479/tests/dromaeo/cssquery-jquery.html) 18:02:54 INFO - PROCESS | 11308 | RSS: Main: 163119104 18:02:54 INFO - PROCESS | 11308 | 18:05:57 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:58479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58479/tests/dromaeo/cssquery-mootools.html) 18:05:57 INFO - PROCESS | 11308 | RSS: Main: 168620032 18:05:57 INFO - PROCESS | 11308 | 18:08:59 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:58479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58479/tests/dromaeo/cssquery-prototype.html) 18:09:00 INFO - PROCESS | 11308 | RSS: Main: 163979264 18:09:00 INFO - PROCESS | 11308 | 18:12:03 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:58479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58479/tests/dromaeo/cssquery-yui.html) 18:12:04 INFO - PROCESS | 11308 | RSS: Main: 167043072 18:12:04 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:58479/tests/dromaeo/cssquery-yui.html (next: http://localhost:58479/tests/dromaeo/cssquery-dojo.html) 18:15:07 INFO - PROCESS | 11308 | RSS: Main: 167763968 18:15:07 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | __start_tp_report 18:15:07 INFO - PROCESS | 11308 | _x_x_mozilla_page_load 18:15:07 INFO - PROCESS | 11308 | _x_x_mozilla_page_load_details 18:15:07 INFO - PROCESS | 11308 | |i|pagename|runs| 18:15:07 INFO - PROCESS | 11308 | |0;dojo.html;2591.403977085269;2598.2854714953387;2607.595822647489;2630.7895368370528;2636.657234559508;4733.431988161426;4788.640851936106;4819.8795030124265;4827.56551910328;4836.613070954324;4763.642726795487;4802.83190088347;4807.062622788558;4852.417709874811;4900.583450406711;4389.978050109753;4426.62373698236;4426.955730442686;4469.307257375112;4531.9546804531865;4069.409935559342;4495.483019452756;4498.257787465064;4516.07420478801;4547.7953492092765;4307.138572285556;4445.422095127645;4459.509453960061;4488.8877778055485;4561.315802629615;4335.436393268855;4395.099004704028;4400.493943196541;4409.691321607489;4410.3825464435;4344.066025804467;4351.521332653406;4366.345048242757;4391.341298805173;4439.245328294198;4782.784774685148;4796.040791841646;4809.567138957511;4809.879753006203;4849.369581954358;5179.896402071975;5194.220866869962;5203;5208.765605547759;5235.267062611238;4874.195757699975;4911.238757992517;5137.178051511778;5144.022635699205;5187.247849061902;4867.659263851497;4871.610271178297;4880.585150262196;4901.730404827733;4915.3855768029;5318;5327.413984461706;5342.2253773202665;5342.839714808562;5383.515483606494;4945.184044632595;4973;5008.724520151427;5070.594352451869;5121.513456221653;5011.248312753043;5074.2895994560795;5126.8974620508125;5201.609879258995;5202.271681964528;4973.154563724175;5065.670731402447;5097.08252514551;5119.10415677255;5130.179171332644;5139.871503212375;5141.948580514222;5144.948550514522;5150.819721309736;5201.427842937273;4310.870673879788;4354.9782251088545;4355.259605867011;4356.956430435655;4425.601695847389;3772.5284339457567;3790.6019867914024;3800.9239815204096;3832.770033797981;3835;4457.041736026705;4458.910821783546;4465.218586747306;4469.865904022885;4483.887902802456;5049.469805670426;5077;5098.235264710249;5201.115810312256;5234.633575649744;4457.8439754608435;4467.084247729208;4471.575200355961;4520.073384956077;4522.819087236474;4639.628829693616;4643.6517261205545;4652.209124448852;4667;4704.9059018819435;4710.364100846342;4736.526347365236;4828.565429111397;4845.345878306383;4855.684380515397;5144.228365745168;5189.974050129726;5193.298904647824;5235.607329450383;5293.735313234246;4851.078295123915;4857.247126695368;4864.708117512961;4877.561019508261;4910.435299940553;4888.2911977762315;5113.41195762492;5138.717370544656;5144.048351055067;5153.896922061613;4992.201247800334;5075.365579302587;5101.0308041472;5114.71869047206;5229.869253268699;5003.224500202475;5018.197088465828;5024.698518088926;5026.648134630687;5065.037642847848;4888.584470320063;4923.803047878188;4951.72765497901;4971;5033.899322013466;4885.755712214446;4991.126552853309;4996.675216110941;4997.350344455198;5045.571126454292;5091.236314552847;5101.158308878993;5117;5131.127708289525;5147.6654017488745;4850.733209673361;4888.193448081027;4942.3080768693135;4986.775595098302;4992.301077849177 18:15:07 INFO - PROCESS | 11308 | |1;ext.html;534.3854567247666;548.9368722596903;553.0625589625583;564.3735453646453;564.6612032780332;38993.415098773505;40542.79728601356;40631;44225.55774442255;44350.778246108726;42386;43210.78394608023;43238.35142472865;43328.3500747489;43363.78318108405;7648.082230132378;7672.309492145706;7848;7848.607569621525;7872.448928575002;9962.103410693036;10268.486575671224;10292.433916134609;10544.630937917174;10560.577576896914;10139.543720532594;10236.334638248527;10249.33379330341;10252.589896404135;10302.845457318146;9850.50747462624;9882.90117098827;9951.55218015191;9956.352837065568;9971.900280997243;10067.093961543496;10109.443980581065;10114.241431892637;10115;10115.645952391631;38772.41841372382;38861.611383886084;38970.610293896985;39005.21989560221;39022.804885975675;3547.0872841115242;3720.069982504374;3722.9441558376648;3753.5683396409217;3764.4729737836724;28988.855055724798;29018.41963160746;29680.554791678143;29703.40593188124;29834.254143646584;3279.114639047468;3294.769366144371;3397.6432474590306;3401.523786669868;3405.4551271796395;244768;247769;248210;248460;249163.9999999982;53117.7344113277;53173.73413132987;53338;53394.73302633462;53669.46330536723;56424;56514;56590.7170464145;56639;56672;12876.098673092794;13406.195628262336;13487.865121348857;13547.932260338635;13627.182369057888;9164.679236226833;9471.384360016576;10623.415712135908;10900.236983411243;11116.110711143088;15391.461298854487;15406;15420.383184672712;15485.458008969857;15563.844361556467;5979.880402391927;6213.161223234896;6230.95292812823;6259.18630578031;6264.624122552661;789.6643926331286;812.2283830361181;836.958152092393;842.1452225990624;843.1147295339991;26386.86806565993;27935.161945141677;28376.43247135087;28473.430531389255;28648.85675571609;985.5466485416789;985.6648739428485;987.1263931420601;989.3717489394287;1107.7618312062946;14296.714065718836;15187.316570754343;15235.16206608625;15298;15382.230888455533;339133;343048;343280;344423;344511;50376.748116259914;50382.49617503778;50640.49359506358;50698;50789.74605126951;1205.5599706107207;1223.1315765806378;1245.9439325230387;1253.642711827143;1255.3597665190819;26065.218043458728;26970.32574185661;27596.172114836587;27632.861835691496;27800.58299125474;42617;42875.068112399305;43115.56884431116;43146.784266078466;43218.56781432145;280086;281543;282039;282315;282340;23936.162234321717;24336.756632433448;24521.509569808146;24628.50742985166;35925.64074359223;35370.46944295889;35794.463083054296;35938;36179.63820361868;36566.63433365632;31873.68126318707;31978.081315121166;31995.840020799747;32238.19404514906;32324.83837580797;31127.221819454695;31741.8412907934;31869.8406507966;32027.519587206676;32556.88380255276;30864.37034444851;31165;31192.394585840924;31289.687103128676;31739.365212695157;25927.870360648078;26700.866495667397;28874.42251155007;28901.56647650245;29635;22228.777712222673;22539.66190507111;22702.772972270064;22774.88612556993;22968.885155574117 18:15:07 INFO - PROCESS | 11308 | |2;jquery.html;352.71782573940857;364.23510627681867;369.5270054330457;370.1246551904746;383.7659027992926;16970.66058678827;18213.635727285462;18817.943271273274;18863.15115819788;18967.90516047418;17799.911000445012;17994.370197043107;18118.27526898926;18253.361132360336;18379.98910059946;5010.248462730583;5163.7418129093585;5185.688858668473;5196.350456192976;5207.218917162418;4877.951220487803;4955.603551715854;4985.302057711923;4990.6257030722845;5040.420351659551;4953.826616068438;4959.107360675077;4960.900781984358;4977.925331120036;4977.975110124463;4933.531314525132;4961.925571116436;5233.816816411408;5465.781368745245;5503.477169668875;5344.4922732340365;5378.058839703075;5384.057789886793;5397.919031214535;5402.540784033362;12753.489860405572;20512.076956536992;21178;21360.786392136037;21436.678449823266;1941.7572803399576;2018.535736780534;2061.2373421833868;2142.2287976328507;2187.1798075721604;8620.827583448296;9091.863622045674;9299.674511392137;9469.905300946972;9652.613895444174;1721.1308289313943;1742.2508321421783;1742.5643589102724;1768.1582922661623;1793.0944872839132;63952.680236598986;70669.99999999949;71780.28219717788;74993.62503187504;76408;8688.174623410892;8950.462972221687;9067.410618309788;9941.353812002197;10183.643572474928;13768.586942391745;13778.862211377958;13804.17174969505;13849.307534623229;13866.791998120036;6858.554193977376;7110.217876033632;7131.465140114512;7245.601491917995;7245.746398876014;6617.272100068989;6624.205095388585;6791.320867913268;6814.420774234147;6822.795316140524;4025.094353770437;4178.603032711888;4211.368294755811;4217.1144059747185;4318.762468064224;1668.341005302923;1704.7101992661278;1738.452387497934;1760.4718584424622;1767.5492749348834;824.8762685597209;839.1482645115213;839.8236370362171;857.7169534053872;867.111211008721;17022.319107235573;17318.567035823955;17405.265257279567;18455.53861153455;18681.626367472574;818.402566126719;821.6343727041528;827.4249396669258;847.8431490174338;861.1689719420789;9817.607295708092;10166.542505587266;10284;10324.328918620266;10333.896661033445;431111;434966;438056;442388;473118;87132;87177;88948;89679;90389;888.0808363343779;906.4878343735768;938.2681508423304;938.7324612485409;941.7268991992382;15397.384104635688;15464.768028479357;15619.921900390425;15932.283047262668;16084.517464476085;39114.60885391109;40218.59781402266;40358.596414035484;40658.59341406548;41190;55082.44917550773;55122.724386379414;57004.71497642485;57046.7147664259;58042.4195758037;7603.809904752426;7639.847203055797;7847.764567062997;7868.134505204309;7968.884356190254;12363.32001739913;12653.683657908627;12658.493660253487;12701.36493175319;12705.301208433255;10357.896421035995;10557.841632375674;10723.30298530593;11147;11271.661850144508;10447.111995480165;10593.788124237626;10757.838632420677;10827.24209305341;10830.51262693165;10089.848652270075;10831.837522437012;10938.070264027647;11051.392173430539;11062.280951738112;7646.579438130733;7701.499402538817;7884.645190966535;7915.525068495908;7940.682372705027;9928.652497162564;10681.786364272826;10771.299865508718;10978.890211097787;11244.325340479598 18:15:07 INFO - PROCESS | 11308 | |3;mootools.html;1336.21163513527;1344.8924086073114;1345.7375811716713;1347.1916849890074;1347.818044563984;6137.079438084278;6418.293987661354;6588.209414870216;6949.478789090819;6976.790696279113;6764.661766911647;6929.0645762822005;6991.860162796741;7127.536710113852;7169.749058782943;2010.808973147556;2052.5997430501056;2054.1680619349186;2057;2058.7941205879365;1974.684050551912;2011.3161525081468;2018.4852862520038;2063.7213976113185;2074.1495986645477;2079.9080482746604;2105.473631592102;2107.3151225851584;2110.4488201172126;2118.692789545515;2036.216056818121;2048.0374224114644;2053.58928214357;2063.5769667218183;2066.4833791552114;2008.8493362997833;2040.2145174107927;2040.9795902040937;2062.123597471069;2067.514134178467;6933.37599616037;7098.183708873494;7101.6449177541435;7108.857822843566;7151.320624540713;4303.65570754342;4389.934150987738;4418.5802348776815;4421.248387774086;4423.004823914625;2636.5386057440064;2788.776897848167;2828.632277803893;2838.3046153692476;2849.871755770995;958.4536814016013;966.294604938399;989.3865803202061;1080.1628737728324;1101.7576133250673;8932;9025.277977761763;9106.81786364269;9135.954320228422;9164.816703665889;3643.836027378721;3653.926921461556;3729.370793590512;3798.2213646202463;3801.3917773156163;7400.888986665204;7420.962895185489;7426.925730742623;7428.554286742705;7454.962725186448;4167.499900012018;4175.749455032707;4211.578842115764;4221.7255878367805;4278.208531421635;3859.7684138951754;3891.416287556889;3921.8039098045556;3940.9802950985636;3971.0866500704424;3050.542418637178;3079.0608864296605;3111.4866047101973;3123.984380078085;3131.2798056447145;847.3941132090584;869.5478351257311;873.5282947208436;885.0441523154977;902.9413088149249;821.8602837517636;836.8577341851778;840.3235395506554;861.405630115231;863.8617821148586;4784.091022705675;4962.478939711351;5001.249812528077;5014.6991180529285;5079.746012699424;924.3760461688333;930.7068273493828;937.8686983822271;943.0804965158915;947.5124055233356;3279.7868138570916;3391.6438773928876;3395.2700169463683;3419.6409377015552;3469.0460123465746;8016.478928869605;8375.078741338448;8435.789105272295;8440.113788052166;8443.408961372645;8353.874691879626;8361.498310101291;8380.329573634095;8393.790155246168;8401.53791541471;6489.902651460232;6641.369069938348;6666.633335166613;6707.128073350434;6746.662666866637;4875.098106850244;4889.193283108248;4919.557239848431;4946.307516947702;4990.251462280687;7489.363404110712;7529.247075292646;7558.811029724081;7561;7577.886331704918;7195.6761945713615;7468.589227592534;7478.102627684712;7730.729424470116;7749.380049596131;6070.484008859296;6174.44430001302;6185.072239163981;6200.0699895016105;6203.906941395792;6718.126643536309;6736.629485378156;6746.291639377991;6782.389584937182;6791.524593278423;5634.436556344497;6119.785807496716;6167.352427994996;6250.906236406367;6286.748530058747;6142.385761423822;6146.600470969552;6178.938210617836;6182.165407669907;6207.906881396692;5435.891282174255;5501.669899806025;5531.561793933526;5541.501264886179;5552.666839989613;4186.832526698898;4207.97896010518;4293.119910418294;4295.22685916538;4377.781110944504;4364.192624364503;4380.8685739427865;4389.40742999691;4487.6761355399585;4501.932471012872 18:15:07 INFO - PROCESS | 11308 | |4;prototype.html;328.8668089423783;328.9013296011196;337.0024726808646;340.16659184996763;341.4434471810949;5075.974620126899;5086.880886205038;5088.847334579968;5108.974455127719;5110.872228194297;5005.274235235888;5006.399232092145;5012.498750124985;5024;5036.3452751142395;3763.5671897731836;3860.961390386088;3863.4011728182177;3913.2956067907767;3927.725059245854;3932.7836968966694;3933.174033452964;3938.6849052075763;3941.4481972523868;3983.1237127831973;3896.6298201670797;3898.3177943859855;3899.259140763246;3902.400015993443;3914.2171565686835;3627.8776915504463;3789.2232092420986;3930.8034598269974;3937.7637341759587;3953.1303113315166;3308.751843611739;3321.4353559894876;3327.1183136468853;3333.633300336961;3350.430426827445;4829.1790395632825;4857.757112144414;4870.196417591093;4874.878128046792;4884.169691152512;4327;4337.566243375669;4375.32182511708;4378.8905277368;4389.648828093745;5021.543752311825;5185.922211166836;5195.558377537914;5197.58419326453;5207.843764687065;3636.690881275095;3643.0892276930767;3645.2527231917393;3657.7256705747177;3659.2864391443677;5430.185472179165;5444.3194600674915;5465.234867118606;5498.422665620093;5507.201455788888;3594.2991116731987;3656.305301992613;3674.2651469706166;3700.3524383232825;3703.6296370362747;3703.4815125882396;3720.330340538675;3721.0511319613865;3732.2722069196248;3741.6258374162912;4315.568443155722;4323.156984388014;4329.718568293051;4348.673849461303;4361.978190109029;5140.228965655182;5247.868803279948;5276.15581506957;5286;5287.867803304948;1258.2261908926127;1261.199138547011;1263.5072321794507;1274.7450509897872;1281.1992504684572;832.7793134819278;862.3532350736947;869.7347309070794;874.3966663002508;874.7463235661714;4561.429821272341;4604.7927843247135;4629.490756016836;4629.745364005012;4643.349931009661;5393.568514518829;5402.8919421611345;5414.133738601805;5425.077736784756;5439.564834813205;4537.954620453819;4639.582437580634;4649.325847752057;4650.279206722963;4652;2767.8477683727588;2768.7231276872553;2785.749282564579;2800.5799130130235;2805.2846524136216;4874.46380898101;4886.633502487328;4888.633352498577;4892.45887545422;4916.975415122973;5207.6875387476875;5370.4629537045985;5376.758045887945;5397.7571009304675;5407.188921661782;4801.471838097877;4824.855254342376;4877.195262781673;4892.535209155125;4897.804087836518;5227.712475813867;5230.476952304739;5256.423073077985;5259.344031264187;5275.920861187162;5019.372578427697;5058.6206034548295;5074.695518268915;5161.922571161361;5203.973980130075;4828.899428748506;4868.829590964441;4879.878003049952;4886.096072226507;4899.706017638953;3635;3671.944920826243;3675.3016926783826;3675.9081022974638;3676.28312479064;5101.642884998015;5243.895122097613;5263.526282634428;5293.602979776455;5308.893822123458;5061.506855477569;5075.492450754895;5087;5087.821926232564;5128.358955130609;5089.651242420836;5095.745212739274;5099.184130539096;5116.513931176532;5143;4805.615550756001;4978.502149784992;4999.300097986212;5001.449840517467;5067.822626208213;5139.8715032123;5165.121929272108;5176.637635365489;5266.683998960075;5269.42036376006;5160.432352441153;5163.734884953211;5169.7673604687125;5188.273641690091;5190.117679994485 18:15:07 INFO - PROCESS | 11308 | |5;yui.html;639.5427269502305;655.4690700532569;726.905502284703;740.9259074092591;765.1697907770069;12475.18911270768;12778.808317875239;12849.614511564645;12902.548410805624;12940.805887911678;12028.639140825768;12066.698332541691;12192.634220973363;12286.815697764518;12319.5072197112;801.3028665061405;810.1088802317433;816.1226681317578;816.4937738602046;817.060380562355;804.5172896262254;810.878368244765;811.1847593168857;815.0545367373848;816.1797393619404;847.3560094328324;851.9957400212991;852.1606217875387;852.4842470305468;853.2022558907411;844.9788755281137;845.8223773007676;847.2459511035183;848.5757121439281;849.290842146802;617.6386813713983;619.0528491408153;619.4301242856583;622.0389498225253;622.470899735226;11141.777164456747;11283.040941519981;11393.145514086476;11406.315621062762;11602.419879006016;10841.566337346576;11066.114710823114;11128.554857805679;11253;11356.558195248603;9383.108604682544;9461;9609.711708648681;9617.90382096177;9761.560729767107;3257.5765150530515;3265.4122257993554;3269.836508174582;3287.3425314936867;3323.7507186961075;59747.70126149385;60453.395466045215;60655.39344606586;60726;61409.385906140815;8052.115967974562;8242.876356854653;8389.119142490074;8409.873851892227;8466.74599762008;16353.91823040901;16364.018158910503;16488.67022659564;17131.571710707332;17765;6561.80314590563;6631.602103873686;6679.098321726602;6736.831579210461;6950.860982780316;3582.373084710165;3710.888673339804;3713.5729391119826;3716.7398282119993;3721.3673675474693;2953.926151846221;3028.227801910499;3041.2700951771417;3079.7382222511337;3081.9075427737203;535.3709391465013;536.8738346488572;537.5377175628956;537.9560636251709;550.0896017091719;614.2107392001257;629.7008920762693;645.8987426437913;646.12127506591;648.8248172993266;8059.879101813477;8317.875231871527;8427.241548260687;8601.22588966996;8659.870101948476;625.8497960489541;641.493220355923;644.7904431059831;645.1290757477368;648.9578177418452;3927.430522574211;4036.0918793271867;4110.424540564323;4125.814338354781;4175.770332631734;69519.65240173868;69934;72219;72232;73021.2697873025;61270.38729612736;61561;61845.69077154585;62420.37579624236;62784.68607656933;55218;55345.72327138419;55572.72213638906;58126.709366452895;59343.25253979671;7778.533288002738;7878.487898286593;8007.239312265326;8132.1867813218205;8571.914280857112;32327;34111.65888341184;35352.64647353494;35741.82129089442;37410.43884341791;47938;48473;49052.26421603608;49062.264066038326;50185.74907125441;10254.384736915808;10615.469226538797;10627.468626568487;10672.62645807393;10955.123590112613;12382.257064575793;12408.56570020045;12493.625191244277;12622.55821046259;12870.549530766753;11916.702082448008;12014.819777703517;12331.260124392566;12779.169353991962;12857.03572232105;10442.63450779219;10579.682609521727;10874.293170943864;10874.565017399533;11202.66392008241;11307.660770176908;11614;11874.46564904564;12330.506779729069;12346.13577049598;9416.387934784218;9551.474668893277;9837.360571562825;10050.296479246383;10228.437435941094;8440.915590844013;9093.40892841963;9391.624335026523;9481.620735170793;9625.085616866387 18:15:07 INFO - PROCESS | 11308 | __end_tp_report 18:15:07 INFO - PROCESS | 11308 | __start_cc_report 18:15:07 INFO - PROCESS | 11308 | _x_x_mozilla_cycle_collect,352 18:15:07 INFO - PROCESS | 11308 | __end_cc_report 18:15:07 INFO - PROCESS | 11308 | __startTimestamp1483668907400__endTimestamp 18:15:07 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | ------- Summary: start ------- 18:15:07 INFO - PROCESS | 11308 | Number of tests: 6 18:15:07 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | [#0] dojo.html Cycles:165 Average:4757.84 Median:4880.59 stddev:510.72 (10.5%) stddev-sans-first:483.18 18:15:07 INFO - PROCESS | 11308 | Values: 2591.4 2598.3 2607.6 2630.8 2636.7 4733.4 4788.6 4819.9 4827.6 4836.6 4763.6 4802.8 4807.1 4852.4 4900.6 4390.0 4426.6 4427.0 4469.3 4532.0 4069.4 4495.5 4498.3 4516.1 4547.8 4307.1 4445.4 4459.5 4488.9 4561.3 4335.4 4395.1 4400.5 4409.7 4410.4 4344.1 4351.5 4366.3 4391.3 4439.2 4782.8 4796.0 4809.6 4809.9 4849.4 5179.9 5194.2 5203.0 5208.8 5235.3 4874.2 4911.2 5137.2 5144.0 5187.2 4867.7 4871.6 4880.6 4901.7 4915.4 5318.0 5327.4 5342.2 5342.8 5383.5 4945.2 4973.0 5008.7 5070.6 5121.5 5011.2 5074.3 5126.9 5201.6 5202.3 4973.2 5065.7 5097.1 5119.1 5130.2 5139.9 5141.9 5144.9 5150.8 5201.4 4310.9 4355.0 4355.3 4357.0 4425.6 3772.5 3790.6 3800.9 3832.8 3835.0 4457.0 4458.9 4465.2 4469.9 4483.9 5049.5 5077.0 5098.2 5201.1 5234.6 4457.8 4467.1 4471.6 4520.1 4522.8 4639.6 4643.7 4652.2 4667.0 4704.9 4710.4 4736.5 4828.6 4845.3 4855.7 5144.2 5190.0 5193.3 5235.6 5293.7 4851.1 4857.2 4864.7 4877.6 4910.4 4888.3 5113.4 5138.7 5144.0 5153.9 4992.2 5075.4 5101.0 5114.7 5229.9 5003.2 5018.2 5024.7 5026.6 5065.0 4888.6 4923.8 4951.7 4971.0 5033.9 4885.8 4991.1 4996.7 4997.4 5045.6 5091.2 5101.2 5117.0 5131.1 5147.7 4850.7 4888.2 4942.3 4986.8 4992.3 18:15:07 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | [#1] ext.html Cycles:180 Average:44777.88 Median:32440.86 stddev:76893.26 (237.0%) stddev-sans-first:77037.21 18:15:07 INFO - PROCESS | 11308 | Values: 534.4 548.9 553.1 564.4 564.7 38993.4 40542.8 40631.0 44225.6 44350.8 42386.0 43210.8 43238.4 43328.4 43363.8 7648.1 7672.3 7848.0 7848.6 7872.4 9962.1 10268.5 10292.4 10544.6 10560.6 10139.5 10236.3 10249.3 10252.6 10302.8 9850.5 9882.9 9951.6 9956.4 9971.9 10067.1 10109.4 10114.2 10115.0 10115.6 38772.4 38861.6 38970.6 39005.2 39022.8 3547.1 3720.1 3722.9 3753.6 3764.5 28988.9 29018.4 29680.6 29703.4 29834.3 3279.1 3294.8 3397.6 3401.5 3405.5 244768.0 247769.0 248210.0 248460.0 249164.0 53117.7 53173.7 53338.0 53394.7 53669.5 56424.0 56514.0 56590.7 56639.0 56672.0 12876.1 13406.2 13487.9 13547.9 13627.2 9164.7 9471.4 10623.4 10900.2 11116.1 15391.5 15406.0 15420.4 15485.5 15563.8 5979.9 6213.2 6231.0 6259.2 6264.6 789.7 812.2 837.0 842.1 843.1 26386.9 27935.2 28376.4 28473.4 28648.9 985.5 985.7 987.1 989.4 1107.8 14296.7 15187.3 15235.2 15298.0 15382.2 339133.0 343048.0 343280.0 344423.0 344511.0 50376.7 50382.5 50640.5 50698.0 50789.7 1205.6 1223.1 1245.9 1253.6 1255.4 26065.2 26970.3 27596.2 27632.9 27800.6 42617.0 42875.1 43115.6 43146.8 43218.6 280086.0 281543.0 282039.0 282315.0 282340.0 23936.2 24336.8 24521.5 24628.5 35925.6 35370.5 35794.5 35938.0 36179.6 36566.6 31873.7 31978.1 31995.8 32238.2 32324.8 31127.2 31741.8 31869.8 32027.5 32556.9 30864.4 31165.0 31192.4 31289.7 31739.4 25927.9 26700.9 28874.4 28901.6 29635.0 22228.8 22539.7 22702.8 22774.9 22968.9 18:15:07 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | [#2] jquery.html Cycles:180 Average:26566.89 Median:436511.00 stddev:73385.04 (16.8%) stddev-sans-first:73564.51 18:15:07 INFO - PROCESS | 11308 | Values: 352.7 364.2 369.5 370.1 383.8 16970.7 18213.6 18817.9 18863.2 18967.9 17799.9 17994.4 18118.3 18253.4 18380.0 5010.2 5163.7 5185.7 5196.4 5207.2 4878.0 4955.6 4985.3 4990.6 5040.4 4953.8 4959.1 4960.9 4977.9 4978.0 4933.5 4961.9 5233.8 5465.8 5503.5 5344.5 5378.1 5384.1 5397.9 5402.5 12753.5 20512.1 21178.0 21360.8 21436.7 1941.8 2018.5 2061.2 2142.2 2187.2 8620.8 9091.9 9299.7 9469.9 9652.6 1721.1 1742.3 1742.6 1768.2 1793.1 63952.7 70670.0 71780.3 74993.6 76408.0 8688.2 8950.5 9067.4 9941.4 10183.6 13768.6 13778.9 13804.2 13849.3 13866.8 6858.6 7110.2 7131.5 7245.6 7245.7 6617.3 6624.2 6791.3 6814.4 6822.8 4025.1 4178.6 4211.4 4217.1 4318.8 1668.3 1704.7 1738.5 1760.5 1767.5 824.9 839.1 839.8 857.7 867.1 17022.3 17318.6 17405.3 18455.5 18681.6 818.4 821.6 827.4 847.8 861.2 9817.6 10166.5 10284.0 10324.3 10333.9 431111.0 434966.0 438056.0 442388.0 473118.0 87132.0 87177.0 88948.0 89679.0 90389.0 888.1 906.5 938.3 938.7 941.7 15397.4 15464.8 15619.9 15932.3 16084.5 39114.6 40218.6 40358.6 40658.6 41190.0 55082.4 55122.7 57004.7 57046.7 58042.4 7603.8 7639.8 7847.8 7868.1 7968.9 12363.3 12653.7 12658.5 12701.4 12705.3 10357.9 10557.8 10723.3 11147.0 11271.7 10447.1 10593.8 10757.8 10827.2 10830.5 10089.8 10831.8 10938.1 11051.4 11062.3 7646.6 7701.5 7884.6 7915.5 7940.7 9928.7 10681.8 10771.3 10978.9 11244.3 18:15:07 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | [#3] mootools.html Cycles:180 Average:4603.77 Median:5547.08 stddev:2436.79 (43.9%) stddev-sans-first:2431.25 18:15:07 INFO - PROCESS | 11308 | Values: 1336.2 1344.9 1345.7 1347.2 1347.8 6137.1 6418.3 6588.2 6949.5 6976.8 6764.7 6929.1 6991.9 7127.5 7169.7 2010.8 2052.6 2054.2 2057.0 2058.8 1974.7 2011.3 2018.5 2063.7 2074.1 2079.9 2105.5 2107.3 2110.4 2118.7 2036.2 2048.0 2053.6 2063.6 2066.5 2008.8 2040.2 2041.0 2062.1 2067.5 6933.4 7098.2 7101.6 7108.9 7151.3 4303.7 4389.9 4418.6 4421.2 4423.0 2636.5 2788.8 2828.6 2838.3 2849.9 958.5 966.3 989.4 1080.2 1101.8 8932.0 9025.3 9106.8 9136.0 9164.8 3643.8 3653.9 3729.4 3798.2 3801.4 7400.9 7421.0 7426.9 7428.6 7455.0 4167.5 4175.7 4211.6 4221.7 4278.2 3859.8 3891.4 3921.8 3941.0 3971.1 3050.5 3079.1 3111.5 3124.0 3131.3 847.4 869.5 873.5 885.0 902.9 821.9 836.9 840.3 861.4 863.9 4784.1 4962.5 5001.2 5014.7 5079.7 924.4 930.7 937.9 943.1 947.5 3279.8 3391.6 3395.3 3419.6 3469.0 8016.5 8375.1 8435.8 8440.1 8443.4 8353.9 8361.5 8380.3 8393.8 8401.5 6489.9 6641.4 6666.6 6707.1 6746.7 4875.1 4889.2 4919.6 4946.3 4990.3 7489.4 7529.2 7558.8 7561.0 7577.9 7195.7 7468.6 7478.1 7730.7 7749.4 6070.5 6174.4 6185.1 6200.1 6203.9 6718.1 6736.6 6746.3 6782.4 6791.5 5634.4 6119.8 6167.4 6250.9 6286.7 6142.4 6146.6 6178.9 6182.2 6207.9 5435.9 5501.7 5531.6 5541.5 5552.7 4186.8 4208.0 4293.1 4295.2 4377.8 4364.2 4380.9 4389.4 4487.7 4501.9 18:15:07 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | [#4] prototype.html Cycles:180 Average:4282.44 Median:4878.54 stddev:1250.90 (25.6%) stddev-sans-first:1218.70 18:15:07 INFO - PROCESS | 11308 | Values: 328.9 328.9 337.0 340.2 341.4 5076.0 5086.9 5088.8 5109.0 5110.9 5005.3 5006.4 5012.5 5024.0 5036.3 3763.6 3861.0 3863.4 3913.3 3927.7 3932.8 3933.2 3938.7 3941.4 3983.1 3896.6 3898.3 3899.3 3902.4 3914.2 3627.9 3789.2 3930.8 3937.8 3953.1 3308.8 3321.4 3327.1 3333.6 3350.4 4829.2 4857.8 4870.2 4874.9 4884.2 4327.0 4337.6 4375.3 4378.9 4389.6 5021.5 5185.9 5195.6 5197.6 5207.8 3636.7 3643.1 3645.3 3657.7 3659.3 5430.2 5444.3 5465.2 5498.4 5507.2 3594.3 3656.3 3674.3 3700.4 3703.6 3703.5 3720.3 3721.1 3732.3 3741.6 4315.6 4323.2 4329.7 4348.7 4362.0 5140.2 5247.9 5276.2 5286.0 5287.9 1258.2 1261.2 1263.5 1274.7 1281.2 832.8 862.4 869.7 874.4 874.7 4561.4 4604.8 4629.5 4629.7 4643.3 5393.6 5402.9 5414.1 5425.1 5439.6 4538.0 4639.6 4649.3 4650.3 4652.0 2767.8 2768.7 2785.7 2800.6 2805.3 4874.5 4886.6 4888.6 4892.5 4917.0 5207.7 5370.5 5376.8 5397.8 5407.2 4801.5 4824.9 4877.2 4892.5 4897.8 5227.7 5230.5 5256.4 5259.3 5275.9 5019.4 5058.6 5074.7 5161.9 5204.0 4828.9 4868.8 4879.9 4886.1 4899.7 3635.0 3671.9 3675.3 3675.9 3676.3 5101.6 5243.9 5263.5 5293.6 5308.9 5061.5 5075.5 5087.0 5087.8 5128.4 5089.7 5095.7 5099.2 5116.5 5143.0 4805.6 4978.5 4999.3 5001.4 5067.8 5139.9 5165.1 5176.6 5266.7 5269.4 5160.4 5163.7 5169.8 5188.3 5190.1 18:15:07 INFO - PROCESS | 11308 | 18:15:07 INFO - PROCESS | 11308 | [#5] yui.html Cycles:180 Average:14938.73 Median:58734.98 stddev:19440.15 (33.1%) stddev-sans-first:19465.03 18:15:07 INFO - PROCESS | 11308 | Values: 639.5 655.5 726.9 740.9 765.2 12475.2 12778.8 12849.6 12902.5 12940.8 12028.6 12066.7 12192.6 12286.8 12319.5 801.3 810.1 816.1 816.5 817.1 804.5 810.9 811.2 815.1 816.2 847.4 852.0 852.2 852.5 853.2 845.0 845.8 847.2 848.6 849.3 617.6 619.1 619.4 622.0 622.5 11141.8 11283.0 11393.1 11406.3 11602.4 10841.6 11066.1 11128.6 11253.0 11356.6 9383.1 9461.0 9609.7 9617.9 9761.6 3257.6 3265.4 3269.8 3287.3 3323.8 59747.7 60453.4 60655.4 60726.0 61409.4 8052.1 8242.9 8389.1 8409.9 8466.7 16353.9 16364.0 16488.7 17131.6 17765.0 6561.8 6631.6 6679.1 6736.8 6950.9 3582.4 3710.9 3713.6 3716.7 3721.4 2953.9 3028.2 3041.3 3079.7 3081.9 535.4 536.9 537.5 538.0 550.1 614.2 629.7 645.9 646.1 648.8 8059.9 8317.9 8427.2 8601.2 8659.9 625.8 641.5 644.8 645.1 649.0 3927.4 4036.1 4110.4 4125.8 4175.8 69519.7 69934.0 72219.0 72232.0 73021.3 61270.4 61561.0 61845.7 62420.4 62784.7 55218.0 55345.7 55572.7 58126.7 59343.3 7778.5 7878.5 8007.2 8132.2 8571.9 32327.0 34111.7 35352.6 35741.8 37410.4 47938.0 48473.0 49052.3 49062.3 50185.7 10254.4 10615.5 10627.5 10672.6 10955.1 12382.3 12408.6 12493.6 12622.6 12870.5 11916.7 12014.8 12331.3 12779.2 12857.0 10442.6 10579.7 10874.3 10874.6 11202.7 11307.7 11614.0 11874.5 12330.5 12346.1 9416.4 9551.5 9837.4 10050.3 10228.4 8440.9 9093.4 9391.6 9481.6 9625.1 18:15:07 INFO - PROCESS | 11308 | -------- Summary: end -------- 18:15:07 INFO - PROCESS | 11308 | 18:15:08 INFO - TEST-INFO | 11308: exit 0 18:15:08 INFO - TEST-OK | dromaeo_css | took 1119940ms 18:15:08 INFO - TEST-START | kraken 18:15:08 INFO - operating with platform_type : linux_ 18:15:08 INFO - Initialising browser for kraken test... 18:15:08 INFO - TEST-INFO | started process 11650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TPLEI/profile http://localhost:58479/getInfo.html) 18:15:08 INFO - PROCESS | 11650 | 1483668908694 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 18:15:13 INFO - PROCESS | 11650 | __metrics Screen width/height:1600/1200 18:15:13 INFO - PROCESS | 11650 | colorDepth:24 18:15:13 INFO - PROCESS | 11650 | Browser inner width/height: 1024/697 18:15:13 INFO - PROCESS | 11650 | __metrics 18:15:13 ERROR - PROCESS | 11650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 18:15:14 INFO - TEST-INFO | 11650: exit 0 18:15:14 INFO - Browser initialized. 18:15:14 INFO - Running cycle 1/1 for kraken test... 18:15:14 INFO - TEST-INFO | started process 11772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TPLEI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:26 INFO - PROCESS | 11772 | RSS: Main: 158457856 18:15:26 INFO - PROCESS | 11772 | 18:15:29 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58479/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:30 INFO - PROCESS | 11772 | RSS: Main: 164319232 18:15:30 INFO - PROCESS | 11772 | 18:15:33 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58479/tests/kraken/driver.html?testName=audio-dft) 18:15:33 INFO - PROCESS | 11772 | RSS: Main: 163467264 18:15:33 INFO - PROCESS | 11772 | 18:15:36 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58479/tests/kraken/driver.html?testName=audio-fft) 18:15:37 INFO - PROCESS | 11772 | RSS: Main: 159596544 18:15:37 INFO - PROCESS | 11772 | 18:15:39 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58479/tests/kraken/driver.html?testName=audio-oscillator) 18:15:40 INFO - PROCESS | 11772 | RSS: Main: 160583680 18:15:40 INFO - PROCESS | 11772 | 18:15:42 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:15:42 INFO - PROCESS | 11772 | RSS: Main: 160645120 18:15:42 INFO - PROCESS | 11772 | 18:15:45 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58479/tests/kraken/driver.html?testName=imaging-darkroom) 18:15:46 INFO - PROCESS | 11772 | RSS: Main: 165355520 18:15:46 INFO - PROCESS | 11772 | 18:15:50 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58479/tests/kraken/driver.html?testName=imaging-desaturate) 18:15:50 INFO - PROCESS | 11772 | RSS: Main: 161656832 18:15:50 INFO - PROCESS | 11772 | 18:15:53 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58479/tests/kraken/driver.html?testName=json-parse-financial) 18:15:54 INFO - PROCESS | 11772 | RSS: Main: 162922496 18:15:54 INFO - PROCESS | 11772 | 18:15:56 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:15:56 INFO - PROCESS | 11772 | RSS: Main: 163438592 18:15:56 INFO - PROCESS | 11772 | 18:15:58 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58479/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:15:59 INFO - PROCESS | 11772 | RSS: Main: 163282944 18:15:59 INFO - PROCESS | 11772 | 18:16:01 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:02 INFO - PROCESS | 11772 | RSS: Main: 162934784 18:16:02 INFO - PROCESS | 11772 | 18:16:04 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:05 INFO - PROCESS | 11772 | RSS: Main: 163344384 18:16:05 INFO - PROCESS | 11772 | 18:16:08 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:09 INFO - PROCESS | 11772 | RSS: Main: 163561472 18:16:09 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | Cycle 1(1): loaded http://localhost:58479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58479/tests/kraken/driver.html?testName=ai-astar) 18:16:11 INFO - PROCESS | 11772 | RSS: Main: 165044224 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | __start_tp_report 18:16:11 INFO - PROCESS | 11772 | _x_x_mozilla_page_load 18:16:11 INFO - PROCESS | 11772 | _x_x_mozilla_page_load_details 18:16:11 INFO - PROCESS | 11772 | |i|pagename|runs| 18:16:11 INFO - PROCESS | 11772 | |0;ai-astar;108;116;115;115;114;115;114;115;115;115 18:16:11 INFO - PROCESS | 11772 | |1;audio-beat-detection;152;130;125;170;125;126;127;127;147;128 18:16:11 INFO - PROCESS | 11772 | |2;audio-dft;164;164;165;173;163;164;163;164;163;163 18:16:11 INFO - PROCESS | 11772 | |3;audio-fft;77;75;75;117;77;78;76;75;98;77 18:16:11 INFO - PROCESS | 11772 | |4;audio-oscillator;85;84;101;85;85;85;98;85;85;106 18:16:11 INFO - PROCESS | 11772 | |5;imaging-gaussian-blur;118;117;118;118;118;118;118;118;118;117 18:16:11 INFO - PROCESS | 11772 | |6;imaging-darkroom;151;151;152;151;150;150;150;151;150;150 18:16:11 INFO - PROCESS | 11772 | |7;imaging-desaturate;96;95;96;96;97;96;96;96;96;96 18:16:11 INFO - PROCESS | 11772 | |8;json-parse-financial;67;67;76;67;69;68;73;68;69;67 18:16:11 INFO - PROCESS | 11772 | |9;json-stringify-tinderbox;67;67;67;67;67;67;72;72;67;68 18:16:11 INFO - PROCESS | 11772 | |10;stanford-crypto-aes;85;84;85;85;84;85;85;89;91;85 18:16:11 INFO - PROCESS | 11772 | |11;stanford-crypto-ccm;148;143;132;134;143;134;153;135;185;141 18:16:11 INFO - PROCESS | 11772 | |12;stanford-crypto-pbkdf2;177;181;175;188;181;179;177;179;183;179 18:16:11 INFO - PROCESS | 11772 | |13;stanford-crypto-sha256-iterative;73;70;73;69;71;69;70;69;68;68 18:16:11 INFO - PROCESS | 11772 | __end_tp_report 18:16:11 INFO - PROCESS | 11772 | __start_cc_report 18:16:11 INFO - PROCESS | 11772 | _x_x_mozilla_cycle_collect,797 18:16:11 INFO - PROCESS | 11772 | __end_cc_report 18:16:11 INFO - PROCESS | 11772 | __startTimestamp1483668971391__endTimestamp 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | ------- Summary: start ------- 18:16:11 INFO - PROCESS | 11772 | Number of tests: 14 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:2.25 (2.0%) stddev-sans-first:0.60 18:16:11 INFO - PROCESS | 11772 | Values: 108.0 116.0 115.0 115.0 114.0 115.0 114.0 115.0 115.0 115.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:129.00 stddev:15.41 (11.9%) stddev-sans-first:15.17 18:16:11 INFO - PROCESS | 11772 | Values: 152.0 130.0 125.0 170.0 125.0 126.0 127.0 127.0 147.0 128.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.03 (1.8%) stddev-sans-first:3.20 18:16:11 INFO - PROCESS | 11772 | Values: 164.0 164.0 165.0 173.0 163.0 164.0 163.0 164.0 163.0 163.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.00 stddev:13.95 (18.1%) stddev-sans-first:14.66 18:16:11 INFO - PROCESS | 11772 | Values: 77.0 75.0 75.0 117.0 77.0 78.0 76.0 75.0 98.0 77.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:85.00 stddev:8.35 (9.8%) stddev-sans-first:8.66 18:16:11 INFO - PROCESS | 11772 | Values: 85.0 84.0 101.0 85.0 85.0 85.0 98.0 85.0 85.0 106.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:16:11 INFO - PROCESS | 11772 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 18:16:11 INFO - PROCESS | 11772 | Values: 151.0 151.0 152.0 151.0 150.0 150.0 150.0 151.0 150.0 150.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:16:11 INFO - PROCESS | 11772 | Values: 96.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:68.50 stddev:3.03 (4.4%) stddev-sans-first:3.12 18:16:11 INFO - PROCESS | 11772 | Values: 67.0 67.0 76.0 67.0 69.0 68.0 73.0 68.0 69.0 67.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:67.00 stddev:2.08 (3.1%) stddev-sans-first:2.17 18:16:11 INFO - PROCESS | 11772 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 72.0 72.0 67.0 68.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:2.30 (2.7%) stddev-sans-first:2.42 18:16:11 INFO - PROCESS | 11772 | Values: 85.0 84.0 85.0 85.0 84.0 85.0 85.0 89.0 91.0 85.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:143.00 stddev:15.66 (11.0%) stddev-sans-first:16.57 18:16:11 INFO - PROCESS | 11772 | Values: 148.0 143.0 132.0 134.0 143.0 134.0 153.0 135.0 185.0 141.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:180.00 stddev:3.67 (2.0%) stddev-sans-first:3.73 18:16:11 INFO - PROCESS | 11772 | Values: 177.0 181.0 175.0 188.0 181.0 179.0 177.0 179.0 183.0 179.0 18:16:11 INFO - PROCESS | 11772 | 18:16:11 INFO - PROCESS | 11772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.83 (2.6%) stddev-sans-first:1.58 18:16:11 INFO - PROCESS | 11772 | Values: 73.0 70.0 73.0 69.0 71.0 69.0 70.0 69.0 68.0 68.0 18:16:11 INFO - PROCESS | 11772 | -------- Summary: end -------- 18:16:11 INFO - PROCESS | 11772 | 18:16:12 INFO - TEST-INFO | 11772: exit 0 18:16:12 INFO - TEST-OK | kraken | took 64326ms 18:16:12 INFO - SUITE-END | took 1184s 18:16:12 INFO - Completed test suite (00:19:44) 18:16:12 INFO - javascript benchmark 18:16:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6315.341369283811, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.403977085269, 2598.2854714953387, 2607.595822647489, 2630.7895368370528, 2636.657234559508, 4733.431988161426, 4788.640851936106, 4819.8795030124265, 4827.56551910328, 4836.613070954324, 4763.642726795487, 4802.83190088347, 4807.062622788558, 4852.417709874811, 4900.583450406711, 4389.978050109753, 4426.62373698236, 4426.955730442686, 4469.307257375112, 4531.9546804531865, 4069.409935559342, 4495.483019452756, 4498.257787465064, 4516.07420478801, 4547.7953492092765, 4307.138572285556, 4445.422095127645, 4459.509453960061, 4488.8877778055485, 4561.315802629615, 4335.436393268855, 4395.099004704028, 4400.493943196541, 4409.691321607489, 4410.3825464435, 4344.066025804467, 4351.521332653406, 4366.345048242757, 4391.341298805173, 4439.245328294198, 4782.784774685148, 4796.040791841646, 4809.567138957511, 4809.879753006203, 4849.369581954358, 5179.896402071975, 5194.220866869962, 5203.0, 5208.765605547759, 5235.267062611238, 4874.195757699975, 4911.238757992517, 5137.178051511778, 5144.022635699205, 5187.247849061902, 4867.659263851497, 4871.610271178297, 4880.585150262196, 4901.730404827733, 4915.3855768029, 5318.0, 5327.413984461706, 5342.2253773202665, 5342.839714808562, 5383.515483606494, 4945.184044632595, 4973.0, 5008.724520151427, 5070.594352451869, 5121.513456221653, 5011.248312753043, 5074.2895994560795, 5126.8974620508125, 5201.609879258995, 5202.271681964528, 4973.154563724175, 5065.670731402447, 5097.08252514551, 5119.10415677255, 5130.179171332644, 5139.871503212375, 5141.948580514222, 5144.948550514522, 5150.819721309736, 5201.427842937273, 4310.870673879788, 4354.9782251088545, 4355.259605867011, 4356.956430435655, 4425.601695847389, 3772.5284339457567, 3790.6019867914024, 3800.9239815204096, 3832.770033797981, 3835.0, 4457.041736026705, 4458.910821783546, 4465.218586747306, 4469.865904022885, 4483.887902802456, 5049.469805670426, 5077.0, 5098.235264710249, 5201.115810312256, 5234.633575649744, 4457.8439754608435, 4467.084247729208, 4471.575200355961, 4520.073384956077, 4522.819087236474, 4639.628829693616, 4643.6517261205545, 4652.209124448852, 4667.0, 4704.9059018819435, 4710.364100846342, 4736.526347365236, 4828.565429111397, 4845.345878306383, 4855.684380515397, 5144.228365745168, 5189.974050129726, 5193.298904647824, 5235.607329450383, 5293.735313234246, 4851.078295123915, 4857.247126695368, 4864.708117512961, 4877.561019508261, 4910.435299940553, 4888.2911977762315, 5113.41195762492, 5138.717370544656, 5144.048351055067, 5153.896922061613, 4992.201247800334, 5075.365579302587, 5101.0308041472, 5114.71869047206, 5229.869253268699, 5003.224500202475, 5018.197088465828, 5024.698518088926, 5026.648134630687, 5065.037642847848, 4888.584470320063, 4923.803047878188, 4951.72765497901, 4971.0, 5033.899322013466, 4885.755712214446, 4991.126552853309, 4996.675216110941, 4997.350344455198, 5045.571126454292, 5091.236314552847, 5101.158308878993, 5117.0, 5131.127708289525, 5147.6654017488745, 4850.733209673361, 4888.193448081027, 4942.3080768693135, 4986.775595098302, 4992.301077849177], "value": 4724.0803634051945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.3854567247666, 548.9368722596903, 553.0625589625583, 564.3735453646453, 564.6612032780332, 38993.415098773505, 40542.79728601356, 40631.0, 44225.55774442255, 44350.778246108726, 42386.0, 43210.78394608023, 43238.35142472865, 43328.3500747489, 43363.78318108405, 7648.082230132378, 7672.309492145706, 7848.0, 7848.607569621525, 7872.448928575002, 9962.103410693036, 10268.486575671224, 10292.433916134609, 10544.630937917174, 10560.577576896914, 10139.543720532594, 10236.334638248527, 10249.33379330341, 10252.589896404135, 10302.845457318146, 9850.50747462624, 9882.90117098827, 9951.55218015191, 9956.352837065568, 9971.900280997243, 10067.093961543496, 10109.443980581065, 10114.241431892637, 10115.0, 10115.645952391631, 38772.41841372382, 38861.611383886084, 38970.610293896985, 39005.21989560221, 39022.804885975675, 3547.0872841115242, 3720.069982504374, 3722.9441558376648, 3753.5683396409217, 3764.4729737836724, 28988.855055724798, 29018.41963160746, 29680.554791678143, 29703.40593188124, 29834.254143646584, 3279.114639047468, 3294.769366144371, 3397.6432474590306, 3401.523786669868, 3405.4551271796395, 244768.0, 247769.0, 248210.0, 248460.0, 249163.9999999982, 53117.7344113277, 53173.73413132987, 53338.0, 53394.73302633462, 53669.46330536723, 56424.0, 56514.0, 56590.7170464145, 56639.0, 56672.0, 12876.098673092794, 13406.195628262336, 13487.865121348857, 13547.932260338635, 13627.182369057888, 9164.679236226833, 9471.384360016576, 10623.415712135908, 10900.236983411243, 11116.110711143088, 15391.461298854487, 15406.0, 15420.383184672712, 15485.458008969857, 15563.844361556467, 5979.880402391927, 6213.161223234896, 6230.95292812823, 6259.18630578031, 6264.624122552661, 789.6643926331286, 812.2283830361181, 836.958152092393, 842.1452225990624, 843.1147295339991, 26386.86806565993, 27935.161945141677, 28376.43247135087, 28473.430531389255, 28648.85675571609, 985.5466485416789, 985.6648739428485, 987.1263931420601, 989.3717489394287, 1107.7618312062946, 14296.714065718836, 15187.316570754343, 15235.16206608625, 15298.0, 15382.230888455533, 339133.0, 343048.0, 343280.0, 344423.0, 344511.0, 50376.748116259914, 50382.49617503778, 50640.49359506358, 50698.0, 50789.74605126951, 1205.5599706107207, 1223.1315765806378, 1245.9439325230387, 1253.642711827143, 1255.3597665190819, 26065.218043458728, 26970.32574185661, 27596.172114836587, 27632.861835691496, 27800.58299125474, 42617.0, 42875.068112399305, 43115.56884431116, 43146.784266078466, 43218.56781432145, 280086.0, 281543.0, 282039.0, 282315.0, 282340.0, 23936.162234321717, 24336.756632433448, 24521.509569808146, 24628.50742985166, 35925.64074359223, 35370.46944295889, 35794.463083054296, 35938.0, 36179.63820361868, 36566.63433365632, 31873.68126318707, 31978.081315121166, 31995.840020799747, 32238.19404514906, 32324.83837580797, 31127.221819454695, 31741.8412907934, 31869.8406507966, 32027.519587206676, 32556.88380255276, 30864.37034444851, 31165.0, 31192.394585840924, 31289.687103128676, 31739.365212695157, 25927.870360648078, 26700.866495667397, 28874.42251155007, 28901.56647650245, 29635.0, 22228.777712222673, 22539.66190507111, 22702.772972270064, 22774.88612556993, 22968.885155574117], "value": 17495.622077015723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.71782573940857, 364.23510627681867, 369.5270054330457, 370.1246551904746, 383.7659027992926, 16970.66058678827, 18213.635727285462, 18817.943271273274, 18863.15115819788, 18967.90516047418, 17799.911000445012, 17994.370197043107, 18118.27526898926, 18253.361132360336, 18379.98910059946, 5010.248462730583, 5163.7418129093585, 5185.688858668473, 5196.350456192976, 5207.218917162418, 4877.951220487803, 4955.603551715854, 4985.302057711923, 4990.6257030722845, 5040.420351659551, 4953.826616068438, 4959.107360675077, 4960.900781984358, 4977.925331120036, 4977.975110124463, 4933.531314525132, 4961.925571116436, 5233.816816411408, 5465.781368745245, 5503.477169668875, 5344.4922732340365, 5378.058839703075, 5384.057789886793, 5397.919031214535, 5402.540784033362, 12753.489860405572, 20512.076956536992, 21178.0, 21360.786392136037, 21436.678449823266, 1941.7572803399576, 2018.535736780534, 2061.2373421833868, 2142.2287976328507, 2187.1798075721604, 8620.827583448296, 9091.863622045674, 9299.674511392137, 9469.905300946972, 9652.613895444174, 1721.1308289313943, 1742.2508321421783, 1742.5643589102724, 1768.1582922661623, 1793.0944872839132, 63952.680236598986, 70669.99999999949, 71780.28219717788, 74993.62503187504, 76408.0, 8688.174623410892, 8950.462972221687, 9067.410618309788, 9941.353812002197, 10183.643572474928, 13768.586942391745, 13778.862211377958, 13804.17174969505, 13849.307534623229, 13866.791998120036, 6858.554193977376, 7110.217876033632, 7131.465140114512, 7245.601491917995, 7245.746398876014, 6617.272100068989, 6624.205095388585, 6791.320867913268, 6814.420774234147, 6822.795316140524, 4025.094353770437, 4178.603032711888, 4211.368294755811, 4217.1144059747185, 4318.762468064224, 1668.341005302923, 1704.7101992661278, 1738.452387497934, 1760.4718584424622, 1767.5492749348834, 824.8762685597209, 839.1482645115213, 839.8236370362171, 857.7169534053872, 867.111211008721, 17022.319107235573, 17318.567035823955, 17405.265257279567, 18455.53861153455, 18681.626367472574, 818.402566126719, 821.6343727041528, 827.4249396669258, 847.8431490174338, 861.1689719420789, 9817.607295708092, 10166.542505587266, 10284.0, 10324.328918620266, 10333.896661033445, 431111.0, 434966.0, 438056.0, 442388.0, 473118.0, 87132.0, 87177.0, 88948.0, 89679.0, 90389.0, 888.0808363343779, 906.4878343735768, 938.2681508423304, 938.7324612485409, 941.7268991992382, 15397.384104635688, 15464.768028479357, 15619.921900390425, 15932.283047262668, 16084.517464476085, 39114.60885391109, 40218.59781402266, 40358.596414035484, 40658.59341406548, 41190.0, 55082.44917550773, 55122.724386379414, 57004.71497642485, 57046.7147664259, 58042.4195758037, 7603.809904752426, 7639.847203055797, 7847.764567062997, 7868.134505204309, 7968.884356190254, 12363.32001739913, 12653.683657908627, 12658.493660253487, 12701.36493175319, 12705.301208433255, 10357.896421035995, 10557.841632375674, 10723.30298530593, 11147.0, 11271.661850144508, 10447.111995480165, 10593.788124237626, 10757.838632420677, 10827.24209305341, 10830.51262693165, 10089.848652270075, 10831.837522437012, 10938.070264027647, 11051.392173430539, 11062.280951738112, 7646.579438130733, 7701.499402538817, 7884.645190966535, 7915.525068495908, 7940.682372705027, 9928.652497162564, 10681.786364272826, 10771.299865508718, 10978.890211097787, 11244.325340479598], "value": 8358.216427250425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.21163513527, 1344.8924086073114, 1345.7375811716713, 1347.1916849890074, 1347.818044563984, 6137.079438084278, 6418.293987661354, 6588.209414870216, 6949.478789090819, 6976.790696279113, 6764.661766911647, 6929.0645762822005, 6991.860162796741, 7127.536710113852, 7169.749058782943, 2010.808973147556, 2052.5997430501056, 2054.1680619349186, 2057.0, 2058.7941205879365, 1974.684050551912, 2011.3161525081468, 2018.4852862520038, 2063.7213976113185, 2074.1495986645477, 2079.9080482746604, 2105.473631592102, 2107.3151225851584, 2110.4488201172126, 2118.692789545515, 2036.216056818121, 2048.0374224114644, 2053.58928214357, 2063.5769667218183, 2066.4833791552114, 2008.8493362997833, 2040.2145174107927, 2040.9795902040937, 2062.123597471069, 2067.514134178467, 6933.37599616037, 7098.183708873494, 7101.6449177541435, 7108.857822843566, 7151.320624540713, 4303.65570754342, 4389.934150987738, 4418.5802348776815, 4421.248387774086, 4423.004823914625, 2636.5386057440064, 2788.776897848167, 2828.632277803893, 2838.3046153692476, 2849.871755770995, 958.4536814016013, 966.294604938399, 989.3865803202061, 1080.1628737728324, 1101.7576133250673, 8932.0, 9025.277977761763, 9106.81786364269, 9135.954320228422, 9164.816703665889, 3643.836027378721, 3653.926921461556, 3729.370793590512, 3798.2213646202463, 3801.3917773156163, 7400.888986665204, 7420.962895185489, 7426.925730742623, 7428.554286742705, 7454.962725186448, 4167.499900012018, 4175.749455032707, 4211.578842115764, 4221.7255878367805, 4278.208531421635, 3859.7684138951754, 3891.416287556889, 3921.8039098045556, 3940.9802950985636, 3971.0866500704424, 3050.542418637178, 3079.0608864296605, 3111.4866047101973, 3123.984380078085, 3131.2798056447145, 847.3941132090584, 869.5478351257311, 873.5282947208436, 885.0441523154977, 902.9413088149249, 821.8602837517636, 836.8577341851778, 840.3235395506554, 861.405630115231, 863.8617821148586, 4784.091022705675, 4962.478939711351, 5001.249812528077, 5014.6991180529285, 5079.746012699424, 924.3760461688333, 930.7068273493828, 937.8686983822271, 943.0804965158915, 947.5124055233356, 3279.7868138570916, 3391.6438773928876, 3395.2700169463683, 3419.6409377015552, 3469.0460123465746, 8016.478928869605, 8375.078741338448, 8435.789105272295, 8440.113788052166, 8443.408961372645, 8353.874691879626, 8361.498310101291, 8380.329573634095, 8393.790155246168, 8401.53791541471, 6489.902651460232, 6641.369069938348, 6666.633335166613, 6707.128073350434, 6746.662666866637, 4875.098106850244, 4889.193283108248, 4919.557239848431, 4946.307516947702, 4990.251462280687, 7489.363404110712, 7529.247075292646, 7558.811029724081, 7561.0, 7577.886331704918, 7195.6761945713615, 7468.589227592534, 7478.102627684712, 7730.729424470116, 7749.380049596131, 6070.484008859296, 6174.44430001302, 6185.072239163981, 6200.0699895016105, 6203.906941395792, 6718.126643536309, 6736.629485378156, 6746.291639377991, 6782.389584937182, 6791.524593278423, 5634.436556344497, 6119.785807496716, 6167.352427994996, 6250.906236406367, 6286.748530058747, 6142.385761423822, 6146.600470969552, 6178.938210617836, 6182.165407669907, 6207.906881396692, 5435.891282174255, 5501.669899806025, 5531.561793933526, 5541.501264886179, 5552.666839989613, 4186.832526698898, 4207.97896010518, 4293.119910418294, 4295.22685916538, 4377.781110944504, 4364.192624364503, 4380.8685739427865, 4389.40742999691, 4487.6761355399585, 4501.932471012872], "value": 3784.3361050078006, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.8668089423783, 328.9013296011196, 337.0024726808646, 340.16659184996763, 341.4434471810949, 5075.974620126899, 5086.880886205038, 5088.847334579968, 5108.974455127719, 5110.872228194297, 5005.274235235888, 5006.399232092145, 5012.498750124985, 5024.0, 5036.3452751142395, 3763.5671897731836, 3860.961390386088, 3863.4011728182177, 3913.2956067907767, 3927.725059245854, 3932.7836968966694, 3933.174033452964, 3938.6849052075763, 3941.4481972523868, 3983.1237127831973, 3896.6298201670797, 3898.3177943859855, 3899.259140763246, 3902.400015993443, 3914.2171565686835, 3627.8776915504463, 3789.2232092420986, 3930.8034598269974, 3937.7637341759587, 3953.1303113315166, 3308.751843611739, 3321.4353559894876, 3327.1183136468853, 3333.633300336961, 3350.430426827445, 4829.1790395632825, 4857.757112144414, 4870.196417591093, 4874.878128046792, 4884.169691152512, 4327.0, 4337.566243375669, 4375.32182511708, 4378.8905277368, 4389.648828093745, 5021.543752311825, 5185.922211166836, 5195.558377537914, 5197.58419326453, 5207.843764687065, 3636.690881275095, 3643.0892276930767, 3645.2527231917393, 3657.7256705747177, 3659.2864391443677, 5430.185472179165, 5444.3194600674915, 5465.234867118606, 5498.422665620093, 5507.201455788888, 3594.2991116731987, 3656.305301992613, 3674.2651469706166, 3700.3524383232825, 3703.6296370362747, 3703.4815125882396, 3720.330340538675, 3721.0511319613865, 3732.2722069196248, 3741.6258374162912, 4315.568443155722, 4323.156984388014, 4329.718568293051, 4348.673849461303, 4361.978190109029, 5140.228965655182, 5247.868803279948, 5276.15581506957, 5286.0, 5287.867803304948, 1258.2261908926127, 1261.199138547011, 1263.5072321794507, 1274.7450509897872, 1281.1992504684572, 832.7793134819278, 862.3532350736947, 869.7347309070794, 874.3966663002508, 874.7463235661714, 4561.429821272341, 4604.7927843247135, 4629.490756016836, 4629.745364005012, 4643.349931009661, 5393.568514518829, 5402.8919421611345, 5414.133738601805, 5425.077736784756, 5439.564834813205, 4537.954620453819, 4639.582437580634, 4649.325847752057, 4650.279206722963, 4652.0, 2767.8477683727588, 2768.7231276872553, 2785.749282564579, 2800.5799130130235, 2805.2846524136216, 4874.46380898101, 4886.633502487328, 4888.633352498577, 4892.45887545422, 4916.975415122973, 5207.6875387476875, 5370.4629537045985, 5376.758045887945, 5397.7571009304675, 5407.188921661782, 4801.471838097877, 4824.855254342376, 4877.195262781673, 4892.535209155125, 4897.804087836518, 5227.712475813867, 5230.476952304739, 5256.423073077985, 5259.344031264187, 5275.920861187162, 5019.372578427697, 5058.6206034548295, 5074.695518268915, 5161.922571161361, 5203.973980130075, 4828.899428748506, 4868.829590964441, 4879.878003049952, 4886.096072226507, 4899.706017638953, 3635.0, 3671.944920826243, 3675.3016926783826, 3675.9081022974638, 3676.28312479064, 5101.642884998015, 5243.895122097613, 5263.526282634428, 5293.602979776455, 5308.893822123458, 5061.506855477569, 5075.492450754895, 5087.0, 5087.821926232564, 5128.358955130609, 5089.651242420836, 5095.745212739274, 5099.184130539096, 5116.513931176532, 5143.0, 4805.615550756001, 4978.502149784992, 4999.300097986212, 5001.449840517467, 5067.822626208213, 5139.8715032123, 5165.121929272108, 5176.637635365489, 5266.683998960075, 5269.42036376006, 5160.432352441153, 5163.734884953211, 5169.7673604687125, 5188.273641690091, 5190.117679994485], "value": 3890.5104319481625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.5427269502305, 655.4690700532569, 726.905502284703, 740.9259074092591, 765.1697907770069, 12475.18911270768, 12778.808317875239, 12849.614511564645, 12902.548410805624, 12940.805887911678, 12028.639140825768, 12066.698332541691, 12192.634220973363, 12286.815697764518, 12319.5072197112, 801.3028665061405, 810.1088802317433, 816.1226681317578, 816.4937738602046, 817.060380562355, 804.5172896262254, 810.878368244765, 811.1847593168857, 815.0545367373848, 816.1797393619404, 847.3560094328324, 851.9957400212991, 852.1606217875387, 852.4842470305468, 853.2022558907411, 844.9788755281137, 845.8223773007676, 847.2459511035183, 848.5757121439281, 849.290842146802, 617.6386813713983, 619.0528491408153, 619.4301242856583, 622.0389498225253, 622.470899735226, 11141.777164456747, 11283.040941519981, 11393.145514086476, 11406.315621062762, 11602.419879006016, 10841.566337346576, 11066.114710823114, 11128.554857805679, 11253.0, 11356.558195248603, 9383.108604682544, 9461.0, 9609.711708648681, 9617.90382096177, 9761.560729767107, 3257.5765150530515, 3265.4122257993554, 3269.836508174582, 3287.3425314936867, 3323.7507186961075, 59747.70126149385, 60453.395466045215, 60655.39344606586, 60726.0, 61409.385906140815, 8052.115967974562, 8242.876356854653, 8389.119142490074, 8409.873851892227, 8466.74599762008, 16353.91823040901, 16364.018158910503, 16488.67022659564, 17131.571710707332, 17765.0, 6561.80314590563, 6631.602103873686, 6679.098321726602, 6736.831579210461, 6950.860982780316, 3582.373084710165, 3710.888673339804, 3713.5729391119826, 3716.7398282119993, 3721.3673675474693, 2953.926151846221, 3028.227801910499, 3041.2700951771417, 3079.7382222511337, 3081.9075427737203, 535.3709391465013, 536.8738346488572, 537.5377175628956, 537.9560636251709, 550.0896017091719, 614.2107392001257, 629.7008920762693, 645.8987426437913, 646.12127506591, 648.8248172993266, 8059.879101813477, 8317.875231871527, 8427.241548260687, 8601.22588966996, 8659.870101948476, 625.8497960489541, 641.493220355923, 644.7904431059831, 645.1290757477368, 648.9578177418452, 3927.430522574211, 4036.0918793271867, 4110.424540564323, 4125.814338354781, 4175.770332631734, 69519.65240173868, 69934.0, 72219.0, 72232.0, 73021.2697873025, 61270.38729612736, 61561.0, 61845.69077154585, 62420.37579624236, 62784.68607656933, 55218.0, 55345.72327138419, 55572.72213638906, 58126.709366452895, 59343.25253979671, 7778.533288002738, 7878.487898286593, 8007.239312265326, 8132.1867813218205, 8571.914280857112, 32327.0, 34111.65888341184, 35352.64647353494, 35741.82129089442, 37410.43884341791, 47938.0, 48473.0, 49052.26421603608, 49062.264066038326, 50185.74907125441, 10254.384736915808, 10615.469226538797, 10627.468626568487, 10672.62645807393, 10955.123590112613, 12382.257064575793, 12408.56570020045, 12493.625191244277, 12622.55821046259, 12870.549530766753, 11916.702082448008, 12014.819777703517, 12331.260124392566, 12779.169353991962, 12857.03572232105, 10442.63450779219, 10579.682609521727, 10874.293170943864, 10874.565017399533, 11202.66392008241, 11307.660770176908, 11614.0, 11874.46564904564, 12330.506779729069, 12346.13577049598, 9416.387934784218, 9551.474668893277, 9837.360571562825, 10050.296479246383, 10228.437435941094, 8440.915590844013, 9093.40892841963, 9391.624335026523, 9481.620735170793, 9625.085616866387], "value": 6236.950658785447, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 125.0, 170.0, 125.0, 126.0, 127.0, 127.0, 147.0, 128.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 173.0, 163.0, 164.0, 163.0, 164.0, 163.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 117.0, 77.0, 78.0, 76.0, 75.0, 98.0, 77.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 101.0, 85.0, 85.0, 85.0, 98.0, 85.0, 85.0, 106.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 151.0, 150.0, 150.0, 150.0, 151.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 76.0, 67.0, 69.0, 68.0, 73.0, 68.0, 69.0, 67.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 72.0, 72.0, 67.0, 68.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 89.0, 91.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 143.0, 132.0, 134.0, 143.0, 134.0, 153.0, 135.0, 185.0, 141.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 181.0, 175.0, 188.0, 181.0, 179.0, 177.0, 179.0, 183.0, 179.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 73.0, 69.0, 71.0, 69.0, 70.0, 69.0, 68.0, 68.0], "value": 70.0, "unit": "score"}]}]} 18:16:12 INFO - Return code: 0 18:16:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:16:12 ERROR - # TBPL SUCCESS # 18:16:12 INFO - Running post-action listener: _resource_record_post_action 18:16:12 INFO - [mozharness: 2017-01-06 02:16:12.690284Z] Finished run-tests step (success) 18:16:12 INFO - Running post-run listener: _resource_record_post_run 18:16:12 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 0; Write bytes: 403308544; Read time: 0; Write time: 467588 18:16:12 INFO - TinderboxPrint: CPU usage
13.5% 18:16:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:16:12 INFO - TinderboxPrint: I/O write bytes / time
403,308,544 / 467,588 18:16:12 INFO - TinderboxPrint: CPU idle
8,284.3 (86.5%) 18:16:12 INFO - TinderboxPrint: CPU user
1,235.0 (12.9%) 18:16:12 INFO - TinderboxPrint: Swap in / out
0 / 0 18:16:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107843584; Read time: 0; Write time: 111396 18:16:12 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 0; Write bytes: 294879232; Read time: 0; Write time: 356160 18:16:13 INFO - Running post-run listener: _upload_blobber_files 18:16:13 INFO - Blob upload gear active. 18:16:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:16:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:16:13 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:16:13 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:16:13 INFO - (blobuploader) - INFO - Open directory for files ... 18:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:14 INFO - (blobuploader) - INFO - Done attempting. 18:16:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:16:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:16:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:15 INFO - (blobuploader) - INFO - Done attempting. 18:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:16 INFO - (blobuploader) - INFO - Done attempting. 18:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:20 INFO - (blobuploader) - INFO - Done attempting. 18:16:20 INFO - (blobuploader) - INFO - Iteration through files over. 18:16:20 INFO - Return code: 0 18:16:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:16:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:16:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ccf32f65e1b702add6041ec4dacd192486eee5a182238cf6ad3f08a0605f306bd03dd9ae3c974b8b279e1fa7890d327eb5887743034e8c200c4028bf58b74c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a1da79e462367e03466cc8826f37650341f80cf518044490959c527be9898328c5ab16d1d2abc48d97d1bf05b1e8c4906c920efc0cb4b7844dba056a4156e84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5a6ec1cf48740f97b8ca36203d017d766c9e500198c893d1e027fbd78e3087c8cc97d61169a39f93c902eb8a8918f1253459750927b2866ba24f47aa854072a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26f4a92e4bf7d47e13e55b4154cf1b64b091aeb87dbddffe5657c5e4d0b86ce8788808e0d5c96e1f9d1226ab3677d4c408046ec1df5691f9ccef249b1a4b70e9"} 18:16:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:16:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:16:20 INFO - Contents: 18:16:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ccf32f65e1b702add6041ec4dacd192486eee5a182238cf6ad3f08a0605f306bd03dd9ae3c974b8b279e1fa7890d327eb5887743034e8c200c4028bf58b74c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a1da79e462367e03466cc8826f37650341f80cf518044490959c527be9898328c5ab16d1d2abc48d97d1bf05b1e8c4906c920efc0cb4b7844dba056a4156e84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5a6ec1cf48740f97b8ca36203d017d766c9e500198c893d1e027fbd78e3087c8cc97d61169a39f93c902eb8a8918f1253459750927b2866ba24f47aa854072a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26f4a92e4bf7d47e13e55b4154cf1b64b091aeb87dbddffe5657c5e4d0b86ce8788808e0d5c96e1f9d1226ab3677d4c408046ec1df5691f9ccef249b1a4b70e9"} 18:16:20 INFO - Running post-run listener: copy_logs_to_upload_dir 18:16:20 INFO - Copying logs to upload dir... 18:16:20 INFO - mkdir: /builds/slave/test/build/upload/logs 18:16:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.744121 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-05 18:16:20.204922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 18:16:20.208623) ========= 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=ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ccf32f65e1b702add6041ec4dacd192486eee5a182238cf6ad3f08a0605f306bd03dd9ae3c974b8b279e1fa7890d327eb5887743034e8c200c4028bf58b74c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a1da79e462367e03466cc8826f37650341f80cf518044490959c527be9898328c5ab16d1d2abc48d97d1bf05b1e8c4906c920efc0cb4b7844dba056a4156e84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5a6ec1cf48740f97b8ca36203d017d766c9e500198c893d1e027fbd78e3087c8cc97d61169a39f93c902eb8a8918f1253459750927b2866ba24f47aa854072a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26f4a92e4bf7d47e13e55b4154cf1b64b091aeb87dbddffe5657c5e4d0b86ce8788808e0d5c96e1f9d1226ab3677d4c408046ec1df5691f9ccef249b1a4b70e9"} build_url:https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011776 build_url: 'https://queue.taskcluster.net/v1/task/evJgljTzQC-5Qt9CU749Qw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ccf32f65e1b702add6041ec4dacd192486eee5a182238cf6ad3f08a0605f306bd03dd9ae3c974b8b279e1fa7890d327eb5887743034e8c200c4028bf58b74c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a1da79e462367e03466cc8826f37650341f80cf518044490959c527be9898328c5ab16d1d2abc48d97d1bf05b1e8c4906c920efc0cb4b7844dba056a4156e84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5a6ec1cf48740f97b8ca36203d017d766c9e500198c893d1e027fbd78e3087c8cc97d61169a39f93c902eb8a8918f1253459750927b2866ba24f47aa854072a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26f4a92e4bf7d47e13e55b4154cf1b64b091aeb87dbddffe5657c5e4d0b86ce8788808e0d5c96e1f9d1226ab3677d4c408046ec1df5691f9ccef249b1a4b70e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 18:16:20.236963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 18:16:20.237777) ========= 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=ba164b0a7b0ec7655860e956000001c1-1483667730.83373-1858871792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 18:16:20.323669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 18:16:20.324449) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 18:16:20.325133) ========= ========= Total master_lag: 0.18 =========