builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1483889276.75 results: success (0) revision: d192a99be4b436f2dc839435319f7630d5d8f4b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:56.751087) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:56.751734) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:56.752236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:56.767913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:56.768226) ========= 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=fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-08 07:27:58-- 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% 57.5K=0.2s 2017-01-08 07:27:58 (57.5 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.286703 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.068675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.068999) ========= 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=fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022608 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.119007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.119379) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d192a99be4b436f2dc839435319f7630d5d8f4b0 --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 d192a99be4b436f2dc839435319f7630d5d8f4b0 --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=fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-08 07:27:58,908 truncating revision to first 12 chars 2017-01-08 07:27:58,908 Setting DEBUG logging. 2017-01-08 07:27:58,908 attempt 1/10 2017-01-08 07:27:58,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d192a99be4b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-08 07:27:59,347 unpacking tar archive at: mozilla-central-d192a99be4b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.781924 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.915199) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.915555) ========= script_repo_revision: d192a99be4b436f2dc839435319f7630d5d8f4b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.916018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.916347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-08 07:27:57.935300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-08 07:27:57.935615) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:27:59 INFO - MultiFileLogger online at 20170108 07:27:59 in /builds/slave/test 07:27:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 07:27:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:27:59 INFO - {'append_to_log': False, 07:27:59 INFO - 'base_work_dir': '/builds/slave/test', 07:27:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:27:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:27:59 INFO - 'branch': 'Firefox-Non-PGO', 07:27:59 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:59 INFO - 'config_files': ('talos/linux_config.py',), 07:27:59 INFO - 'default_actions': ('clobber', 07:27:59 INFO - 'read-buildbot-config', 07:27:59 INFO - 'download-and-extract', 07:27:59 INFO - 'populate-webroot', 07:27:59 INFO - 'create-virtualenv', 07:27:59 INFO - 'install', 07:27:59 INFO - 'run-tests'), 07:27:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:59 INFO - 'download_minidump_stackwalk': True, 07:27:59 INFO - 'download_symbols': 'ondemand', 07:27:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:59 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:59 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:59 INFO - 'installer_path': 'installer.exe', 07:27:59 INFO - 'log_level': 'info', 07:27:59 INFO - 'log_name': 'talos', 07:27:59 INFO - 'log_to_console': True, 07:27:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:27:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:27:59 INFO - 'opt_config_files': (), 07:27:59 INFO - 'pip_index': False, 07:27:59 INFO - 'sps_profile': False, 07:27:59 INFO - 'sps_profile_interval': 0, 07:27:59 INFO - 'suite': 'dromaeojs', 07:27:59 INFO - 'system_bits': '32', 07:27:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:59 INFO - 'title': 'talos-linux64-ix-048', 07:27:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:59 INFO - 'use_talos_json': True, 07:27:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:27:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:59 INFO - 'work_dir': 'build'} 07:27:59 INFO - [mozharness: 2017-01-08 15:27:59.823078Z] Running clobber step. 07:27:59 INFO - Running pre-action listener: _resource_record_pre_action 07:27:59 INFO - Running main action method: clobber 07:27:59 INFO - rmtree: /builds/slave/test/build 07:27:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:00 INFO - Running post-action listener: _resource_record_post_action 07:28:00 INFO - [mozharness: 2017-01-08 15:28:00.280293Z] Finished clobber step (success) 07:28:00 INFO - [mozharness: 2017-01-08 15:28:00.280394Z] Running read-buildbot-config step. 07:28:00 INFO - Running pre-action listener: _resource_record_pre_action 07:28:00 INFO - Running main action method: read_buildbot_config 07:28:00 INFO - Using buildbot properties: 07:28:00 INFO - { 07:28:00 INFO - "project": "", 07:28:00 INFO - "product": "firefox", 07:28:00 INFO - "who": "ffxbld@noreply.mozilla.org", 07:28:00 INFO - "installer_path": "public/build/target.tar.bz2", 07:28:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:28:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:28:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:28:00 INFO - "stage_platform": "linux64", 07:28:00 INFO - "basedir": "/builds/slave/test", 07:28:00 INFO - "buildnumber": 375, 07:28:00 INFO - "platform": "ubuntu64_hw", 07:28:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:28:00 INFO - "slavebuilddir": "test", 07:28:00 INFO - "taskId": "Z77TKo52TfuRp8_SMNG8tQ", 07:28:00 INFO - "branch": "mozilla-central", 07:28:00 INFO - "script_repo_revision": "production", 07:28:00 INFO - "revision": "d192a99be4b436f2dc839435319f7630d5d8f4b0", 07:28:00 INFO - "slavename": "talos-linux64-ix-048", 07:28:00 INFO - "repo_path": "mozilla-central" 07:28:00 INFO - } 07:28:00 INFO - Finding installer, test and symbols from parent task. 07:28:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z77TKo52TfuRp8_SMNG8tQ'}, attempt #1 07:28:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z77TKo52TfuRp8_SMNG8tQ'}, attempt #1 07:28:01 INFO - Task dependencies: LTivuPKOT82-kmX9cDsG1g 07:28:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g'}, attempt #1 07:28:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.tar.bz2 07:28:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/test_packages.json 07:28:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.crashreporter-symbols.zip 07:28:01 INFO - Running post-action listener: _resource_record_post_action 07:28:01 INFO - [mozharness: 2017-01-08 15:28:01.677568Z] Finished read-buildbot-config step (success) 07:28:01 INFO - [mozharness: 2017-01-08 15:28:01.677785Z] Running download-and-extract step. 07:28:01 INFO - Running pre-action listener: _resource_record_pre_action 07:28:01 INFO - Running main action method: download_and_extract 07:28:01 INFO - mkdir: /builds/slave/test/build/tests 07:28:01 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')]} 07:28:01 INFO - trying https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.test_packages.json 07:28:01 INFO - Downloading https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:28:02 INFO - Downloaded 896 bytes. 07:28:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:28:02 INFO - Using the following test package requirements: 07:28:02 INFO - {u'common': [u'target.common.tests.zip'], 07:28:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:28:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:28:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:28:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:28:02 INFO - u'mozbase': [u'target.common.tests.zip'], 07:28:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:28:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:28:02 INFO - u'web-platform': [u'target.common.tests.zip', 07:28:02 INFO - u'target.web-platform.tests.zip'], 07:28:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:28:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:28:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.common.tests.zip 07:28:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:28:02 INFO - Fetch https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.common.tests.zip into memory 07:28:03 INFO - Expected file size: 20251352 07:28:03 INFO - Obtained file size: 20251352 07:28:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:28:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.common.tests.zip 07:28:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:28:07 INFO - Fetch https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.common.tests.zip into memory 07:28:08 INFO - Expected file size: 20251352 07:28:08 INFO - Obtained file size: 20251352 07:28:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.talos.tests.zip 07:28:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:28:12 INFO - Fetch https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.talos.tests.zip into memory 07:28:14 INFO - Expected file size: 14403537 07:28:14 INFO - Obtained file size: 14403537 07:28:14 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')]} 07:28:14 INFO - trying https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.tar.bz2 07:28:14 INFO - Downloading https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:28:16 INFO - Downloaded 55888330 bytes. 07:28:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.tar.bz2 07:28:16 INFO - mkdir: /builds/slave/test/properties 07:28:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:28:16 INFO - Writing to file /builds/slave/test/properties/build_url 07:28:16 INFO - Contents: 07:28:16 INFO - build_url:https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.tar.bz2 07:28:16 INFO - Running post-action listener: _resource_record_post_action 07:28:16 INFO - Running post-action listener: set_extra_try_arguments 07:28:16 INFO - [mozharness: 2017-01-08 15:28:16.608931Z] Finished download-and-extract step (success) 07:28:16 INFO - [mozharness: 2017-01-08 15:28:16.609027Z] Running populate-webroot step. 07:28:16 INFO - Running pre-action listener: _resource_record_pre_action 07:28:16 INFO - Running main action method: populate_webroot 07:28:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:28:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:28:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:28:16 INFO - '--tppagecycles', 07:28:16 INFO - '7'], 07:28:16 INFO - 'tests': ['tsvgm']}}, 07:28:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:28:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:28:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:28:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:28:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:28:16 INFO - 'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:28:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:28:16 INFO - 'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['damp', 'tps']}, 07:28:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:28:16 INFO - 'tests': ['damp', 'tps']}, 07:28:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['dromaeo_dom']}, 07:28:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:28:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['basic_compositor_video']}, 07:28:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:28:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['a11yr', 07:28:16 INFO - 'ts_paint', 07:28:16 INFO - 'tpaint', 07:28:16 INFO - 'sessionrestore', 07:28:16 INFO - 'sessionrestore_no_auto_restore', 07:28:16 INFO - 'tabpaint']}, 07:28:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:28:16 INFO - 'ts_paint', 07:28:16 INFO - 'tpaint', 07:28:16 INFO - 'sessionrestore', 07:28:16 INFO - 'sessionrestore_no_auto_restore', 07:28:16 INFO - 'tabpaint']}, 07:28:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:28:16 INFO - 'ts_paint', 07:28:16 INFO - 'tpaint', 07:28:16 INFO - 'sessionrestore', 07:28:16 INFO - 'sessionrestore_no_auto_restore', 07:28:16 INFO - 'tabpaint']}, 07:28:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:28:16 INFO - 'ts_paint', 07:28:16 INFO - 'tpaint', 07:28:16 INFO - 'sessionrestore', 07:28:16 INFO - 'sessionrestore_no_auto_restore', 07:28:16 INFO - 'tabpaint']}, 07:28:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['a11yr', 07:28:16 INFO - 'ts_paint', 07:28:16 INFO - 'tpaint', 07:28:16 INFO - 'sessionrestore', 07:28:16 INFO - 'sessionrestore_no_auto_restore', 07:28:16 INFO - 'tabpaint']}, 07:28:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['a11yr', 07:28:16 INFO - 'ts_paint', 07:28:16 INFO - 'tpaint', 07:28:16 INFO - 'sessionrestore', 07:28:16 INFO - 'sessionrestore_no_auto_restore', 07:28:16 INFO - 'tabpaint']}, 07:28:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['tsvgx', 07:28:16 INFO - 'tsvgr_opacity', 07:28:16 INFO - 'tart', 07:28:16 INFO - 'tscrollx', 07:28:16 INFO - 'cart', 07:28:16 INFO - 'tsvg_static']}, 07:28:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:28:16 INFO - 'tsvgr_opacity', 07:28:16 INFO - 'tart', 07:28:16 INFO - 'tscrollx', 07:28:16 INFO - 'cart', 07:28:16 INFO - 'tsvg_static']}, 07:28:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:28:16 INFO - 'talos_options': ['--disable-e10s'], 07:28:16 INFO - 'tests': ['tp5o']}, 07:28:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:28:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:28:16 INFO - 'talos_options': ['--disable-e10s', 07:28:16 INFO - '--xperf_path', 07:28:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:16 INFO - 'tests': ['tp5n']}, 07:28:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:28:16 INFO - 'talos_options': ['--xperf_path', 07:28:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:16 INFO - 'tests': ['tp5n']}}, 07:28:16 INFO - 'talos.zip': {'path': '', 07:28:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:28:16 INFO - Running post-action listener: _resource_record_post_action 07:28:16 INFO - [mozharness: 2017-01-08 15:28:16.622026Z] Finished populate-webroot step (success) 07:28:16 INFO - [mozharness: 2017-01-08 15:28:16.622115Z] Running create-virtualenv step. 07:28:16 INFO - Running pre-action listener: _resource_record_pre_action 07:28:16 INFO - Running main action method: create_virtualenv 07:28:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:28:16 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 07:28:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:28:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:28:16 INFO - Using real prefix '/usr' 07:28:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:28:17 INFO - Installing distribute.............................................................................................................................................................................................done. 07:28:19 INFO - Installing pip.................done. 07:28:19 INFO - Return code: 0 07:28:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:28:19 INFO - Reading from file tmpfile_stdout 07:28:19 INFO - Output received: 07:28:19 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) 07:28:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:28:19 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')]} 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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')]} 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:19 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 07:28:19 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 07:28:19 INFO - Using env: {'DISPLAY': ':0', 07:28:19 INFO - 'HOME': '/home/cltbld', 07:28:19 INFO - 'LANG': 'en_US.UTF-8', 07:28:19 INFO - 'LANGUAGE': 'en_US:en', 07:28:19 INFO - 'LOGNAME': 'cltbld', 07:28:19 INFO - 'MAIL': '/var/mail/cltbld', 07:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:19 INFO - 'MOZ_NO_REMOTE': '1', 07:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:19 INFO - 'NO_EM_RESTART': '1', 07:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:19 INFO - 'PWD': '/builds/slave/test', 07:28:19 INFO - 'SHELL': '/bin/bash', 07:28:19 INFO - 'SHLVL': '1', 07:28:19 INFO - 'TERM': 'linux', 07:28:19 INFO - 'TMOUT': '86400', 07:28:19 INFO - 'USER': 'cltbld', 07:28:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:19 INFO - '_': '/tools/buildbot/bin/python'} 07:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:19 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 07:28:19 INFO - Cleaning up... 07:28:19 INFO - Return code: 0 07:28:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:28:19 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')]} 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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')]} 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:19 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 07:28:19 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 07:28:19 INFO - Using env: {'DISPLAY': ':0', 07:28:19 INFO - 'HOME': '/home/cltbld', 07:28:19 INFO - 'LANG': 'en_US.UTF-8', 07:28:19 INFO - 'LANGUAGE': 'en_US:en', 07:28:19 INFO - 'LOGNAME': 'cltbld', 07:28:19 INFO - 'MAIL': '/var/mail/cltbld', 07:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:19 INFO - 'MOZ_NO_REMOTE': '1', 07:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:19 INFO - 'NO_EM_RESTART': '1', 07:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:19 INFO - 'PWD': '/builds/slave/test', 07:28:19 INFO - 'SHELL': '/bin/bash', 07:28:19 INFO - 'SHLVL': '1', 07:28:19 INFO - 'TERM': 'linux', 07:28:19 INFO - 'TMOUT': '86400', 07:28:19 INFO - 'USER': 'cltbld', 07:28:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:19 INFO - '_': '/tools/buildbot/bin/python'} 07:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:19 INFO - Downloading/unpacking psutil>=3.1.1 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:21 INFO - Installing collected packages: psutil 07:28:21 INFO - Running setup.py install for psutil 07:28:22 INFO - building 'psutil._psutil_linux' extension 07:28:22 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 07:28:22 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 07:28:22 INFO - building 'psutil._psutil_posix' extension 07:28:22 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 07:28:22 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 07:28:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:22 INFO - Successfully installed psutil 07:28:22 INFO - Cleaning up... 07:28:22 INFO - Return code: 0 07:28:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:28:22 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')]} 07:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:22 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')]} 07:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:22 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:22 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 07:28:22 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 07:28:22 INFO - Using env: {'DISPLAY': ':0', 07:28:22 INFO - 'HOME': '/home/cltbld', 07:28:22 INFO - 'LANG': 'en_US.UTF-8', 07:28:22 INFO - 'LANGUAGE': 'en_US:en', 07:28:22 INFO - 'LOGNAME': 'cltbld', 07:28:22 INFO - 'MAIL': '/var/mail/cltbld', 07:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:22 INFO - 'MOZ_NO_REMOTE': '1', 07:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:22 INFO - 'NO_EM_RESTART': '1', 07:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:22 INFO - 'PWD': '/builds/slave/test', 07:28:22 INFO - 'SHELL': '/bin/bash', 07:28:22 INFO - 'SHLVL': '1', 07:28:22 INFO - 'TERM': 'linux', 07:28:22 INFO - 'TMOUT': '86400', 07:28:22 INFO - 'USER': 'cltbld', 07:28:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:22 INFO - '_': '/tools/buildbot/bin/python'} 07:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:28:22 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 07:28:22 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 07:28:22 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 07:28:22 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 07:28:22 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 07:28:22 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 07:28:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:28:24 INFO - Installing collected packages: mozsystemmonitor 07:28:24 INFO - Running setup.py install for mozsystemmonitor 07:28:24 INFO - Successfully installed mozsystemmonitor 07:28:24 INFO - Cleaning up... 07:28:24 INFO - Return code: 0 07:28:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:24 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:24 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 07:28:24 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 07:28:24 INFO - Using env: {'DISPLAY': ':0', 07:28:24 INFO - 'HOME': '/home/cltbld', 07:28:24 INFO - 'LANG': 'en_US.UTF-8', 07:28:24 INFO - 'LANGUAGE': 'en_US:en', 07:28:24 INFO - 'LOGNAME': 'cltbld', 07:28:24 INFO - 'MAIL': '/var/mail/cltbld', 07:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:24 INFO - 'MOZ_NO_REMOTE': '1', 07:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:24 INFO - 'NO_EM_RESTART': '1', 07:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:24 INFO - 'PWD': '/builds/slave/test', 07:28:24 INFO - 'SHELL': '/bin/bash', 07:28:24 INFO - 'SHLVL': '1', 07:28:24 INFO - 'TERM': 'linux', 07:28:24 INFO - 'TMOUT': '86400', 07:28:24 INFO - 'USER': 'cltbld', 07:28:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:24 INFO - '_': '/tools/buildbot/bin/python'} 07:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:28:25 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 07:28:25 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 07:28:25 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 07:28:25 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 07:28:25 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 07:28:25 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 07:28:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:28:27 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 07:28:27 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 07:28:27 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 07:28:27 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 07:28:27 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 07:28:27 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 07:28:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:27 INFO - warning: no files found matching '*.txt' 07:28:27 INFO - no previously-included directories found matching 'build' 07:28:27 INFO - no previously-included directories found matching 'dist' 07:28:27 INFO - no previously-included directories found matching '.git*' 07:28:27 INFO - Installing collected packages: jsonschema, functools32 07:28:27 INFO - Running setup.py install for functools32 07:28:27 INFO - warning: no files found matching '*.txt' 07:28:27 INFO - no previously-included directories found matching 'build' 07:28:27 INFO - no previously-included directories found matching 'dist' 07:28:27 INFO - no previously-included directories found matching '.git*' 07:28:27 INFO - Successfully installed jsonschema functools32 07:28:27 INFO - Cleaning up... 07:28:27 INFO - Return code: 0 07:28:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:27 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:27 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 07:28:27 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 07:28:27 INFO - Using env: {'DISPLAY': ':0', 07:28:27 INFO - 'HOME': '/home/cltbld', 07:28:27 INFO - 'LANG': 'en_US.UTF-8', 07:28:27 INFO - 'LANGUAGE': 'en_US:en', 07:28:27 INFO - 'LOGNAME': 'cltbld', 07:28:27 INFO - 'MAIL': '/var/mail/cltbld', 07:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:27 INFO - 'MOZ_NO_REMOTE': '1', 07:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:27 INFO - 'NO_EM_RESTART': '1', 07:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:27 INFO - 'PWD': '/builds/slave/test', 07:28:27 INFO - 'SHELL': '/bin/bash', 07:28:27 INFO - 'SHLVL': '1', 07:28:27 INFO - 'TERM': 'linux', 07:28:27 INFO - 'TMOUT': '86400', 07:28:27 INFO - 'USER': 'cltbld', 07:28:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:27 INFO - '_': '/tools/buildbot/bin/python'} 07:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:28:27 INFO - Cleaning up... 07:28:27 INFO - Return code: 0 07:28:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:27 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:27 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 07:28:27 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 07:28:27 INFO - Using env: {'DISPLAY': ':0', 07:28:27 INFO - 'HOME': '/home/cltbld', 07:28:27 INFO - 'LANG': 'en_US.UTF-8', 07:28:27 INFO - 'LANGUAGE': 'en_US:en', 07:28:27 INFO - 'LOGNAME': 'cltbld', 07:28:27 INFO - 'MAIL': '/var/mail/cltbld', 07:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:27 INFO - 'MOZ_NO_REMOTE': '1', 07:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:27 INFO - 'NO_EM_RESTART': '1', 07:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:27 INFO - 'PWD': '/builds/slave/test', 07:28:27 INFO - 'SHELL': '/bin/bash', 07:28:27 INFO - 'SHLVL': '1', 07:28:27 INFO - 'TERM': 'linux', 07:28:27 INFO - 'TMOUT': '86400', 07:28:27 INFO - 'USER': 'cltbld', 07:28:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:27 INFO - '_': '/tools/buildbot/bin/python'} 07:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:28 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 07:28:28 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 07:28:28 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 07:28:28 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 07:28:28 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 07:28:28 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 07:28:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:30 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 07:28:30 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 07:28:30 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 07:28:30 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 07:28:30 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 07:28:30 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 07:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:30 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 07:28:30 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 07:28:30 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 07:28:30 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 07:28:30 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 07:28:30 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 07:28:30 INFO - Downloading docopt-0.6.1.tar.gz 07:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:30 INFO - Running setup.py install for blobuploader 07:28:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:30 INFO - Running setup.py install for requests 07:28:31 INFO - Running setup.py install for docopt 07:28:31 INFO - Successfully installed blobuploader requests docopt 07:28:31 INFO - Cleaning up... 07:28:31 INFO - Return code: 0 07:28:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:31 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:31 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 07:28:31 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 07:28:31 INFO - Using env: {'DISPLAY': ':0', 07:28:31 INFO - 'HOME': '/home/cltbld', 07:28:31 INFO - 'LANG': 'en_US.UTF-8', 07:28:31 INFO - 'LANGUAGE': 'en_US:en', 07:28:31 INFO - 'LOGNAME': 'cltbld', 07:28:31 INFO - 'MAIL': '/var/mail/cltbld', 07:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:31 INFO - 'MOZ_NO_REMOTE': '1', 07:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:31 INFO - 'NO_EM_RESTART': '1', 07:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:31 INFO - 'PWD': '/builds/slave/test', 07:28:31 INFO - 'SHELL': '/bin/bash', 07:28:31 INFO - 'SHLVL': '1', 07:28:31 INFO - 'TERM': 'linux', 07:28:31 INFO - 'TMOUT': '86400', 07:28:31 INFO - 'USER': 'cltbld', 07:28:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:31 INFO - '_': '/tools/buildbot/bin/python'} 07:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:31 INFO - Running setup.py (path:/tmp/pip-4zxeHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:31 INFO - Running setup.py (path:/tmp/pip-Yn5Hhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:31 INFO - Running setup.py (path:/tmp/pip-K6qZQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:31 INFO - Running setup.py (path:/tmp/pip-QrxSML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:31 INFO - Running setup.py (path:/tmp/pip-l44V_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:32 INFO - Running setup.py (path:/tmp/pip-JuuDLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:32 INFO - Running setup.py (path:/tmp/pip-TimcO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:32 INFO - Running setup.py (path:/tmp/pip-DrdieN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:32 INFO - Running setup.py (path:/tmp/pip-s71eAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:32 INFO - Running setup.py (path:/tmp/pip-QLM5ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:32 INFO - Running setup.py (path:/tmp/pip-ZlAqQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:32 INFO - Running setup.py (path:/tmp/pip-P9jZPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:32 INFO - Running setup.py (path:/tmp/pip-5ouzUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:32 INFO - Running setup.py (path:/tmp/pip-9USBoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:32 INFO - Running setup.py (path:/tmp/pip-tF2SV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:32 INFO - Running setup.py (path:/tmp/pip-IOT4tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:32 INFO - Running setup.py (path:/tmp/pip-qR3cvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:32 INFO - Running setup.py install for manifestparser 07:28:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Running setup.py install for mozcrash 07:28:33 INFO - Running setup.py install for mozdebug 07:28:33 INFO - Running setup.py install for mozdevice 07:28:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Running setup.py install for mozfile 07:28:33 INFO - Running setup.py install for mozhttpd 07:28:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Running setup.py install for mozinfo 07:28:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Running setup.py install for mozInstall 07:28:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Running setup.py install for mozleak 07:28:33 INFO - Running setup.py install for mozlog 07:28:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Running setup.py install for moznetwork 07:28:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:34 INFO - Running setup.py install for mozprocess 07:28:34 INFO - Running setup.py install for mozprofile 07:28:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:34 INFO - Running setup.py install for mozrunner 07:28:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:34 INFO - Running setup.py install for mozscreenshot 07:28:34 INFO - Running setup.py install for moztest 07:28:34 INFO - Running setup.py install for mozversion 07:28:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:34 INFO - Cleaning up... 07:28:34 INFO - Return code: 0 07:28:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:34 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')]} 07:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:34 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')]} 07:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:34 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:34 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 07:28:34 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 07:28:34 INFO - Using env: {'DISPLAY': ':0', 07:28:34 INFO - 'HOME': '/home/cltbld', 07:28:34 INFO - 'LANG': 'en_US.UTF-8', 07:28:34 INFO - 'LANGUAGE': 'en_US:en', 07:28:34 INFO - 'LOGNAME': 'cltbld', 07:28:34 INFO - 'MAIL': '/var/mail/cltbld', 07:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:34 INFO - 'MOZ_NO_REMOTE': '1', 07:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:34 INFO - 'NO_EM_RESTART': '1', 07:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:34 INFO - 'PWD': '/builds/slave/test', 07:28:34 INFO - 'SHELL': '/bin/bash', 07:28:34 INFO - 'SHLVL': '1', 07:28:34 INFO - 'TERM': 'linux', 07:28:34 INFO - 'TMOUT': '86400', 07:28:34 INFO - 'USER': 'cltbld', 07:28:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:34 INFO - '_': '/tools/buildbot/bin/python'} 07:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:34 INFO - Running setup.py (path:/tmp/pip-dTOQgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:35 INFO - Running setup.py (path:/tmp/pip-7xTopQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:35 INFO - Running setup.py (path:/tmp/pip-Ny5v2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:35 INFO - Running setup.py (path:/tmp/pip-IOAF_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:35 INFO - Running setup.py (path:/tmp/pip-hld0uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:35 INFO - Running setup.py (path:/tmp/pip-g2IAsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:35 INFO - Running setup.py (path:/tmp/pip-vcHD2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:35 INFO - Running setup.py (path:/tmp/pip-jVKXwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:35 INFO - Running setup.py (path:/tmp/pip-Y8N4Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:35 INFO - Running setup.py (path:/tmp/pip-F5MDyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:35 INFO - Running setup.py (path:/tmp/pip-4roJfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:35 INFO - Running setup.py (path:/tmp/pip-RhbXcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:35 INFO - Running setup.py (path:/tmp/pip-7dryV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:35 INFO - Running setup.py (path:/tmp/pip-aQO3hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:35 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)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:35 INFO - Running setup.py (path:/tmp/pip-hKdDbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:36 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)) 07:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:36 INFO - Running setup.py (path:/tmp/pip-0YrbsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:36 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)) 07:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:36 INFO - Running setup.py (path:/tmp/pip-7tO0OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:36 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)) 07:28:36 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)) 07:28:36 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)) 07:28:36 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)) 07:28:36 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)) 07:28:36 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)) 07:28:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:36 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 07:28:36 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 07:28:36 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 07:28:36 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 07:28:36 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 07:28:36 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 07:28:38 INFO - Downloading blessings-1.6.tar.gz 07:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:38 INFO - Installing collected packages: blessings 07:28:38 INFO - Running setup.py install for blessings 07:28:38 INFO - Successfully installed blessings 07:28:38 INFO - Cleaning up... 07:28:38 INFO - Return code: 0 07:28:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:38 INFO - Reading from file tmpfile_stdout 07:28:38 INFO - Current package versions: 07:28:38 INFO - argparse == 1.2.1 07:28:38 INFO - blessings == 1.6 07:28:38 INFO - blobuploader == 1.2.4 07:28:38 INFO - docopt == 0.6.1 07:28:38 INFO - functools32 == 3.2.3-2 07:28:38 INFO - jsonschema == 2.5.1 07:28:38 INFO - manifestparser == 1.1 07:28:38 INFO - mozInstall == 1.12 07:28:38 INFO - mozcrash == 1.0 07:28:38 INFO - mozdebug == 0.1 07:28:38 INFO - mozdevice == 0.49 07:28:38 INFO - mozfile == 1.2 07:28:38 INFO - mozhttpd == 0.7 07:28:38 INFO - mozinfo == 0.9 07:28:38 INFO - mozleak == 0.1 07:28:38 INFO - mozlog == 3.4 07:28:38 INFO - moznetwork == 0.27 07:28:38 INFO - mozprocess == 0.24 07:28:38 INFO - mozprofile == 0.28 07:28:38 INFO - mozrunner == 6.13 07:28:38 INFO - mozscreenshot == 0.1 07:28:38 INFO - mozsystemmonitor == 0.3 07:28:38 INFO - moztest == 0.8 07:28:38 INFO - mozversion == 1.4 07:28:38 INFO - psutil == 3.1.1 07:28:38 INFO - requests == 1.2.3 07:28:38 INFO - wsgiref == 0.1.2 07:28:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:38 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')]} 07:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:38 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')]} 07:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:38 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:38 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 07:28:38 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 07:28:38 INFO - Using env: {'DISPLAY': ':0', 07:28:38 INFO - 'HOME': '/home/cltbld', 07:28:38 INFO - 'LANG': 'en_US.UTF-8', 07:28:38 INFO - 'LANGUAGE': 'en_US:en', 07:28:38 INFO - 'LOGNAME': 'cltbld', 07:28:38 INFO - 'MAIL': '/var/mail/cltbld', 07:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:38 INFO - 'MOZ_NO_REMOTE': '1', 07:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:38 INFO - 'NO_EM_RESTART': '1', 07:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:38 INFO - 'PWD': '/builds/slave/test', 07:28:38 INFO - 'SHELL': '/bin/bash', 07:28:38 INFO - 'SHLVL': '1', 07:28:38 INFO - 'TERM': 'linux', 07:28:38 INFO - 'TMOUT': '86400', 07:28:38 INFO - 'USER': 'cltbld', 07:28:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:38 INFO - '_': '/tools/buildbot/bin/python'} 07:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 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)) 07:28:38 INFO - Cleaning up... 07:28:38 INFO - Return code: 0 07:28:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28:38 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')]} 07:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:38 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')]} 07:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:38 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eec630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, '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': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', '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 07:28:38 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 07:28:38 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 07:28:38 INFO - Using env: {'DISPLAY': ':0', 07:28:38 INFO - 'HOME': '/home/cltbld', 07:28:38 INFO - 'LANG': 'en_US.UTF-8', 07:28:38 INFO - 'LANGUAGE': 'en_US:en', 07:28:38 INFO - 'LOGNAME': 'cltbld', 07:28:38 INFO - 'MAIL': '/var/mail/cltbld', 07:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:38 INFO - 'MOZ_NO_REMOTE': '1', 07:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:38 INFO - 'NO_EM_RESTART': '1', 07:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:38 INFO - 'PWD': '/builds/slave/test', 07:28:38 INFO - 'SHELL': '/bin/bash', 07:28:38 INFO - 'SHLVL': '1', 07:28:38 INFO - 'TERM': 'linux', 07:28:38 INFO - 'TMOUT': '86400', 07:28:38 INFO - 'USER': 'cltbld', 07:28:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:38 INFO - '_': '/tools/buildbot/bin/python'} 07:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:28:39 INFO - Cleaning up... 07:28:39 INFO - Return code: 0 07:28:39 INFO - Running post-action listener: _resource_record_post_action 07:28:39 INFO - Running post-action listener: _start_resource_monitoring 07:28:39 INFO - Starting resource monitoring. 07:28:39 INFO - [mozharness: 2017-01-08 15:28:39.188370Z] Finished create-virtualenv step (success) 07:28:39 INFO - [mozharness: 2017-01-08 15:28:39.188877Z] Running install step. 07:28:39 INFO - Running pre-action listener: _resource_record_pre_action 07:28:39 INFO - Running main action method: install 07:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:39 INFO - Reading from file tmpfile_stdout 07:28:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:39 INFO - Reading from file tmpfile_stdout 07:28:39 INFO - Output received: 07:28:39 INFO - Usage: mozinstall [options] installer 07:28:39 INFO - Options: 07:28:39 INFO - -h, --help show this help message and exit 07:28:39 INFO - -d DEST, --destination=DEST 07:28:39 INFO - Directory to install application into. [default: 07:28:39 INFO - "/builds/slave/test"] 07:28:39 INFO - --app=APP Application being installed. [default: firefox] 07:28:39 INFO - mkdir: /builds/slave/test/build/application 07:28:39 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'] 07:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:28:55 INFO - Reading from file tmpfile_stdout 07:28:55 INFO - Output received: 07:28:55 INFO - /builds/slave/test/build/application/firefox/firefox 07:28:55 INFO - Running post-action listener: _resource_record_post_action 07:28:55 INFO - [mozharness: 2017-01-08 15:28:55.563950Z] Finished install step (success) 07:28:55 INFO - [mozharness: 2017-01-08 15:28:55.564225Z] Running run-tests step. 07:28:55 INFO - Running pre-action listener: _resource_record_pre_action 07:28:55 INFO - Running main action method: run_tests 07:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:55 INFO - Python 2.7.3 07:28:55 INFO - Return code: 0 07:28:55 INFO - grabbing minidump binary from tooltool 07:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:55 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 0x1f75850>, '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 0x1eea6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeab60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:55 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 07:28:55 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 07:28:55 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 07:28:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:55 INFO - Return code: 0 07:28:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:28:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:28:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:55 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:28:55 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:28:55 INFO - Using env: {'DISPLAY': ':0', 07:28:55 INFO - 'HOME': '/home/cltbld', 07:28:55 INFO - 'LANG': 'en_US.UTF-8', 07:28:55 INFO - 'LANGUAGE': 'en_US:en', 07:28:55 INFO - 'LOGNAME': 'cltbld', 07:28:55 INFO - 'MAIL': '/var/mail/cltbld', 07:28:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:55 INFO - 'MOZ_NO_REMOTE': '1', 07:28:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:55 INFO - 'NO_EM_RESTART': '1', 07:28:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:55 INFO - 'PWD': '/builds/slave/test', 07:28:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:55 INFO - 'SHELL': '/bin/bash', 07:28:55 INFO - 'SHLVL': '1', 07:28:55 INFO - 'TERM': 'linux', 07:28:55 INFO - 'TMOUT': '86400', 07:28:55 INFO - 'USER': 'cltbld', 07:28:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843', 07:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:55 INFO - '_': '/tools/buildbot/bin/python'} 07:28:55 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:28:55 INFO - mozversion application_buildid: 20170108145412 07:28:55 INFO - mozversion application_changeset: d192a99be4b436f2dc839435319f7630d5d8f4b0 07:28:55 INFO - mozversion application_display_name: Nightly 07:28:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:55 INFO - mozversion application_name: Firefox 07:28:55 INFO - mozversion application_remotingname: firefox 07:28:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:28:55 INFO - mozversion application_vendor: Mozilla 07:28:55 INFO - mozversion application_version: 53.0a1 07:28:55 INFO - mozversion platform_buildid: 20170108145412 07:28:55 INFO - mozversion platform_changeset: d192a99be4b436f2dc839435319f7630d5d8f4b0 07:28:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:28:55 INFO - mozversion platform_version: 53.0a1 07:28:55 INFO - using testdate: 1483889335 07:28:55 INFO - actual date: 1483889335 07:28:55 INFO - starting webserver on 'localhost:54893' 07:28:55 INFO - SUITE-START | Running 2 tests 07:28:55 INFO - TEST-START | dromaeo_css 07:28:55 INFO - operating with platform_type : linux_ 07:28:55 INFO - Initialising browser for dromaeo_css test... 07:28:55 INFO - TEST-INFO | started process 30809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpat_N3U/profile http://localhost:54893/getInfo.html) 07:28:56 INFO - PROCESS | 30809 | 1483889336378 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:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < 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 07:28:59 INFO - PROCESS | 30809 | __metrics Screen width/height:1600/1200 07:28:59 INFO - PROCESS | 30809 | colorDepth:24 07:28:59 INFO - PROCESS | 30809 | Browser inner width/height: 1024/697 07:28:59 INFO - PROCESS | 30809 | __metrics 07:29:00 INFO - PROCESS | 30809 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:29:00 INFO - PROCESS | 30809 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:01 INFO - PROCESS | 30809 | console.error: PushService: 07:29:01 INFO - PROCESS | 30809 | stateChangeProcessEnqueue: Error transitioning state 07:29:01 INFO - PROCESS | 30809 | UnknownError 07:29:01 INFO - TEST-INFO | 30809: exit 0 07:29:01 INFO - Browser initialized. 07:29:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:29:01 INFO - TEST-INFO | started process 30891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpat_N3U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:14 INFO - PROCESS | 30891 | RSS: Main: 152559616 07:29:14 INFO - PROCESS | 30891 | 07:32:18 INFO - PROCESS | 30891 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54893/tests/dromaeo/cssquery-ext.html) 07:32:19 INFO - PROCESS | 30891 | RSS: Main: 263868416 07:32:19 INFO - PROCESS | 30891 | 07:34:03 INFO - PROCESS | 30891 | ************************* 07:34:03 INFO - PROCESS | 30891 | A coding exception was thrown and uncaught in a Task. 07:34:03 INFO - PROCESS | 30891 | 07:34:03 INFO - PROCESS | 30891 | Full message: ReferenceError: fetch is not defined 07:34:03 INFO - PROCESS | 30891 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:34:03 INFO - PROCESS | 30891 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:34:03 INFO - PROCESS | 30891 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:34:03 INFO - PROCESS | 30891 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:34:03 INFO - PROCESS | 30891 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:34:03 INFO - PROCESS | 30891 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:34:03 INFO - PROCESS | 30891 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:34:03 INFO - PROCESS | 30891 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:34:03 INFO - PROCESS | 30891 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:34:03 INFO - PROCESS | 30891 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:34:03 INFO - PROCESS | 30891 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:34:03 INFO - PROCESS | 30891 | 07:34:03 INFO - PROCESS | 30891 | ************************* 07:35:21 INFO - PROCESS | 30891 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-ext.html (next: http://localhost:54893/tests/dromaeo/cssquery-jquery.html) 07:35:22 INFO - PROCESS | 30891 | RSS: Main: 234287104 07:35:22 INFO - PROCESS | 30891 | 07:38:24 INFO - PROCESS | 30891 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54893/tests/dromaeo/cssquery-mootools.html) 07:38:25 INFO - PROCESS | 30891 | RSS: Main: 184619008 07:38:25 INFO - PROCESS | 30891 | 07:41:27 INFO - PROCESS | 30891 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54893/tests/dromaeo/cssquery-prototype.html) 07:41:28 INFO - PROCESS | 30891 | RSS: Main: 215531520 07:41:28 INFO - PROCESS | 30891 | 07:44:31 INFO - PROCESS | 30891 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54893/tests/dromaeo/cssquery-yui.html) 07:44:31 INFO - PROCESS | 30891 | RSS: Main: 184811520 07:44:31 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-yui.html (next: http://localhost:54893/tests/dromaeo/cssquery-dojo.html) 07:47:35 INFO - PROCESS | 30891 | RSS: Main: 279248896 07:47:35 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | __start_tp_report 07:47:35 INFO - PROCESS | 30891 | _x_x_mozilla_page_load 07:47:35 INFO - PROCESS | 30891 | _x_x_mozilla_page_load_details 07:47:35 INFO - PROCESS | 30891 | |i|pagename|runs| 07:47:35 INFO - PROCESS | 30891 | |0;dojo.html;2561.462092960478;2573.047972250268;2603.2190342897125;2607.8696065196737;2611.1905309354115;4239.025024244425;4265.338872474764;4266.935995960063;4275.615194632483;4280.957190428095;4318.07161460286;4327.415798867152;4333.93499097513;4334.0681753423005;4355.063661312817;3992.3013472642315;4022.1151346703823;4029.536603290615;4049.068714195737;4075.0831063010883;4026.899327516821;4029.073313137965;4037.7375470594316;4051.5138183417885;4101.979490102545;3981.641652251297;4008.2584721826556;4018.6985976051765;4076.8776936691947;4101.958980410188;4051.108756073659;4058.4115303281155;4067.349224124126;4067.6542493888055;4094.979525102385;3866.941995870064;3957.6042395760483;4033.253848038122;4033.899152521181;4072.2059198456313;4336.371226172188;4338.566143385668;4357.694961352675;4373.125374925028;4383.342498625232;4601.907961840778;4603.608693261077;4605.171069207541;4607.055553611502;4647.465541462741;4470.932936005963;4496.910061798746;4563.292689633112;4619.976900115512;4633.2818413146015;4314.158739045887;4331;4355.4337936068105;4373.278409062469;4400.317950717644;4701.717896926195;4702.858914232578;4710.222813235846;4736.502667219961;4756.357891684578;4398.450193725785;4412.624926881187;4527.0493196429115;4528.660350473728;4532.365468834366;4502.57225563571;4525.208088584551;4529.977350113294;4577.313402989512;4601.976990115095;4519.050999290186;4548.522405147478;4555.817767289338;4555.931661025087;4597.149527337453;4516.893361126479;4568.520305367955;4574.062317224961;4578.839740609129;4602.792874320664;3771.2268984858038;3783.3379158647126;3810.504634397566;3818.6181381862148;3875.612438756158;3367.6800703933086;3392.338493993697;3401.9829900850336;3439.3465241604017;3443.104792753902;4347.217500849814;4367.235733746582;4367.5414081520985;4457.843975460908;4509.684322097487;4525.162844873709;4538.568835960578;4544.590986811203;4601.539846015372;4628.0281140960105;4374.737515749065;4393.406890069799;4405.096955124256;4408.7575183365225;4449.132419178294;3970.404439334123;3993.2612466693754;4027.939580906289;4030.0327921298676;4056.2495938250927;4789.042191561632;4812.687175333592;4821.975890120527;4829.927551086666;4887;4603.8158473662015;4607;4618.699784513996;4627.352170696173;4664.743439110882;4759.16714574941;4851.975740121418;4855.5387238213725;4862.513748625251;4905.558499735041;4448.399466072039;4512;4522.366868638327;4527.4340707411575;4602.07958408313;4631.814727410866;4632.907341853077;4635.420572428447;4635.582797548102;4679.181143299977;4517.09658068381;4523.86292834891;4525.479569849378;4528.841490547815;4571.26859702446;4411.9558804411545;4438.689291749675;4438.911221775482;4462.0629667768835;4463.218936686132;4392.231359512137;4400.163968845909;4419.403380543714;4440.777961101997;4444.422225110715;4499.685022048425;4519.096180763926;4522.186006518858;4536.9092618148115;4571.38286331341;4347.304431290978;4351.282038463744;4357.302831546937;4381.145676593033;4403.669724770591 07:47:35 INFO - PROCESS | 30891 | |1;ext.html;519.7349351830567;521.9321488206533;536.5921899356488;543.0577947261498;549.6674511920288;31829;39650;41932.58067419325;41991.58008419915;46042.30936535955;42718.35922461158;43005;43031;43038;43070;7615.9619201903915;7720.1121870985;7769.883451748228;7783.844323113534;7787.026621672291;7642.082950046002;9626.951865240664;9950.9502452488;10000.099991000809;10293.897061029369;10098.848517272247;10161.390316580992;10171.38971661699;10171.440570768642;10173.79652406955;9850.802983940317;9870.309078364517;9907.900920990769;9911.65309214174;9919.752006199868;9710.417374957526;9770.853437198448;9783.0706082922;9784.90215097847;9785.706428807147;33667.32665346704;33842.49236261458;33876.32247355039;33927.151821204665;33930.1517462063;3686.981565092184;3740.831662575191;3745.9625403745886;3795.6394142556414;3796.6772824309965;30374.696253037408;30477.238069048228;30675.539866901792;30810;31919;3440.3807314683345;3445.2248244145117;3458.9654103459147;3530.4704294355797;3561.305545418644;247714;249443.9999999982;249992;250989;252404;56727.71636141875;57002;57073.71463142741;57089;57094.7145264271;61346.69326653338;61347.6932615343;61355.693221533606;61403;61440.94063068601;14244.572662820132;14326.928365358106;14348.282585870873;14376;14421.855781442262;10000.949995250123;10414.531346089445;10822.945885270523;10832.350058996486;10900.236983411243;16771.748423773653;17352.739708904377;17404.912975435043;17506.824931750773;17635.911820441073;6412.967935160387;6608.702608382634;6620.569662971891;6625.801225963229;6707.631080290631;794.8489786940578;804.3484777330381;805.3355981315439;809.8218391953761;829.307528213936;27637.447251054866;28260.293492662848;28745.71254287472;28795.424091518053;29008;938.6245501799335;947.2753343691943;950.6435086842434;966.4346357381011;1057.0116940660353;14766.557003289918;15320.310586023656;15392.922495425213;15437;15443.200950777504;344263;346344;346896;349099;351456.0971097998;52667.473325266255;52832.47167528352;52833;52881.206781897534;52890;1211.1703483114095;1219.9573014944435;1246.7880460321949;1253.974920501603;1254.2787896959285;26011.479770404865;27053.59419608668;27329.590056148776;27831.582526261718;27846.44307113806;37471.62528374681;37748;37818.24363512659;37821.05447363838;37867.887835143;266544;267052;267167;267252;268228;32754;34018;34026.489602655485;36850.63149368472;38204.80897595494;39208.411873822486;46788;47140.7642961783;47172.03651031194;48294;36538.451923220644;36885.631143689294;37085.25829483449;37466.2506749858;37764.24471510609;36517.34226067712;37330.6266937338;37429.62570374261;37848.86453406402;38413.23173536458;35467.46798797968;35922;35960.460593090604;36305.45541816928;36713.265734685694;30593.23516912095;33293.667063329056;33552.66447335593;33644.66355336415;33817.15457113592;22280.220192293193;23432.648510272018;23802;24976.875115624305;25303.87348063248 07:47:35 INFO - PROCESS | 30891 | |2;jquery.html;338.74424809269;368.5577307231323;372.69439059970824;373.7813379173183;387.73246459942635;13474.124181928168;16271.51185464435;16904.746428803577;17490.650186996252;18799.342023029196;16819.32722691094;16898.83101168988;17070.573235669115;17105.657886842255;17112.82887171128;4994.999999999991;5111.642185047048;5299.920501192485;5318.095923692981;5362.570994320465;3546.5034895114704;3688.6680198782105;5343.706096164709;5382.111951527993;5590.972045139769;5817.534597232232;5931.644101353911;5955.362275374285;5955.761769529214;5959;5394.1908713692865;5419.783208671648;5423.240746295522;5514.503694667499;5950.256217972754;5277.205750044965;5317.1492561190025;5324.227986941872;5326.573874090063;5341.225522299244;11267.21129520934;11430.199886007982;11445.484953177127;11560.76878462426;11581.247218930743;2055.8149766521083;2119.5760847830497;2153.720016397874;2208.8012078912816;2240.6078936186263;8702.956485217534;8858.68994585193;9278.025807290205;11720.120990925714;13082.607521774362;1678.6894424531501;1737.148797089417;1750.518607382967;1753.281154726556;1781.186895624437;78241;78573;78654;78674.60662696707;81143.5942820282;8351;8833.55832208387;8875.023747387782;8912.287017038621;9652.469114198646;11850.170488065753;11920.284782913053;11934.22427542207;11966.700832479257;12136.87863121375;6723.562968407038;6729.461643068543;6917.239103698589;6937.861242775116;6938.8612227756175;6623.381804400368;6641.435477984329;6881.621510816853;6905.965470172718;6906.37842594169;3610.9097272568397;3670.376036073874;3758.210775737126;3792.009195172501;3847.961520384816;1750.5098572399747;1756.7628370169864;1780.1900135438602;1784.090114041848;1847.5473508990115;931.7158266728712;961.1733908838394;962.831504486712;988.8961659025699;994.4132961552718;16754.664906701797;17038.403655871985;17166.22751976164;17571.73642395365;17810.287588496572;915.7481692534473;924.930630202724;931.1340453378423;935.7192842147329;936.784539555906;9038;9368.859467107999;9570.282228832866;9613.509905964587;9794.069563391466;480908;485507;486917;493203;501401;91050;95938.52030739802;97570.51214743881;100900;101085.49457252667;936.8032713130319;940.9576569054409;980.8626792249091;980.8675828763169;986.8766404199619;15748.291326890088;15886.046837189806;15934.840651593335;15974.201289935689;16180.514584562481;39577.80211098926;39961;40232.396514052896;40313;41281.793591031856;49719.25421118759;55793.86267510652;56435.43564564302;56751.71624141853;57704;6801.9319806801295;6999.860002799814;7030.3478682510595;7067.71729130829;7475.551466912003;9339.252859771066;10239.232057595562;10338.534765935401;10346.741331466774;10787.244892857425;8516;8595.613197406257;8655.091215422543;8755.16141610269;9212.631494740403;8955.776105597412;9076.228520575562;9089.863652045357;9185.173334399937;9552.331336806357;9002.549872506479;9088.272938164799;9110.90889091127;9443.858342124737;9564.33049686543;6825.180978282638;6837.863242735217;6984.987176859226;7071.080759501232;7201.063861697946;8330.458520196167;10151.847722284025;10194;10505.78988420212;10612.097971672494 07:47:35 INFO - PROCESS | 30891 | |3;mootools.html;1327.2368388176799;1361.9046666733332;1380.8412032616252;1389.0970868935192;1396.2599822094292;6954.582725036495;7302.306280903319;7304.525205861615;7313.195548489669;7334.853302933945;6399.104125422433;6571.112899758543;6869.9656501717545;7037.507374483788;7147.535410198334;2036.4806974221553;2070.7411573553304;2073.5645514441985;2077.6156411063926;2080.074366906727;1997.4107638246753;2085.2493102483095;2095.224766836273;2095.5389814240843;2102.6530622447353;1877.155280123943;1939.5732938753451;2047.7235573197652;2075.2529089527834;2103.5372218112066;1951.6389467948404;1952.1215453046186;1954.159711324123;1954.7947465516058;1955.9608807823763;2028.6652702304102;2049.1803278688494;2059.4542446251753;2088.6553718636405;2092.6442504774072;7252.927470725278;7256;7265.782026539212;7314.670839812221;7332;4328.5455027222315;4417;4417.050334178135;4443.977780111079;4446.377507149002;2599.2592111248205;2704.716004819505;2721.537338652434;2758.9310267243277;2765.460735156645;953.3279038277998;1001.3441196016548;1007.2999265510473;1027.5941003303653;1028.4703377760459;9568.33021688482;9578.090081442251;9594.520273986273;9618.711438656781;9618.9519052405;3718.8326525306425;3880.708946828999;3954.149857780591;3984.063745019918;3992.1017771001875;8274.958625206835;8294.419390642597;8334.458260213067;8335.95832020836;8348.916510834935;4307.741535507879;4346.36977638247;4352.521222665504;4353.1293741251875;4359.782010899442;3968.940465893014;3987.80060996949;3990.082281075369;3995.180987897474;4025.3156963316305;3449.844756985942;3453.2575496268423;3531.8940431787087;3535.045537704805;3543.450765131357;1117.1509652664033;1118.7426891814928;1129.678041758095;1133.3426612564692;1134.797115058041;641.5701480008405;655.2137435077831;661.9238787539495;665.1452883045264;669.4142625202948;4706.199946009118;4718.127146477913;4732.313814496947;4802.783874725646;4941.950580494221;476.2047380873949;480;480.10460491184386;485.55329097230634;807.3904202327205;3326.3014766898737;3355.496675498695;3375.6624337566536;3377.2401209727614;3468.427709427916;8361.707340243061;8476.915230847735;8569.400141990001;8615.956920215358;8627.309815214894;8508;8527.573621318908;8531.402801803813;8543.316534677211;8559.229669329665;6861.416779573792;6868.244493105854;6872.862542749117;6874.106366172366;6937.549059311129;4731;4770.4275486940405;4812.181929072136;4919.163742163769;5048.671836330626;7588.392928565812;7668.079830420385;7901.288884000238;7998.3201427879285;8005.279524842792;7940.523568585903;7974;7976.84046319082;7978.401619878417;8118.147594502492;6279.686015699288;6347.174867267226;6378.968105159444;6391.137196478416;6419.711113000019;6752.527323087336;6789.15135608049;6798.048273241849;6818.624975626388;6860.176778786378;6235.282942461675;6291.402316779899;6331.398517140864;6348.650824204528;6407.935920640734;6132.6627035513475;6199.969000154971;6213.689315534296;6216.347283535164;6222.719977601109;5559.499645031967;5652.689102099424;5665.943340566707;5670.007748644053;5680.886382272414;4236.597523235288;4260.169266992907;4264.381664658545;4280.363830925589;4386.758728269976;4190.413342132043;4235.618794308527;4257.19113368459;4361.476622805284;4420.690551661352 07:47:35 INFO - PROCESS | 30891 | |4;prototype.html;311.62760501201046;316.44779859145797;319.1701575902652;331.86725309876044;334.2446071877558;4182.309918863388;4259.70182087254;4328;4336.3278691802825;4371.289800323796;4270.786460676969;4271.145770845836;4308.246056940038;4308.2891322931755;4336.262835317995;3267.2648654052828;3403;3428.502867084271;3431.227973705909;3454.1191996040975;3313.453280208763;3374.3926093303194;3407.5399821024216;3445.534852794878;3446.4313388291025;3402.42158832999;3418.8119653419053;3420.880269190579;3423.6062852771875;3424.7260219182403;3403.3703764803467;3415.7438192135687;3416.555847739778;3421.8460169292443;3432.3135372925267;2872.4111557130736;2888.638920134983;2940.7059294070636;2967.3916847046303;3022.80351777136;4200.537940826506;4206.26390381682;4212.53662097169;4214.452121224252;4215.156968606291;3808.809559522013;3809.276237514863;3821.713371497121;3822.37549041659;3826.3877779555414;4374.212641724488;4414.933775993362;4488.236999710057;4495.370648109268;4497.9775101124615;3183.3474137801927;3202.647708752035;3211.5343275224964;3211.8394080295893;3214.9196270093203;4635.2120139576355;4646.163690535702;4649.442066951953;4649.744264065441;4657.88355291117;3284.901452956415;3289.9342013159603;3291.127851119455;3316.7512436567354;3332.250243695149;3375.274316022018;3380.5267262582765;3383.763136580416;3383.881564145243;3390.2371966307383;3647.708183345326;3785.6782173515007;3816.46569480273;3821.331267028259;3831.5210598675167;4503;4503.121891231179;4503.234450143484;4513.954860451354;4522.8643140705835;1133.5522468624847;1137.391495549877;1138.362516990488;1140.298716289476;1140.4034351907396;755.4814822207293;792.8107838242636;799.6361655446758;801.7394346837301;802.7070119406375;4290.82836686529;4329.545397733255;4333.501647310537;4343.652507799368;4349.869503914888;4498.887527811766;4530.501644819067;4530.977345113253;4545;4546.977265113719;4315.741055536678;4320.697551171388;4321.67587430944;4335.501417336984;4338.414314067623;2253.504229069602;2377.037299893546;2387.8089752819733;2388.23576455536;2403.6299309393476;4748.477667456577;4762.618990480753;4767.856964291077;4774.188387974053;4787.61699064074;4609.262517997105;4612.310151878483;4630.930536041962;4636.095961287517;4666.859994200179;4592.827245147785;4796.544328288807;4799.400074990696;4814.446338670958;4831.154547954094;4538.977305113453;4546.181687296318;4547.045120524727;4550;4557.886052848706;4410.625096866802;4468.536883914991;4492.618127459203;4494.4606647202545;4510.413646225969;4630.976845115752;4801.791176059052;4802.271182374273;4868.805247790048;4920.803167873388;3316.1709572606846;3329.7669163159317;3333.3666603345287;3338.382399256145;3341.415252330784;4470.24005918988;4638.211504044388;4644.256918892961;4656.254999200111;4660.720356778605;4502.5199926073765;4504.369388285577;4510.143072816154;4526.434195725535;4531.365608814835;4478.820847166076;4479.70881892676;4482.686211965131;4517.277235642281;4519.774011299488;4417.690761646654;4427.8893027673275;4431.446069241345;4441.955580444283;4470;4289.957100429081;4545.090981803719;4549.613282870993;4555.658325625525;4559.886002849956;4433.733975961452;4436.778161091868;4441.866743997685;4448.933266000948;4478.171538265431 07:47:35 INFO - PROCESS | 30891 | |5;yui.html;652.8367908022994;660.9471242300616;727.7380143148465;755.4938191411753;770.349055048484;12050;13084.803727944076;13096.214227146378;13125.737485250313;13126.540571080013;13268.203907765517;13319.334033298344;13325.46698132076;13330.133541319832;13469.259190744506;639.3957709964086;657.4773055420952;756.5649751392943;767.3209209849296;775.248009430854;789.9723509677162;790.474334567512;791.1732239809385;791.5685951156605;791.9287264146226;828.8300898315831;829.3365307753803;830.779843341515;830.900291964965;831.268483734313;679.4937771360344;693.9444844412435;694.1947341084318;697.435077587151;826.8263664630434;588.6115163991744;607.0863350657277;610.4353473037467;611.1108337369117;612.0665984373866;12714.173578717446;12716.872831271661;12740.299283539494;12750.681232969157;12752.426140823685;12761.553345632858;12797.744045119045;12841.807372889414;12848.614541563767;12867.871321286855;11317.094632429385;11444.599439019677;11500.252483588623;11820.645380638594;11892.621475704893;4048.6761059115493;4063.878083657495;4105.0763578194965;4264.275073237557;4278.72188307759;60926;61114.38885611176;61915.69042154805;62322.37677623211;63777;9511.096445837635;9669.468179250069;9689.982551832098;9715.368501047551;9886.406815591088;17504.912475437795;17650.735238971425;17725.911370443064;18471.90764046171;18479.53801154955;6673.699683514156;6781.762638307636;6868.210155832143;6899.137607799025;7130.857382852314;3530.894073177809;3586.6234045424853;3604.981975090108;3661.176235347026;3667.1932174921476;2769.8476583787683;2819.3938303264895;2833.334166470878;2833.943321133566;2834.8299102053943;502.3218654816042;513.1609817947608;515.2914742229434;540.9107497262908;570.8943845388617;604.1722839709538;617.5831313863124;623.7130919776954;628.6573817269599;632.8101569529123;8858.42420242695;9188.586513606904;9298.210536838922;9598.520073996273;9642.71071867845;502.53264464048056;523.9318888544541;533.0937406409042;544.6595877576515;545.4109561673383;4007.358822588372;4127.814248358831;4284.635805956466;4462.620677242471;4543.204939135638;59584.702076490204;63319;64509.67745161338;64568.03147952785;64921.35078649153;54312.185317220275;55220;56402.43597563972;56890.14664780031;56945.715271423374;42590.36114458224;42848.78575607102;43399.566004339555;49463;51667.7416612922;9336.859947100664;9863.506824658594;9987.450690212108;10260.435676037889;10300.175985920958;33944.15139621529;34248.14379640529;34258.82870585731;35309.64690353166;36609;40526.79736601298;40751.388729168495;43056.35415468833;43279;44354.334684979105;10853.782924341627;10879;10982.341059536133;11099.334039957628;11430.085593152362;12771.361431928552;13096.410661520446;13177.868221317663;14035.789463158266;14059.578212653636;11646.825297620711;12088.576899808464;12504.923689052295;12511.311877846441;12609.684757881127;11762.176647634584;11819.172657913863;11896.702582435162;12550.623481295575;12588.937055314665;11788.587399440978;12155.75688486243;12175.269483830998;12282.324472154118;12761.234325940473;8842.91157088421;9503.19222866064;9599.664011759554;9729.270304727032;10114.898851011396;9338.766530836783;9353.719388418358;9372.39079459833;9391.671291504765;9527.76180595463 07:47:35 INFO - PROCESS | 30891 | __end_tp_report 07:47:35 INFO - PROCESS | 30891 | __start_cc_report 07:47:35 INFO - PROCESS | 30891 | _x_x_mozilla_cycle_collect,1086 07:47:35 INFO - PROCESS | 30891 | __end_cc_report 07:47:35 INFO - PROCESS | 30891 | __startTimestamp1483890455346__endTimestamp 07:47:35 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | ------- Summary: start ------- 07:47:35 INFO - PROCESS | 30891 | Number of tests: 6 07:47:35 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | [#0] dojo.html Cycles:165 Average:4318.34 Median:4419.40 stddev:430.75 (9.7%) stddev-sans-first:409.43 07:47:35 INFO - PROCESS | 30891 | Values: 2561.5 2573.0 2603.2 2607.9 2611.2 4239.0 4265.3 4266.9 4275.6 4281.0 4318.1 4327.4 4333.9 4334.1 4355.1 3992.3 4022.1 4029.5 4049.1 4075.1 4026.9 4029.1 4037.7 4051.5 4102.0 3981.6 4008.3 4018.7 4076.9 4102.0 4051.1 4058.4 4067.3 4067.7 4095.0 3866.9 3957.6 4033.3 4033.9 4072.2 4336.4 4338.6 4357.7 4373.1 4383.3 4601.9 4603.6 4605.2 4607.1 4647.5 4470.9 4496.9 4563.3 4620.0 4633.3 4314.2 4331.0 4355.4 4373.3 4400.3 4701.7 4702.9 4710.2 4736.5 4756.4 4398.5 4412.6 4527.0 4528.7 4532.4 4502.6 4525.2 4530.0 4577.3 4602.0 4519.1 4548.5 4555.8 4555.9 4597.1 4516.9 4568.5 4574.1 4578.8 4602.8 3771.2 3783.3 3810.5 3818.6 3875.6 3367.7 3392.3 3402.0 3439.3 3443.1 4347.2 4367.2 4367.5 4457.8 4509.7 4525.2 4538.6 4544.6 4601.5 4628.0 4374.7 4393.4 4405.1 4408.8 4449.1 3970.4 3993.3 4027.9 4030.0 4056.2 4789.0 4812.7 4822.0 4829.9 4887.0 4603.8 4607.0 4618.7 4627.4 4664.7 4759.2 4852.0 4855.5 4862.5 4905.6 4448.4 4512.0 4522.4 4527.4 4602.1 4631.8 4632.9 4635.4 4635.6 4679.2 4517.1 4523.9 4525.5 4528.8 4571.3 4412.0 4438.7 4438.9 4462.1 4463.2 4392.2 4400.2 4419.4 4440.8 4444.4 4499.7 4519.1 4522.2 4536.9 4571.4 4347.3 4351.3 4357.3 4381.1 4403.7 07:47:35 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | [#1] ext.html Cycles:180 Average:45781.16 Median:36411.40 stddev:76261.77 (209.4%) stddev-sans-first:76399.98 07:47:35 INFO - PROCESS | 30891 | Values: 519.7 521.9 536.6 543.1 549.7 31829.0 39650.0 41932.6 41991.6 46042.3 42718.4 43005.0 43031.0 43038.0 43070.0 7616.0 7720.1 7769.9 7783.8 7787.0 7642.1 9627.0 9951.0 10000.1 10293.9 10098.8 10161.4 10171.4 10171.4 10173.8 9850.8 9870.3 9907.9 9911.7 9919.8 9710.4 9770.9 9783.1 9784.9 9785.7 33667.3 33842.5 33876.3 33927.2 33930.2 3687.0 3740.8 3746.0 3795.6 3796.7 30374.7 30477.2 30675.5 30810.0 31919.0 3440.4 3445.2 3459.0 3530.5 3561.3 247714.0 249444.0 249992.0 250989.0 252404.0 56727.7 57002.0 57073.7 57089.0 57094.7 61346.7 61347.7 61355.7 61403.0 61440.9 14244.6 14326.9 14348.3 14376.0 14421.9 10000.9 10414.5 10822.9 10832.4 10900.2 16771.7 17352.7 17404.9 17506.8 17635.9 6413.0 6608.7 6620.6 6625.8 6707.6 794.8 804.3 805.3 809.8 829.3 27637.4 28260.3 28745.7 28795.4 29008.0 938.6 947.3 950.6 966.4 1057.0 14766.6 15320.3 15392.9 15437.0 15443.2 344263.0 346344.0 346896.0 349099.0 351456.1 52667.5 52832.5 52833.0 52881.2 52890.0 1211.2 1220.0 1246.8 1254.0 1254.3 26011.5 27053.6 27329.6 27831.6 27846.4 37471.6 37748.0 37818.2 37821.1 37867.9 266544.0 267052.0 267167.0 267252.0 268228.0 32754.0 34018.0 34026.5 36850.6 38204.8 39208.4 46788.0 47140.8 47172.0 48294.0 36538.5 36885.6 37085.3 37466.3 37764.2 36517.3 37330.6 37429.6 37848.9 38413.2 35467.5 35922.0 35960.5 36305.5 36713.3 30593.2 33293.7 33552.7 33644.7 33817.2 22280.2 23432.6 23802.0 24976.9 25303.9 07:47:35 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | [#2] jquery.html Cycles:180 Average:27634.56 Median:5372.34 stddev:81048.02 (1508.6%) stddev-sans-first:81249.47 07:47:35 INFO - PROCESS | 30891 | Values: 338.7 368.6 372.7 373.8 387.7 13474.1 16271.5 16904.7 17490.7 18799.3 16819.3 16898.8 17070.6 17105.7 17112.8 4995.0 5111.6 5299.9 5318.1 5362.6 3546.5 3688.7 5343.7 5382.1 5591.0 5817.5 5931.6 5955.4 5955.8 5959.0 5394.2 5419.8 5423.2 5514.5 5950.3 5277.2 5317.1 5324.2 5326.6 5341.2 11267.2 11430.2 11445.5 11560.8 11581.2 2055.8 2119.6 2153.7 2208.8 2240.6 8703.0 8858.7 9278.0 11720.1 13082.6 1678.7 1737.1 1750.5 1753.3 1781.2 78241.0 78573.0 78654.0 78674.6 81143.6 8351.0 8833.6 8875.0 8912.3 9652.5 11850.2 11920.3 11934.2 11966.7 12136.9 6723.6 6729.5 6917.2 6937.9 6938.9 6623.4 6641.4 6881.6 6906.0 6906.4 3610.9 3670.4 3758.2 3792.0 3848.0 1750.5 1756.8 1780.2 1784.1 1847.5 931.7 961.2 962.8 988.9 994.4 16754.7 17038.4 17166.2 17571.7 17810.3 915.7 924.9 931.1 935.7 936.8 9038.0 9368.9 9570.3 9613.5 9794.1 480908.0 485507.0 486917.0 493203.0 501401.0 91050.0 95938.5 97570.5 100900.0 101085.5 936.8 941.0 980.9 980.9 986.9 15748.3 15886.0 15934.8 15974.2 16180.5 39577.8 39961.0 40232.4 40313.0 41281.8 49719.3 55793.9 56435.4 56751.7 57704.0 6801.9 6999.9 7030.3 7067.7 7475.6 9339.3 10239.2 10338.5 10346.7 10787.2 8516.0 8595.6 8655.1 8755.2 9212.6 8955.8 9076.2 9089.9 9185.2 9552.3 9002.5 9088.3 9110.9 9443.9 9564.3 6825.2 6837.9 6985.0 7071.1 7201.1 8330.5 10151.8 10194.0 10505.8 10612.1 07:47:35 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | [#3] mootools.html Cycles:180 Average:4713.66 Median:480.05 stddev:2579.12 (537.3%) stddev-sans-first:2573.80 07:47:35 INFO - PROCESS | 30891 | Values: 1327.2 1361.9 1380.8 1389.1 1396.3 6954.6 7302.3 7304.5 7313.2 7334.9 6399.1 6571.1 6870.0 7037.5 7147.5 2036.5 2070.7 2073.6 2077.6 2080.1 1997.4 2085.2 2095.2 2095.5 2102.7 1877.2 1939.6 2047.7 2075.3 2103.5 1951.6 1952.1 1954.2 1954.8 1956.0 2028.7 2049.2 2059.5 2088.7 2092.6 7252.9 7256.0 7265.8 7314.7 7332.0 4328.5 4417.0 4417.1 4444.0 4446.4 2599.3 2704.7 2721.5 2758.9 2765.5 953.3 1001.3 1007.3 1027.6 1028.5 9568.3 9578.1 9594.5 9618.7 9619.0 3718.8 3880.7 3954.1 3984.1 3992.1 8275.0 8294.4 8334.5 8336.0 8348.9 4307.7 4346.4 4352.5 4353.1 4359.8 3968.9 3987.8 3990.1 3995.2 4025.3 3449.8 3453.3 3531.9 3535.0 3543.5 1117.2 1118.7 1129.7 1133.3 1134.8 641.6 655.2 661.9 665.1 669.4 4706.2 4718.1 4732.3 4802.8 4942.0 476.2 480.0 480.1 485.6 807.4 3326.3 3355.5 3375.7 3377.2 3468.4 8361.7 8476.9 8569.4 8616.0 8627.3 8508.0 8527.6 8531.4 8543.3 8559.2 6861.4 6868.2 6872.9 6874.1 6937.5 4731.0 4770.4 4812.2 4919.2 5048.7 7588.4 7668.1 7901.3 7998.3 8005.3 7940.5 7974.0 7976.8 7978.4 8118.1 6279.7 6347.2 6379.0 6391.1 6419.7 6752.5 6789.2 6798.0 6818.6 6860.2 6235.3 6291.4 6331.4 6348.7 6407.9 6132.7 6200.0 6213.7 6216.3 6222.7 5559.5 5652.7 5665.9 5670.0 5680.9 4236.6 4260.2 4264.4 4280.4 4386.8 4190.4 4235.6 4257.2 4361.5 4420.7 07:47:35 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | [#4] prototype.html Cycles:180 Average:3794.69 Median:4336.30 stddev:1104.65 (25.5%) stddev-sans-first:1076.37 07:47:35 INFO - PROCESS | 30891 | Values: 311.6 316.4 319.2 331.9 334.2 4182.3 4259.7 4328.0 4336.3 4371.3 4270.8 4271.1 4308.2 4308.3 4336.3 3267.3 3403.0 3428.5 3431.2 3454.1 3313.5 3374.4 3407.5 3445.5 3446.4 3402.4 3418.8 3420.9 3423.6 3424.7 3403.4 3415.7 3416.6 3421.8 3432.3 2872.4 2888.6 2940.7 2967.4 3022.8 4200.5 4206.3 4212.5 4214.5 4215.2 3808.8 3809.3 3821.7 3822.4 3826.4 4374.2 4414.9 4488.2 4495.4 4498.0 3183.3 3202.6 3211.5 3211.8 3214.9 4635.2 4646.2 4649.4 4649.7 4657.9 3284.9 3289.9 3291.1 3316.8 3332.3 3375.3 3380.5 3383.8 3383.9 3390.2 3647.7 3785.7 3816.5 3821.3 3831.5 4503.0 4503.1 4503.2 4514.0 4522.9 1133.6 1137.4 1138.4 1140.3 1140.4 755.5 792.8 799.6 801.7 802.7 4290.8 4329.5 4333.5 4343.7 4349.9 4498.9 4530.5 4531.0 4545.0 4547.0 4315.7 4320.7 4321.7 4335.5 4338.4 2253.5 2377.0 2387.8 2388.2 2403.6 4748.5 4762.6 4767.9 4774.2 4787.6 4609.3 4612.3 4630.9 4636.1 4666.9 4592.8 4796.5 4799.4 4814.4 4831.2 4539.0 4546.2 4547.0 4550.0 4557.9 4410.6 4468.5 4492.6 4494.5 4510.4 4631.0 4801.8 4802.3 4868.8 4920.8 3316.2 3329.8 3333.4 3338.4 3341.4 4470.2 4638.2 4644.3 4656.3 4660.7 4502.5 4504.4 4510.1 4526.4 4531.4 4478.8 4479.7 4482.7 4517.3 4519.8 4417.7 4427.9 4431.4 4442.0 4470.0 4290.0 4545.1 4549.6 4555.7 4559.9 4433.7 4436.8 4441.9 4448.9 4478.2 07:47:35 INFO - PROCESS | 30891 | 07:47:35 INFO - PROCESS | 30891 | [#5] yui.html Cycles:180 Average:14521.74 Median:27003.10 stddev:17529.68 (64.9%) stddev-sans-first:17547.92 07:47:35 INFO - PROCESS | 30891 | Values: 652.8 660.9 727.7 755.5 770.3 12050.0 13084.8 13096.2 13125.7 13126.5 13268.2 13319.3 13325.5 13330.1 13469.3 639.4 657.5 756.6 767.3 775.2 790.0 790.5 791.2 791.6 791.9 828.8 829.3 830.8 830.9 831.3 679.5 693.9 694.2 697.4 826.8 588.6 607.1 610.4 611.1 612.1 12714.2 12716.9 12740.3 12750.7 12752.4 12761.6 12797.7 12841.8 12848.6 12867.9 11317.1 11444.6 11500.3 11820.6 11892.6 4048.7 4063.9 4105.1 4264.3 4278.7 60926.0 61114.4 61915.7 62322.4 63777.0 9511.1 9669.5 9690.0 9715.4 9886.4 17504.9 17650.7 17725.9 18471.9 18479.5 6673.7 6781.8 6868.2 6899.1 7130.9 3530.9 3586.6 3605.0 3661.2 3667.2 2769.8 2819.4 2833.3 2833.9 2834.8 502.3 513.2 515.3 540.9 570.9 604.2 617.6 623.7 628.7 632.8 8858.4 9188.6 9298.2 9598.5 9642.7 502.5 523.9 533.1 544.7 545.4 4007.4 4127.8 4284.6 4462.6 4543.2 59584.7 63319.0 64509.7 64568.0 64921.4 54312.2 55220.0 56402.4 56890.1 56945.7 42590.4 42848.8 43399.6 49463.0 51667.7 9336.9 9863.5 9987.5 10260.4 10300.2 33944.2 34248.1 34258.8 35309.6 36609.0 40526.8 40751.4 43056.4 43279.0 44354.3 10853.8 10879.0 10982.3 11099.3 11430.1 12771.4 13096.4 13177.9 14035.8 14059.6 11646.8 12088.6 12504.9 12511.3 12609.7 11762.2 11819.2 11896.7 12550.6 12588.9 11788.6 12155.8 12175.3 12282.3 12761.2 8842.9 9503.2 9599.7 9729.3 10114.9 9338.8 9353.7 9372.4 9391.7 9527.8 07:47:35 INFO - PROCESS | 30891 | -------- Summary: end -------- 07:47:35 INFO - PROCESS | 30891 | 07:47:36 INFO - TEST-INFO | 30891: exit 0 07:47:36 INFO - TEST-OK | dromaeo_css | took 1120412ms 07:47:36 INFO - TEST-START | kraken 07:47:36 INFO - operating with platform_type : linux_ 07:47:36 INFO - Initialising browser for kraken test... 07:47:36 INFO - TEST-INFO | started process 31308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzssAB/profile http://localhost:54893/getInfo.html) 07:47:36 INFO - PROCESS | 31308 | 1483890456749 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:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < 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 07:47:40 INFO - PROCESS | 31308 | __metrics Screen width/height:1600/1200 07:47:40 INFO - PROCESS | 31308 | colorDepth:24 07:47:40 INFO - PROCESS | 31308 | Browser inner width/height: 1024/697 07:47:40 INFO - PROCESS | 31308 | __metrics 07:47:41 INFO - PROCESS | 31308 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:47:41 INFO - PROCESS | 31308 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:41 INFO - PROCESS | 31308 | console.error: PushService: 07:47:41 INFO - PROCESS | 31308 | stateChangeProcessEnqueue: Error transitioning state 07:47:41 INFO - PROCESS | 31308 | UnknownError 07:47:42 INFO - TEST-INFO | 31308: exit 0 07:47:42 INFO - Browser initialized. 07:47:42 INFO - Running cycle 1/1 for kraken test... 07:47:42 INFO - TEST-INFO | started process 31392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzssAB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:54 INFO - PROCESS | 31392 | RSS: Main: 152162304 07:47:54 INFO - PROCESS | 31392 | 07:47:57 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54893/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:58 INFO - PROCESS | 31392 | RSS: Main: 205975552 07:47:58 INFO - PROCESS | 31392 | 07:48:00 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54893/tests/kraken/driver.html?testName=audio-dft) 07:48:01 INFO - PROCESS | 31392 | RSS: Main: 185946112 07:48:01 INFO - PROCESS | 31392 | 07:48:04 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54893/tests/kraken/driver.html?testName=audio-fft) 07:48:05 INFO - PROCESS | 31392 | RSS: Main: 268214272 07:48:05 INFO - PROCESS | 31392 | 07:48:07 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54893/tests/kraken/driver.html?testName=audio-oscillator) 07:48:07 INFO - PROCESS | 31392 | RSS: Main: 179351552 07:48:07 INFO - PROCESS | 31392 | 07:48:10 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:48:10 INFO - PROCESS | 31392 | RSS: Main: 183361536 07:48:10 INFO - PROCESS | 31392 | 07:48:13 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54893/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:14 INFO - PROCESS | 31392 | RSS: Main: 222720000 07:48:14 INFO - PROCESS | 31392 | 07:48:17 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54893/tests/kraken/driver.html?testName=imaging-desaturate) 07:48:18 INFO - PROCESS | 31392 | RSS: Main: 216358912 07:48:18 INFO - PROCESS | 31392 | 07:48:21 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54893/tests/kraken/driver.html?testName=json-parse-financial) 07:48:21 INFO - PROCESS | 31392 | RSS: Main: 218243072 07:48:21 INFO - PROCESS | 31392 | 07:48:23 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:24 INFO - PROCESS | 31392 | RSS: Main: 181698560 07:48:24 INFO - PROCESS | 31392 | 07:48:26 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:26 INFO - PROCESS | 31392 | RSS: Main: 188063744 07:48:26 INFO - PROCESS | 31392 | 07:48:28 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:29 INFO - PROCESS | 31392 | RSS: Main: 197300224 07:48:29 INFO - PROCESS | 31392 | 07:48:32 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:33 INFO - PROCESS | 31392 | RSS: Main: 201478144 07:48:33 INFO - PROCESS | 31392 | 07:48:36 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:36 INFO - PROCESS | 31392 | RSS: Main: 202891264 07:48:36 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54893/tests/kraken/driver.html?testName=ai-astar) 07:48:38 INFO - PROCESS | 31392 | RSS: Main: 253956096 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | __start_tp_report 07:48:38 INFO - PROCESS | 31392 | _x_x_mozilla_page_load 07:48:38 INFO - PROCESS | 31392 | _x_x_mozilla_page_load_details 07:48:38 INFO - PROCESS | 31392 | |i|pagename|runs| 07:48:38 INFO - PROCESS | 31392 | |0;ai-astar;106;114;116;114;114;115;113;114;113;115 07:48:38 INFO - PROCESS | 31392 | |1;audio-beat-detection;160;129;128;159;124;126;121;123;143;122 07:48:38 INFO - PROCESS | 31392 | |2;audio-dft;162;164;162;162;162;162;162;161;163;161 07:48:38 INFO - PROCESS | 31392 | |3;audio-fft;76;76;77;116;77;78;77;80;105;78 07:48:38 INFO - PROCESS | 31392 | |4;audio-oscillator;84;84;106;85;84;85;101;84;84;114 07:48:38 INFO - PROCESS | 31392 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;116;117;118 07:48:38 INFO - PROCESS | 31392 | |6;imaging-darkroom;149;149;150;150;150;149;149;149;148;148 07:48:38 INFO - PROCESS | 31392 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;96;96 07:48:38 INFO - PROCESS | 31392 | |8;json-parse-financial;63;59;60;60;59;61;62;63;62;60 07:48:38 INFO - PROCESS | 31392 | |9;json-stringify-tinderbox;66;68;66;66;68;67;67;67;67;67 07:48:38 INFO - PROCESS | 31392 | |10;stanford-crypto-aes;85;85;87;94;89;85;87;85;84;85 07:48:38 INFO - PROCESS | 31392 | |11;stanford-crypto-ccm;142;132;133;132;131;130;138;130;226;143 07:48:38 INFO - PROCESS | 31392 | |12;stanford-crypto-pbkdf2;180;176;177;179;179;176;177;175;181;182 07:48:38 INFO - PROCESS | 31392 | |13;stanford-crypto-sha256-iterative;70;71;69;72;69;69;68;67;67;67 07:48:38 INFO - PROCESS | 31392 | __end_tp_report 07:48:38 INFO - PROCESS | 31392 | __start_cc_report 07:48:38 INFO - PROCESS | 31392 | _x_x_mozilla_cycle_collect,1807 07:48:38 INFO - PROCESS | 31392 | __end_cc_report 07:48:38 INFO - PROCESS | 31392 | __startTimestamp1483890518876__endTimestamp 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | ------- Summary: start ------- 07:48:38 INFO - PROCESS | 31392 | Number of tests: 14 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.76 (2.4%) stddev-sans-first:0.97 07:48:38 INFO - PROCESS | 31392 | Values: 106.0 114.0 116.0 114.0 114.0 115.0 113.0 114.0 113.0 115.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:128.50 stddev:15.05 (11.7%) stddev-sans-first:12.54 07:48:38 INFO - PROCESS | 31392 | Values: 160.0 129.0 128.0 159.0 124.0 126.0 121.0 123.0 143.0 122.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 07:48:38 INFO - PROCESS | 31392 | Values: 162.0 164.0 162.0 162.0 162.0 162.0 162.0 161.0 163.0 161.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#3] audio-fft Cycles:10 Average:84.00 Median:77.00 stddev:14.25 (18.5%) stddev-sans-first:14.82 07:48:38 INFO - PROCESS | 31392 | Values: 76.0 76.0 77.0 116.0 77.0 78.0 77.0 80.0 105.0 78.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:84.00 stddev:11.41 (13.6%) stddev-sans-first:11.81 07:48:38 INFO - PROCESS | 31392 | Values: 84.0 84.0 106.0 85.0 84.0 85.0 101.0 84.0 84.0 114.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 07:48:38 INFO - PROCESS | 31392 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 07:48:38 INFO - PROCESS | 31392 | Values: 149.0 149.0 150.0 150.0 150.0 149.0 149.0 149.0 148.0 148.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:48:38 INFO - PROCESS | 31392 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.50 stddev:1.52 (2.5%) stddev-sans-first:1.41 07:48:38 INFO - PROCESS | 31392 | Values: 63.0 59.0 60.0 60.0 59.0 61.0 62.0 63.0 62.0 60.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 07:48:38 INFO - PROCESS | 31392 | Values: 66.0 68.0 66.0 66.0 68.0 67.0 67.0 67.0 67.0 67.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.00 stddev:2.99 (3.5%) stddev-sans-first:3.11 07:48:38 INFO - PROCESS | 31392 | Values: 85.0 85.0 87.0 94.0 89.0 85.0 87.0 85.0 84.0 85.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:135.50 stddev:29.31 (21.6%) stddev-sans-first:31.09 07:48:38 INFO - PROCESS | 31392 | Values: 142.0 132.0 133.0 132.0 131.0 130.0 138.0 130.0 226.0 143.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:179.00 stddev:2.35 (1.3%) stddev-sans-first:2.40 07:48:38 INFO - PROCESS | 31392 | Values: 180.0 176.0 177.0 179.0 179.0 176.0 177.0 175.0 181.0 182.0 07:48:38 INFO - PROCESS | 31392 | 07:48:38 INFO - PROCESS | 31392 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.73 (2.5%) stddev-sans-first:1.79 07:48:38 INFO - PROCESS | 31392 | Values: 70.0 71.0 69.0 72.0 69.0 69.0 68.0 67.0 67.0 67.0 07:48:38 INFO - PROCESS | 31392 | -------- Summary: end -------- 07:48:38 INFO - PROCESS | 31392 | 07:48:40 INFO - TEST-INFO | 31392: exit 0 07:48:40 INFO - TEST-OK | kraken | took 63838ms 07:48:40 INFO - SUITE-END | took 1184s 07:48:40 INFO - Completed test suite (00:19:44) 07:48:40 INFO - javascript benchmark 07:48:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.462092960478, 2573.047972250268, 2603.2190342897125, 2607.8696065196737, 2611.1905309354115, 4239.025024244425, 4265.338872474764, 4266.935995960063, 4275.615194632483, 4280.957190428095, 4318.07161460286, 4327.415798867152, 4333.93499097513, 4334.0681753423005, 4355.063661312817, 3992.3013472642315, 4022.1151346703823, 4029.536603290615, 4049.068714195737, 4075.0831063010883, 4026.899327516821, 4029.073313137965, 4037.7375470594316, 4051.5138183417885, 4101.979490102545, 3981.641652251297, 4008.2584721826556, 4018.6985976051765, 4076.8776936691947, 4101.958980410188, 4051.108756073659, 4058.4115303281155, 4067.349224124126, 4067.6542493888055, 4094.979525102385, 3866.941995870064, 3957.6042395760483, 4033.253848038122, 4033.899152521181, 4072.2059198456313, 4336.371226172188, 4338.566143385668, 4357.694961352675, 4373.125374925028, 4383.342498625232, 4601.907961840778, 4603.608693261077, 4605.171069207541, 4607.055553611502, 4647.465541462741, 4470.932936005963, 4496.910061798746, 4563.292689633112, 4619.976900115512, 4633.2818413146015, 4314.158739045887, 4331.0, 4355.4337936068105, 4373.278409062469, 4400.317950717644, 4701.717896926195, 4702.858914232578, 4710.222813235846, 4736.502667219961, 4756.357891684578, 4398.450193725785, 4412.624926881187, 4527.0493196429115, 4528.660350473728, 4532.365468834366, 4502.57225563571, 4525.208088584551, 4529.977350113294, 4577.313402989512, 4601.976990115095, 4519.050999290186, 4548.522405147478, 4555.817767289338, 4555.931661025087, 4597.149527337453, 4516.893361126479, 4568.520305367955, 4574.062317224961, 4578.839740609129, 4602.792874320664, 3771.2268984858038, 3783.3379158647126, 3810.504634397566, 3818.6181381862148, 3875.612438756158, 3367.6800703933086, 3392.338493993697, 3401.9829900850336, 3439.3465241604017, 3443.104792753902, 4347.217500849814, 4367.235733746582, 4367.5414081520985, 4457.843975460908, 4509.684322097487, 4525.162844873709, 4538.568835960578, 4544.590986811203, 4601.539846015372, 4628.0281140960105, 4374.737515749065, 4393.406890069799, 4405.096955124256, 4408.7575183365225, 4449.132419178294, 3970.404439334123, 3993.2612466693754, 4027.939580906289, 4030.0327921298676, 4056.2495938250927, 4789.042191561632, 4812.687175333592, 4821.975890120527, 4829.927551086666, 4887.0, 4603.8158473662015, 4607.0, 4618.699784513996, 4627.352170696173, 4664.743439110882, 4759.16714574941, 4851.975740121418, 4855.5387238213725, 4862.513748625251, 4905.558499735041, 4448.399466072039, 4512.0, 4522.366868638327, 4527.4340707411575, 4602.07958408313, 4631.814727410866, 4632.907341853077, 4635.420572428447, 4635.582797548102, 4679.181143299977, 4517.09658068381, 4523.86292834891, 4525.479569849378, 4528.841490547815, 4571.26859702446, 4411.9558804411545, 4438.689291749675, 4438.911221775482, 4462.0629667768835, 4463.218936686132, 4392.231359512137, 4400.163968845909, 4419.403380543714, 4440.777961101997, 4444.422225110715, 4499.685022048425, 4519.096180763926, 4522.186006518858, 4536.9092618148115, 4571.38286331341, 4347.304431290978, 4351.282038463744, 4357.302831546937, 4381.145676593033, 4403.669724770591], "value": 4292.812668030322, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.7349351830567, 521.9321488206533, 536.5921899356488, 543.0577947261498, 549.6674511920288, 31829.0, 39650.0, 41932.58067419325, 41991.58008419915, 46042.30936535955, 42718.35922461158, 43005.0, 43031.0, 43038.0, 43070.0, 7615.9619201903915, 7720.1121870985, 7769.883451748228, 7783.844323113534, 7787.026621672291, 7642.082950046002, 9626.951865240664, 9950.9502452488, 10000.099991000809, 10293.897061029369, 10098.848517272247, 10161.390316580992, 10171.38971661699, 10171.440570768642, 10173.79652406955, 9850.802983940317, 9870.309078364517, 9907.900920990769, 9911.65309214174, 9919.752006199868, 9710.417374957526, 9770.853437198448, 9783.0706082922, 9784.90215097847, 9785.706428807147, 33667.32665346704, 33842.49236261458, 33876.32247355039, 33927.151821204665, 33930.1517462063, 3686.981565092184, 3740.831662575191, 3745.9625403745886, 3795.6394142556414, 3796.6772824309965, 30374.696253037408, 30477.238069048228, 30675.539866901792, 30810.0, 31919.0, 3440.3807314683345, 3445.2248244145117, 3458.9654103459147, 3530.4704294355797, 3561.305545418644, 247714.0, 249443.9999999982, 249992.0, 250989.0, 252404.0, 56727.71636141875, 57002.0, 57073.71463142741, 57089.0, 57094.7145264271, 61346.69326653338, 61347.6932615343, 61355.693221533606, 61403.0, 61440.94063068601, 14244.572662820132, 14326.928365358106, 14348.282585870873, 14376.0, 14421.855781442262, 10000.949995250123, 10414.531346089445, 10822.945885270523, 10832.350058996486, 10900.236983411243, 16771.748423773653, 17352.739708904377, 17404.912975435043, 17506.824931750773, 17635.911820441073, 6412.967935160387, 6608.702608382634, 6620.569662971891, 6625.801225963229, 6707.631080290631, 794.8489786940578, 804.3484777330381, 805.3355981315439, 809.8218391953761, 829.307528213936, 27637.447251054866, 28260.293492662848, 28745.71254287472, 28795.424091518053, 29008.0, 938.6245501799335, 947.2753343691943, 950.6435086842434, 966.4346357381011, 1057.0116940660353, 14766.557003289918, 15320.310586023656, 15392.922495425213, 15437.0, 15443.200950777504, 344263.0, 346344.0, 346896.0, 349099.0, 351456.0971097998, 52667.473325266255, 52832.47167528352, 52833.0, 52881.206781897534, 52890.0, 1211.1703483114095, 1219.9573014944435, 1246.7880460321949, 1253.974920501603, 1254.2787896959285, 26011.479770404865, 27053.59419608668, 27329.590056148776, 27831.582526261718, 27846.44307113806, 37471.62528374681, 37748.0, 37818.24363512659, 37821.05447363838, 37867.887835143, 266544.0, 267052.0, 267167.0, 267252.0, 268228.0, 32754.0, 34018.0, 34026.489602655485, 36850.63149368472, 38204.80897595494, 39208.411873822486, 46788.0, 47140.7642961783, 47172.03651031194, 48294.0, 36538.451923220644, 36885.631143689294, 37085.25829483449, 37466.2506749858, 37764.24471510609, 36517.34226067712, 37330.6266937338, 37429.62570374261, 37848.86453406402, 38413.23173536458, 35467.46798797968, 35922.0, 35960.460593090604, 36305.45541816928, 36713.265734685694, 30593.23516912095, 33293.667063329056, 33552.66447335593, 33644.66355336415, 33817.15457113592, 22280.220192293193, 23432.648510272018, 23802.0, 24976.875115624305, 25303.87348063248], "value": 18101.960926889125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.74424809269, 368.5577307231323, 372.69439059970824, 373.7813379173183, 387.73246459942635, 13474.124181928168, 16271.51185464435, 16904.746428803577, 17490.650186996252, 18799.342023029196, 16819.32722691094, 16898.83101168988, 17070.573235669115, 17105.657886842255, 17112.82887171128, 4994.999999999991, 5111.642185047048, 5299.920501192485, 5318.095923692981, 5362.570994320465, 3546.5034895114704, 3688.6680198782105, 5343.706096164709, 5382.111951527993, 5590.972045139769, 5817.534597232232, 5931.644101353911, 5955.362275374285, 5955.761769529214, 5959.0, 5394.1908713692865, 5419.783208671648, 5423.240746295522, 5514.503694667499, 5950.256217972754, 5277.205750044965, 5317.1492561190025, 5324.227986941872, 5326.573874090063, 5341.225522299244, 11267.21129520934, 11430.199886007982, 11445.484953177127, 11560.76878462426, 11581.247218930743, 2055.8149766521083, 2119.5760847830497, 2153.720016397874, 2208.8012078912816, 2240.6078936186263, 8702.956485217534, 8858.68994585193, 9278.025807290205, 11720.120990925714, 13082.607521774362, 1678.6894424531501, 1737.148797089417, 1750.518607382967, 1753.281154726556, 1781.186895624437, 78241.0, 78573.0, 78654.0, 78674.60662696707, 81143.5942820282, 8351.0, 8833.55832208387, 8875.023747387782, 8912.287017038621, 9652.469114198646, 11850.170488065753, 11920.284782913053, 11934.22427542207, 11966.700832479257, 12136.87863121375, 6723.562968407038, 6729.461643068543, 6917.239103698589, 6937.861242775116, 6938.8612227756175, 6623.381804400368, 6641.435477984329, 6881.621510816853, 6905.965470172718, 6906.37842594169, 3610.9097272568397, 3670.376036073874, 3758.210775737126, 3792.009195172501, 3847.961520384816, 1750.5098572399747, 1756.7628370169864, 1780.1900135438602, 1784.090114041848, 1847.5473508990115, 931.7158266728712, 961.1733908838394, 962.831504486712, 988.8961659025699, 994.4132961552718, 16754.664906701797, 17038.403655871985, 17166.22751976164, 17571.73642395365, 17810.287588496572, 915.7481692534473, 924.930630202724, 931.1340453378423, 935.7192842147329, 936.784539555906, 9038.0, 9368.859467107999, 9570.282228832866, 9613.509905964587, 9794.069563391466, 480908.0, 485507.0, 486917.0, 493203.0, 501401.0, 91050.0, 95938.52030739802, 97570.51214743881, 100900.0, 101085.49457252667, 936.8032713130319, 940.9576569054409, 980.8626792249091, 980.8675828763169, 986.8766404199619, 15748.291326890088, 15886.046837189806, 15934.840651593335, 15974.201289935689, 16180.514584562481, 39577.80211098926, 39961.0, 40232.396514052896, 40313.0, 41281.793591031856, 49719.25421118759, 55793.86267510652, 56435.43564564302, 56751.71624141853, 57704.0, 6801.9319806801295, 6999.860002799814, 7030.3478682510595, 7067.71729130829, 7475.551466912003, 9339.252859771066, 10239.232057595562, 10338.534765935401, 10346.741331466774, 10787.244892857425, 8516.0, 8595.613197406257, 8655.091215422543, 8755.16141610269, 9212.631494740403, 8955.776105597412, 9076.228520575562, 9089.863652045357, 9185.173334399937, 9552.331336806357, 9002.549872506479, 9088.272938164799, 9110.90889091127, 9443.858342124737, 9564.33049686543, 6825.180978282638, 6837.863242735217, 6984.987176859226, 7071.080759501232, 7201.063861697946, 8330.458520196167, 10151.847722284025, 10194.0, 10505.78988420212, 10612.097971672494], "value": 8080.691785494213, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.2368388176799, 1361.9046666733332, 1380.8412032616252, 1389.0970868935192, 1396.2599822094292, 6954.582725036495, 7302.306280903319, 7304.525205861615, 7313.195548489669, 7334.853302933945, 6399.104125422433, 6571.112899758543, 6869.9656501717545, 7037.507374483788, 7147.535410198334, 2036.4806974221553, 2070.7411573553304, 2073.5645514441985, 2077.6156411063926, 2080.074366906727, 1997.4107638246753, 2085.2493102483095, 2095.224766836273, 2095.5389814240843, 2102.6530622447353, 1877.155280123943, 1939.5732938753451, 2047.7235573197652, 2075.2529089527834, 2103.5372218112066, 1951.6389467948404, 1952.1215453046186, 1954.159711324123, 1954.7947465516058, 1955.9608807823763, 2028.6652702304102, 2049.1803278688494, 2059.4542446251753, 2088.6553718636405, 2092.6442504774072, 7252.927470725278, 7256.0, 7265.782026539212, 7314.670839812221, 7332.0, 4328.5455027222315, 4417.0, 4417.050334178135, 4443.977780111079, 4446.377507149002, 2599.2592111248205, 2704.716004819505, 2721.537338652434, 2758.9310267243277, 2765.460735156645, 953.3279038277998, 1001.3441196016548, 1007.2999265510473, 1027.5941003303653, 1028.4703377760459, 9568.33021688482, 9578.090081442251, 9594.520273986273, 9618.711438656781, 9618.9519052405, 3718.8326525306425, 3880.708946828999, 3954.149857780591, 3984.063745019918, 3992.1017771001875, 8274.958625206835, 8294.419390642597, 8334.458260213067, 8335.95832020836, 8348.916510834935, 4307.741535507879, 4346.36977638247, 4352.521222665504, 4353.1293741251875, 4359.782010899442, 3968.940465893014, 3987.80060996949, 3990.082281075369, 3995.180987897474, 4025.3156963316305, 3449.844756985942, 3453.2575496268423, 3531.8940431787087, 3535.045537704805, 3543.450765131357, 1117.1509652664033, 1118.7426891814928, 1129.678041758095, 1133.3426612564692, 1134.797115058041, 641.5701480008405, 655.2137435077831, 661.9238787539495, 665.1452883045264, 669.4142625202948, 4706.199946009118, 4718.127146477913, 4732.313814496947, 4802.783874725646, 4941.950580494221, 476.2047380873949, 480.0, 480.10460491184386, 485.55329097230634, 807.3904202327205, 3326.3014766898737, 3355.496675498695, 3375.6624337566536, 3377.2401209727614, 3468.427709427916, 8361.707340243061, 8476.915230847735, 8569.400141990001, 8615.956920215358, 8627.309815214894, 8508.0, 8527.573621318908, 8531.402801803813, 8543.316534677211, 8559.229669329665, 6861.416779573792, 6868.244493105854, 6872.862542749117, 6874.106366172366, 6937.549059311129, 4731.0, 4770.4275486940405, 4812.181929072136, 4919.163742163769, 5048.671836330626, 7588.392928565812, 7668.079830420385, 7901.288884000238, 7998.3201427879285, 8005.279524842792, 7940.523568585903, 7974.0, 7976.84046319082, 7978.401619878417, 8118.147594502492, 6279.686015699288, 6347.174867267226, 6378.968105159444, 6391.137196478416, 6419.711113000019, 6752.527323087336, 6789.15135608049, 6798.048273241849, 6818.624975626388, 6860.176778786378, 6235.282942461675, 6291.402316779899, 6331.398517140864, 6348.650824204528, 6407.935920640734, 6132.6627035513475, 6199.969000154971, 6213.689315534296, 6216.347283535164, 6222.719977601109, 5559.499645031967, 5652.689102099424, 5665.943340566707, 5670.007748644053, 5680.886382272414, 4236.597523235288, 4260.169266992907, 4264.381664658545, 4280.363830925589, 4386.758728269976, 4190.413342132043, 4235.618794308527, 4257.19113368459, 4361.476622805284, 4420.690551661352], "value": 3791.2826773487673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.62760501201046, 316.44779859145797, 319.1701575902652, 331.86725309876044, 334.2446071877558, 4182.309918863388, 4259.70182087254, 4328.0, 4336.3278691802825, 4371.289800323796, 4270.786460676969, 4271.145770845836, 4308.246056940038, 4308.2891322931755, 4336.262835317995, 3267.2648654052828, 3403.0, 3428.502867084271, 3431.227973705909, 3454.1191996040975, 3313.453280208763, 3374.3926093303194, 3407.5399821024216, 3445.534852794878, 3446.4313388291025, 3402.42158832999, 3418.8119653419053, 3420.880269190579, 3423.6062852771875, 3424.7260219182403, 3403.3703764803467, 3415.7438192135687, 3416.555847739778, 3421.8460169292443, 3432.3135372925267, 2872.4111557130736, 2888.638920134983, 2940.7059294070636, 2967.3916847046303, 3022.80351777136, 4200.537940826506, 4206.26390381682, 4212.53662097169, 4214.452121224252, 4215.156968606291, 3808.809559522013, 3809.276237514863, 3821.713371497121, 3822.37549041659, 3826.3877779555414, 4374.212641724488, 4414.933775993362, 4488.236999710057, 4495.370648109268, 4497.9775101124615, 3183.3474137801927, 3202.647708752035, 3211.5343275224964, 3211.8394080295893, 3214.9196270093203, 4635.2120139576355, 4646.163690535702, 4649.442066951953, 4649.744264065441, 4657.88355291117, 3284.901452956415, 3289.9342013159603, 3291.127851119455, 3316.7512436567354, 3332.250243695149, 3375.274316022018, 3380.5267262582765, 3383.763136580416, 3383.881564145243, 3390.2371966307383, 3647.708183345326, 3785.6782173515007, 3816.46569480273, 3821.331267028259, 3831.5210598675167, 4503.0, 4503.121891231179, 4503.234450143484, 4513.954860451354, 4522.8643140705835, 1133.5522468624847, 1137.391495549877, 1138.362516990488, 1140.298716289476, 1140.4034351907396, 755.4814822207293, 792.8107838242636, 799.6361655446758, 801.7394346837301, 802.7070119406375, 4290.82836686529, 4329.545397733255, 4333.501647310537, 4343.652507799368, 4349.869503914888, 4498.887527811766, 4530.501644819067, 4530.977345113253, 4545.0, 4546.977265113719, 4315.741055536678, 4320.697551171388, 4321.67587430944, 4335.501417336984, 4338.414314067623, 2253.504229069602, 2377.037299893546, 2387.8089752819733, 2388.23576455536, 2403.6299309393476, 4748.477667456577, 4762.618990480753, 4767.856964291077, 4774.188387974053, 4787.61699064074, 4609.262517997105, 4612.310151878483, 4630.930536041962, 4636.095961287517, 4666.859994200179, 4592.827245147785, 4796.544328288807, 4799.400074990696, 4814.446338670958, 4831.154547954094, 4538.977305113453, 4546.181687296318, 4547.045120524727, 4550.0, 4557.886052848706, 4410.625096866802, 4468.536883914991, 4492.618127459203, 4494.4606647202545, 4510.413646225969, 4630.976845115752, 4801.791176059052, 4802.271182374273, 4868.805247790048, 4920.803167873388, 3316.1709572606846, 3329.7669163159317, 3333.3666603345287, 3338.382399256145, 3341.415252330784, 4470.24005918988, 4638.211504044388, 4644.256918892961, 4656.254999200111, 4660.720356778605, 4502.5199926073765, 4504.369388285577, 4510.143072816154, 4526.434195725535, 4531.365608814835, 4478.820847166076, 4479.70881892676, 4482.686211965131, 4517.277235642281, 4519.774011299488, 4417.690761646654, 4427.8893027673275, 4431.446069241345, 4441.955580444283, 4470.0, 4289.957100429081, 4545.090981803719, 4549.613282870993, 4555.658325625525, 4559.886002849956, 4433.733975961452, 4436.778161091868, 4441.866743997685, 4448.933266000948, 4478.171538265431], "value": 3457.0657687990915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.8367908022994, 660.9471242300616, 727.7380143148465, 755.4938191411753, 770.349055048484, 12050.0, 13084.803727944076, 13096.214227146378, 13125.737485250313, 13126.540571080013, 13268.203907765517, 13319.334033298344, 13325.46698132076, 13330.133541319832, 13469.259190744506, 639.3957709964086, 657.4773055420952, 756.5649751392943, 767.3209209849296, 775.248009430854, 789.9723509677162, 790.474334567512, 791.1732239809385, 791.5685951156605, 791.9287264146226, 828.8300898315831, 829.3365307753803, 830.779843341515, 830.900291964965, 831.268483734313, 679.4937771360344, 693.9444844412435, 694.1947341084318, 697.435077587151, 826.8263664630434, 588.6115163991744, 607.0863350657277, 610.4353473037467, 611.1108337369117, 612.0665984373866, 12714.173578717446, 12716.872831271661, 12740.299283539494, 12750.681232969157, 12752.426140823685, 12761.553345632858, 12797.744045119045, 12841.807372889414, 12848.614541563767, 12867.871321286855, 11317.094632429385, 11444.599439019677, 11500.252483588623, 11820.645380638594, 11892.621475704893, 4048.6761059115493, 4063.878083657495, 4105.0763578194965, 4264.275073237557, 4278.72188307759, 60926.0, 61114.38885611176, 61915.69042154805, 62322.37677623211, 63777.0, 9511.096445837635, 9669.468179250069, 9689.982551832098, 9715.368501047551, 9886.406815591088, 17504.912475437795, 17650.735238971425, 17725.911370443064, 18471.90764046171, 18479.53801154955, 6673.699683514156, 6781.762638307636, 6868.210155832143, 6899.137607799025, 7130.857382852314, 3530.894073177809, 3586.6234045424853, 3604.981975090108, 3661.176235347026, 3667.1932174921476, 2769.8476583787683, 2819.3938303264895, 2833.334166470878, 2833.943321133566, 2834.8299102053943, 502.3218654816042, 513.1609817947608, 515.2914742229434, 540.9107497262908, 570.8943845388617, 604.1722839709538, 617.5831313863124, 623.7130919776954, 628.6573817269599, 632.8101569529123, 8858.42420242695, 9188.586513606904, 9298.210536838922, 9598.520073996273, 9642.71071867845, 502.53264464048056, 523.9318888544541, 533.0937406409042, 544.6595877576515, 545.4109561673383, 4007.358822588372, 4127.814248358831, 4284.635805956466, 4462.620677242471, 4543.204939135638, 59584.702076490204, 63319.0, 64509.67745161338, 64568.03147952785, 64921.35078649153, 54312.185317220275, 55220.0, 56402.43597563972, 56890.14664780031, 56945.715271423374, 42590.36114458224, 42848.78575607102, 43399.566004339555, 49463.0, 51667.7416612922, 9336.859947100664, 9863.506824658594, 9987.450690212108, 10260.435676037889, 10300.175985920958, 33944.15139621529, 34248.14379640529, 34258.82870585731, 35309.64690353166, 36609.0, 40526.79736601298, 40751.388729168495, 43056.35415468833, 43279.0, 44354.334684979105, 10853.782924341627, 10879.0, 10982.341059536133, 11099.334039957628, 11430.085593152362, 12771.361431928552, 13096.410661520446, 13177.868221317663, 14035.789463158266, 14059.578212653636, 11646.825297620711, 12088.576899808464, 12504.923689052295, 12511.311877846441, 12609.684757881127, 11762.176647634584, 11819.172657913863, 11896.702582435162, 12550.623481295575, 12588.937055314665, 11788.587399440978, 12155.75688486243, 12175.269483830998, 12282.324472154118, 12761.234325940473, 8842.91157088421, 9503.19222866064, 9599.664011759554, 9729.270304727032, 10114.898851011396, 9338.766530836783, 9353.719388418358, 9372.39079459833, 9391.671291504765, 9527.76180595463], "value": 6304.320742474099, "unit": "score"}], "name": "dromaeo_css", "value": 6107.332755516396, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 116.0, 114.0, 114.0, 115.0, 113.0, 114.0, 113.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 128.0, 159.0, 124.0, 126.0, 121.0, 123.0, 143.0, 122.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 163.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 116.0, 77.0, 78.0, 77.0, 80.0, 105.0, 78.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 85.0, 84.0, 85.0, 101.0, 84.0, 84.0, 114.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 150.0, 150.0, 149.0, 149.0, 149.0, 148.0, 148.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 60.0, 60.0, 59.0, 61.0, 62.0, 63.0, 62.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 94.0, 89.0, 85.0, 87.0, 85.0, 84.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 132.0, 133.0, 132.0, 131.0, 130.0, 138.0, 130.0, 226.0, 143.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 177.0, 179.0, 179.0, 176.0, 177.0, 175.0, 181.0, 182.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 72.0, 69.0, 69.0, 68.0, 67.0, 67.0, 67.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1550.8000000000002, "alertThreshold": 2.0}]} 07:48:40 INFO - Return code: 0 07:48:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:48:40 INFO - # TBPL SUCCESS # 07:48:40 INFO - Running post-action listener: _resource_record_post_action 07:48:40 INFO - [mozharness: 2017-01-08 15:48:40.663500Z] Finished run-tests step (success) 07:48:40 INFO - Running post-run listener: _resource_record_post_run 07:48:40 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 3981312; Write bytes: 384159744; Read time: 2768; Write time: 333108 07:48:40 INFO - TinderboxPrint: CPU usage
13.1% 07:48:40 INFO - TinderboxPrint: I/O read bytes / time
3,981,312 / 2,768 07:48:40 INFO - TinderboxPrint: I/O write bytes / time
384,159,744 / 333,108 07:48:40 INFO - TinderboxPrint: CPU idle
8,330.4 (86.9%) 07:48:40 INFO - TinderboxPrint: CPU user
1,209.6 (12.6%) 07:48:40 INFO - TinderboxPrint: Swap in / out
0 / 0 07:48:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100028416; Read time: 0; Write time: 121280 07:48:40 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 3977216; Write bytes: 284131328; Read time: 2748; Write time: 211828 07:48:41 INFO - Running post-run listener: _upload_blobber_files 07:48:41 INFO - Blob upload gear active. 07:48:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:41 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 07:48:41 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'] 07:48:41 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 07:48:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:48:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:48:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:44 INFO - (blobuploader) - INFO - Done attempting. 07:48:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:48:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:48:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:45 INFO - (blobuploader) - INFO - Done attempting. 07:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:46 INFO - (blobuploader) - INFO - Done attempting. 07:48:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:48:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:48:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:47 INFO - (blobuploader) - INFO - Done attempting. 07:48:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:47 INFO - Return code: 0 07:48:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d724d2eeeac9d7303ce3887dead935d743d87ec4f6282a3b0333bbfc1dcb3ecb181f90c35ae853ea8c701003ed5b024c1c603b96ca5738feb05a224c370d191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9c09530c8ade3ce190683faf9231541d9a4981ffe7497818d301a05ed7a934b982e5185ab749f1748ff65335ae2cde80088d2e38bf59ede621e04658f56896d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79fef2b45c7b246950898459b68ce62653dc5ab22feb6deee80e6a0cb8356700376fc0094e8d8c65a32ae1a74f59f34ee141a4d15e25be9e46c49907bd983139", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54fcb00299cbe112b1b3fe52f4ecc591f8e0a8197735bea51befdd03bb75915cd76ef5638f5acb1f8f512d6d0657287fcb3ed2271fbb98bdfb05abe79267dd38"} 07:48:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:47 INFO - Contents: 07:48:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d724d2eeeac9d7303ce3887dead935d743d87ec4f6282a3b0333bbfc1dcb3ecb181f90c35ae853ea8c701003ed5b024c1c603b96ca5738feb05a224c370d191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9c09530c8ade3ce190683faf9231541d9a4981ffe7497818d301a05ed7a934b982e5185ab749f1748ff65335ae2cde80088d2e38bf59ede621e04658f56896d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79fef2b45c7b246950898459b68ce62653dc5ab22feb6deee80e6a0cb8356700376fc0094e8d8c65a32ae1a74f59f34ee141a4d15e25be9e46c49907bd983139", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54fcb00299cbe112b1b3fe52f4ecc591f8e0a8197735bea51befdd03bb75915cd76ef5638f5acb1f8f512d6d0657287fcb3ed2271fbb98bdfb05abe79267dd38"} 07:48:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:47 INFO - Copying logs to upload dir... 07:48:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.554196 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-08 07:48:45.492617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-08 07:48:45.496522) ========= 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=fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d724d2eeeac9d7303ce3887dead935d743d87ec4f6282a3b0333bbfc1dcb3ecb181f90c35ae853ea8c701003ed5b024c1c603b96ca5738feb05a224c370d191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9c09530c8ade3ce190683faf9231541d9a4981ffe7497818d301a05ed7a934b982e5185ab749f1748ff65335ae2cde80088d2e38bf59ede621e04658f56896d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79fef2b45c7b246950898459b68ce62653dc5ab22feb6deee80e6a0cb8356700376fc0094e8d8c65a32ae1a74f59f34ee141a4d15e25be9e46c49907bd983139", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54fcb00299cbe112b1b3fe52f4ecc591f8e0a8197735bea51befdd03bb75915cd76ef5638f5acb1f8f512d6d0657287fcb3ed2271fbb98bdfb05abe79267dd38"} build_url:https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011788 build_url: 'https://queue.taskcluster.net/v1/task/LTivuPKOT82-kmX9cDsG1g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d724d2eeeac9d7303ce3887dead935d743d87ec4f6282a3b0333bbfc1dcb3ecb181f90c35ae853ea8c701003ed5b024c1c603b96ca5738feb05a224c370d191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9c09530c8ade3ce190683faf9231541d9a4981ffe7497818d301a05ed7a934b982e5185ab749f1748ff65335ae2cde80088d2e38bf59ede621e04658f56896d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79fef2b45c7b246950898459b68ce62653dc5ab22feb6deee80e6a0cb8356700376fc0094e8d8c65a32ae1a74f59f34ee141a4d15e25be9e46c49907bd983139", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54fcb00299cbe112b1b3fe52f4ecc591f8e0a8197735bea51befdd03bb75915cd76ef5638f5acb1f8f512d6d0657287fcb3ed2271fbb98bdfb05abe79267dd38"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-08 07:48:45.521699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-08 07:48:45.521986) ========= 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=fa44defc139c4ba8574fe040000001db-1483888439.419645-544542843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-08 07:48:45.606030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-08 07:48:45.606347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-08 07:48:45.606622) ========= ========= Total master_lag: 0.15 =========