builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1493913760.55 results: success (0) revision: 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.548544) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.548985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.549253) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.566379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.567046) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 09:02:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-05-04 09:02:41 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129219 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.710436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.710760) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.760664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.760992) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a --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 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a --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=74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 09:02:41,286 truncating revision to first 12 chars 2017-05-04 09:02:41,286 Setting DEBUG logging. 2017-05-04 09:02:41,286 attempt 1/10 2017-05-04 09:02:41,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d4525b5aaa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 09:02:41,589 unpacking tar archive at: mozilla-central-6d4525b5aaa8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:41.388346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:41.388730) ========= script_repo_revision: 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:41.389120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:41.389521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:41.399727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-04 09:02:41.400141) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:02:42 INFO - MultiFileLogger online at 20170504 09:02:42 in /builds/slave/test 09:02:42 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 09:02:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:02:42 INFO - {'append_to_log': False, 09:02:42 INFO - 'base_work_dir': '/builds/slave/test', 09:02:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:02:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:02:42 INFO - 'branch': 'Firefox-Non-PGO', 09:02:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:02:42 INFO - 'config_files': ('talos/linux_config.py',), 09:02:42 INFO - 'default_actions': ('clobber', 09:02:42 INFO - 'read-buildbot-config', 09:02:42 INFO - 'download-and-extract', 09:02:42 INFO - 'populate-webroot', 09:02:42 INFO - 'create-virtualenv', 09:02:42 INFO - 'install', 09:02:42 INFO - 'run-tests'), 09:02:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:02:42 INFO - 'download_minidump_stackwalk': True, 09:02:42 INFO - 'download_symbols': 'ondemand', 09:02:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:02:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:02:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:02:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:02:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:02:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:02:42 INFO - 'gecko_profile': False, 09:02:42 INFO - 'gecko_profile_interval': 0, 09:02:42 INFO - 'installer_path': 'installer.exe', 09:02:42 INFO - 'log_level': 'info', 09:02:42 INFO - 'log_name': 'talos', 09:02:42 INFO - 'log_to_console': True, 09:02:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:02:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:02:42 INFO - 'opt_config_files': (), 09:02:42 INFO - 'pip_index': False, 09:02:42 INFO - 'suite': 'dromaeojs', 09:02:42 INFO - 'system_bits': '32', 09:02:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:02:42 INFO - 'title': 'talos-linux64-ix-042', 09:02:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:02:42 INFO - 'use_talos_json': True, 09:02:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:02:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:02:42 INFO - 'work_dir': 'build'} 09:02:42 INFO - [mozharness: 2017-05-04 16:02:42.021528Z] Running clobber step. 09:02:42 INFO - Running pre-action listener: _resource_record_pre_action 09:02:42 INFO - Running main action method: clobber 09:02:42 INFO - rmtree: /builds/slave/test/build 09:02:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:02:43 INFO - Running post-action listener: _resource_record_post_action 09:02:43 INFO - [mozharness: 2017-05-04 16:02:43.475015Z] Finished clobber step (success) 09:02:43 INFO - [mozharness: 2017-05-04 16:02:43.475114Z] Running read-buildbot-config step. 09:02:43 INFO - Running pre-action listener: _resource_record_pre_action 09:02:43 INFO - Running main action method: read_buildbot_config 09:02:43 INFO - Using buildbot properties: 09:02:43 INFO - { 09:02:43 INFO - "project": "", 09:02:43 INFO - "product": "firefox", 09:02:43 INFO - "who": "ffxbld@noreply.mozilla.org", 09:02:43 INFO - "installer_path": "public/build/target.tar.bz2", 09:02:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:02:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:02:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:02:43 INFO - "stage_platform": "linux64", 09:02:43 INFO - "basedir": "/builds/slave/test", 09:02:43 INFO - "buildnumber": 1126, 09:02:43 INFO - "platform": "ubuntu64_hw", 09:02:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:02:43 INFO - "slavebuilddir": "test", 09:02:43 INFO - "taskId": "XB18CH4cR_G6GaWUZJaNpg", 09:02:43 INFO - "branch": "mozilla-central", 09:02:43 INFO - "script_repo_revision": "production", 09:02:43 INFO - "revision": "6d4525b5aaa834ea4db8d8eab8087d86e34cf57a", 09:02:43 INFO - "slavename": "talos-linux64-ix-042", 09:02:43 INFO - "repo_path": "mozilla-central" 09:02:43 INFO - } 09:02:43 INFO - Finding installer, test and symbols from parent task. 09:02:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XB18CH4cR_G6GaWUZJaNpg'}, attempt #1 09:02:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XB18CH4cR_G6GaWUZJaNpg'}, attempt #1 09:02:44 INFO - Task dependencies: ZtpNGFJsTKe8QtQepxpBZQ 09:02:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ'}, attempt #1 09:02:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 09:02:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/test_packages.json 09:02:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.crashreporter-symbols.zip 09:02:44 INFO - Running post-action listener: _resource_record_post_action 09:02:44 INFO - [mozharness: 2017-05-04 16:02:44.858407Z] Finished read-buildbot-config step (success) 09:02:44 INFO - [mozharness: 2017-05-04 16:02:44.858623Z] Running download-and-extract step. 09:02:44 INFO - Running pre-action listener: _resource_record_pre_action 09:02:44 INFO - Running main action method: download_and_extract 09:02:44 INFO - mkdir: /builds/slave/test/build/tests 09:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:44 INFO - trying https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.test_packages.json 09:02:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:02:45 INFO - Downloaded 986 bytes. 09:02:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:02:45 INFO - Using the following test package requirements: 09:02:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:02:45 INFO - u'common': [u'target.common.tests.zip'], 09:02:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:02:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:02:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:02:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:02:45 INFO - u'mozbase': [u'target.common.tests.zip'], 09:02:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:02:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:02:45 INFO - u'web-platform': [u'target.common.tests.zip', 09:02:45 INFO - u'target.web-platform.tests.zip'], 09:02:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:02:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:02:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip 09:02:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:02:45 INFO - Fetch https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip into memory 09:02:46 INFO - Content-Length response header: 58436280 09:02:46 INFO - Bytes received: 58436280 09:02:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:02:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip 09:02:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:02:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip into memory 09:02:57 INFO - Content-Length response header: 58436280 09:02:57 INFO - Bytes received: 58436280 09:03:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.talos.tests.zip 09:03:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:03:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.talos.tests.zip into memory 09:03:08 INFO - Content-Length response header: 14408809 09:03:08 INFO - Bytes received: 14408809 09:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:08 INFO - trying https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 09:03:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:03:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:03:10 INFO - Downloaded 58413936 bytes. 09:03:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 09:03:10 INFO - mkdir: /builds/slave/test/properties 09:03:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:03:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:03:10 INFO - Contents: 09:03:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 09:03:10 INFO - Running post-action listener: _resource_record_post_action 09:03:10 INFO - Running post-action listener: set_extra_try_arguments 09:03:10 INFO - [mozharness: 2017-05-04 16:03:10.068954Z] Finished download-and-extract step (success) 09:03:10 INFO - [mozharness: 2017-05-04 16:03:10.069049Z] Running populate-webroot step. 09:03:10 INFO - Running pre-action listener: _resource_record_pre_action 09:03:10 INFO - Running main action method: populate_webroot 09:03:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:10 INFO - '--tppagecycles', 09:03:10 INFO - '7'], 09:03:10 INFO - 'tests': ['tsvgm']}}, 09:03:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:03:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:03:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:03:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:03:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:03:10 INFO - 'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:03:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:03:10 INFO - 'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['damp', 'tps']}, 09:03:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:03:10 INFO - 'tests': ['damp', 'tps']}, 09:03:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['dromaeo_dom']}, 09:03:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:03:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:03:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['a11yr', 09:03:10 INFO - 'ts_paint', 09:03:10 INFO - 'tpaint', 09:03:10 INFO - 'sessionrestore', 09:03:10 INFO - 'sessionrestore_no_auto_restore', 09:03:10 INFO - 'tabpaint']}, 09:03:10 INFO - 'other-e10s': {'tests': ['a11yr', 09:03:10 INFO - 'ts_paint', 09:03:10 INFO - 'tpaint', 09:03:10 INFO - 'sessionrestore', 09:03:10 INFO - 'sessionrestore_no_auto_restore', 09:03:10 INFO - 'tabpaint']}, 09:03:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:03:10 INFO - 'ts_paint', 09:03:10 INFO - 'tpaint', 09:03:10 INFO - 'sessionrestore', 09:03:10 INFO - 'sessionrestore_no_auto_restore', 09:03:10 INFO - 'tabpaint']}, 09:03:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:03:10 INFO - 'ts_paint', 09:03:10 INFO - 'tpaint', 09:03:10 INFO - 'sessionrestore', 09:03:10 INFO - 'sessionrestore_no_auto_restore', 09:03:10 INFO - 'tabpaint']}, 09:03:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['a11yr', 09:03:10 INFO - 'ts_paint', 09:03:10 INFO - 'tpaint', 09:03:10 INFO - 'sessionrestore', 09:03:10 INFO - 'sessionrestore_no_auto_restore', 09:03:10 INFO - 'tabpaint']}, 09:03:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['a11yr', 09:03:10 INFO - 'ts_paint', 09:03:10 INFO - 'tpaint', 09:03:10 INFO - 'sessionrestore', 09:03:10 INFO - 'sessionrestore_no_auto_restore', 09:03:10 INFO - 'tabpaint']}, 09:03:10 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:03:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:03:10 INFO - 'bloom_basic_ref']}, 09:03:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['tsvgx', 09:03:10 INFO - 'tsvgr_opacity', 09:03:10 INFO - 'tart', 09:03:10 INFO - 'tscrollx', 09:03:10 INFO - 'cart', 09:03:10 INFO - 'tsvg_static']}, 09:03:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:03:10 INFO - 'tsvgr_opacity', 09:03:10 INFO - 'tart', 09:03:10 INFO - 'tscrollx', 09:03:10 INFO - 'cart', 09:03:10 INFO - 'tsvg_static']}, 09:03:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:03:10 INFO - 'talos_options': ['--disable-e10s'], 09:03:10 INFO - 'tests': ['tp5o']}, 09:03:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:03:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:03:10 INFO - 'talos_options': ['--disable-e10s', 09:03:10 INFO - '--xperf_path', 09:03:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:10 INFO - 'tests': ['tp5n']}, 09:03:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:03:10 INFO - 'talos_options': ['--xperf_path', 09:03:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:10 INFO - 'tests': ['tp5n']}}, 09:03:10 INFO - 'talos.zip': {'path': '', 09:03:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:10 INFO - Running post-action listener: _resource_record_post_action 09:03:10 INFO - [mozharness: 2017-05-04 16:03:10.082634Z] Finished populate-webroot step (success) 09:03:10 INFO - [mozharness: 2017-05-04 16:03:10.082723Z] Running create-virtualenv step. 09:03:10 INFO - Running pre-action listener: _resource_record_pre_action 09:03:10 INFO - Running main action method: create_virtualenv 09:03:10 INFO - Creating virtualenv /builds/slave/test/build/venv 09:03:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:03:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:03:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:10 INFO - Using real prefix '/usr' 09:03:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:03:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:12 INFO - Installing pip.................done. 09:03:12 INFO - Return code: 0 09:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:03:12 INFO - Reading from file tmpfile_stdout 09:03:12 INFO - Output received: 09:03:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:03:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:12 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 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:03:12 INFO - Using env: {'DISPLAY': ':0', 09:03:12 INFO - 'HOME': '/home/cltbld', 09:03:12 INFO - 'LANG': 'en_US.UTF-8', 09:03:12 INFO - 'LANGUAGE': 'en_US:en', 09:03:12 INFO - 'LOGNAME': 'cltbld', 09:03:12 INFO - 'MAIL': '/var/mail/cltbld', 09:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:12 INFO - 'MOZ_NO_REMOTE': '1', 09:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:12 INFO - 'NO_EM_RESTART': '1', 09:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:12 INFO - 'PWD': '/builds/slave/test', 09:03:12 INFO - 'SHELL': '/bin/bash', 09:03:12 INFO - 'SHLVL': '1', 09:03:12 INFO - 'TERM': 'linux', 09:03:12 INFO - 'TMOUT': '86400', 09:03:12 INFO - 'USER': 'cltbld', 09:03:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:12 INFO - '_': '/tools/buildbot/bin/python'} 09:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:03:13 INFO - Cleaning up... 09:03:13 INFO - Return code: 0 09:03:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:13 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 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:03:13 INFO - Using env: {'DISPLAY': ':0', 09:03:13 INFO - 'HOME': '/home/cltbld', 09:03:13 INFO - 'LANG': 'en_US.UTF-8', 09:03:13 INFO - 'LANGUAGE': 'en_US:en', 09:03:13 INFO - 'LOGNAME': 'cltbld', 09:03:13 INFO - 'MAIL': '/var/mail/cltbld', 09:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:13 INFO - 'MOZ_NO_REMOTE': '1', 09:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:13 INFO - 'NO_EM_RESTART': '1', 09:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:13 INFO - 'PWD': '/builds/slave/test', 09:03:13 INFO - 'SHELL': '/bin/bash', 09:03:13 INFO - 'SHLVL': '1', 09:03:13 INFO - 'TERM': 'linux', 09:03:13 INFO - 'TMOUT': '86400', 09:03:13 INFO - 'USER': 'cltbld', 09:03:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:13 INFO - '_': '/tools/buildbot/bin/python'} 09:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:13 INFO - Downloading/unpacking psutil>=3.1.1 09:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:14 INFO - Installing collected packages: psutil 09:03:14 INFO - Running setup.py install for psutil 09:03:14 INFO - building 'psutil._psutil_linux' extension 09:03:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:03:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:03:14 INFO - building 'psutil._psutil_posix' extension 09:03:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:03:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:03:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:14 INFO - Successfully installed psutil 09:03:14 INFO - Cleaning up... 09:03:15 INFO - Return code: 0 09:03:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:03:15 INFO - Using env: {'DISPLAY': ':0', 09:03:15 INFO - 'HOME': '/home/cltbld', 09:03:15 INFO - 'LANG': 'en_US.UTF-8', 09:03:15 INFO - 'LANGUAGE': 'en_US:en', 09:03:15 INFO - 'LOGNAME': 'cltbld', 09:03:15 INFO - 'MAIL': '/var/mail/cltbld', 09:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:15 INFO - 'MOZ_NO_REMOTE': '1', 09:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:15 INFO - 'NO_EM_RESTART': '1', 09:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:15 INFO - 'PWD': '/builds/slave/test', 09:03:15 INFO - 'SHELL': '/bin/bash', 09:03:15 INFO - 'SHLVL': '1', 09:03:15 INFO - 'TERM': 'linux', 09:03:15 INFO - 'TMOUT': '86400', 09:03:15 INFO - 'USER': 'cltbld', 09:03:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:15 INFO - '_': '/tools/buildbot/bin/python'} 09:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:03:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:03:16 INFO - Installing collected packages: mozsystemmonitor 09:03:16 INFO - Running setup.py install for mozsystemmonitor 09:03:16 INFO - Successfully installed mozsystemmonitor 09:03:16 INFO - Cleaning up... 09:03:16 INFO - Return code: 0 09:03:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:16 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 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:03:16 INFO - Using env: {'DISPLAY': ':0', 09:03:16 INFO - 'HOME': '/home/cltbld', 09:03:16 INFO - 'LANG': 'en_US.UTF-8', 09:03:16 INFO - 'LANGUAGE': 'en_US:en', 09:03:16 INFO - 'LOGNAME': 'cltbld', 09:03:16 INFO - 'MAIL': '/var/mail/cltbld', 09:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:16 INFO - 'MOZ_NO_REMOTE': '1', 09:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:16 INFO - 'NO_EM_RESTART': '1', 09:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:16 INFO - 'PWD': '/builds/slave/test', 09:03:16 INFO - 'SHELL': '/bin/bash', 09:03:16 INFO - 'SHLVL': '1', 09:03:16 INFO - 'TERM': 'linux', 09:03:16 INFO - 'TMOUT': '86400', 09:03:16 INFO - 'USER': 'cltbld', 09:03:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:16 INFO - '_': '/tools/buildbot/bin/python'} 09:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:16 INFO - Downloading/unpacking jsonschema==2.5.1 09:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:17 INFO - warning: no files found matching '*.txt' 09:03:17 INFO - no previously-included directories found matching 'build' 09:03:17 INFO - no previously-included directories found matching 'dist' 09:03:17 INFO - no previously-included directories found matching '.git*' 09:03:17 INFO - Installing collected packages: jsonschema, functools32 09:03:18 INFO - Running setup.py install for functools32 09:03:18 INFO - warning: no files found matching '*.txt' 09:03:18 INFO - no previously-included directories found matching 'build' 09:03:18 INFO - no previously-included directories found matching 'dist' 09:03:18 INFO - no previously-included directories found matching '.git*' 09:03:18 INFO - Successfully installed jsonschema functools32 09:03:18 INFO - Cleaning up... 09:03:18 INFO - Return code: 0 09:03:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:18 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 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:03:18 INFO - Using env: {'DISPLAY': ':0', 09:03:18 INFO - 'HOME': '/home/cltbld', 09:03:18 INFO - 'LANG': 'en_US.UTF-8', 09:03:18 INFO - 'LANGUAGE': 'en_US:en', 09:03:18 INFO - 'LOGNAME': 'cltbld', 09:03:18 INFO - 'MAIL': '/var/mail/cltbld', 09:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:18 INFO - 'MOZ_NO_REMOTE': '1', 09:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:18 INFO - 'NO_EM_RESTART': '1', 09:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:18 INFO - 'PWD': '/builds/slave/test', 09:03:18 INFO - 'SHELL': '/bin/bash', 09:03:18 INFO - 'SHLVL': '1', 09:03:18 INFO - 'TERM': 'linux', 09:03:18 INFO - 'TMOUT': '86400', 09:03:18 INFO - 'USER': 'cltbld', 09:03:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:18 INFO - '_': '/tools/buildbot/bin/python'} 09:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:03:18 INFO - Cleaning up... 09:03:18 INFO - Return code: 0 09:03:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:18 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 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:03:18 INFO - Using env: {'DISPLAY': ':0', 09:03:18 INFO - 'HOME': '/home/cltbld', 09:03:18 INFO - 'LANG': 'en_US.UTF-8', 09:03:18 INFO - 'LANGUAGE': 'en_US:en', 09:03:18 INFO - 'LOGNAME': 'cltbld', 09:03:18 INFO - 'MAIL': '/var/mail/cltbld', 09:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:18 INFO - 'MOZ_NO_REMOTE': '1', 09:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:18 INFO - 'NO_EM_RESTART': '1', 09:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:18 INFO - 'PWD': '/builds/slave/test', 09:03:18 INFO - 'SHELL': '/bin/bash', 09:03:18 INFO - 'SHLVL': '1', 09:03:18 INFO - 'TERM': 'linux', 09:03:18 INFO - 'TMOUT': '86400', 09:03:18 INFO - 'USER': 'cltbld', 09:03:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:18 INFO - '_': '/tools/buildbot/bin/python'} 09:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:19 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03: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 09:03: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 09:03: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 09:03: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 09:03: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 09:03: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 09:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:03:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:20 INFO - Downloading docopt-0.6.1.tar.gz 09:03:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:20 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:20 INFO - Running setup.py install for blobuploader 09:03:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:03:20 INFO - Running setup.py install for requests 09:03:20 INFO - Running setup.py install for docopt 09:03:20 INFO - Successfully installed blobuploader requests docopt 09:03:20 INFO - Cleaning up... 09:03:20 INFO - Return code: 0 09:03:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:20 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 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:03:20 INFO - Using env: {'DISPLAY': ':0', 09:03:20 INFO - 'HOME': '/home/cltbld', 09:03:20 INFO - 'LANG': 'en_US.UTF-8', 09:03:20 INFO - 'LANGUAGE': 'en_US:en', 09:03:20 INFO - 'LOGNAME': 'cltbld', 09:03:20 INFO - 'MAIL': '/var/mail/cltbld', 09:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:20 INFO - 'MOZ_NO_REMOTE': '1', 09:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:20 INFO - 'NO_EM_RESTART': '1', 09:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:20 INFO - 'PWD': '/builds/slave/test', 09:03:20 INFO - 'SHELL': '/bin/bash', 09:03:20 INFO - 'SHLVL': '1', 09:03:20 INFO - 'TERM': 'linux', 09:03:20 INFO - 'TMOUT': '86400', 09:03:20 INFO - 'USER': 'cltbld', 09:03:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:20 INFO - '_': '/tools/buildbot/bin/python'} 09:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:21 INFO - Running setup.py (path:/tmp/pip-8Fd49Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:21 INFO - Running setup.py (path:/tmp/pip-EA9SBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:21 INFO - Running setup.py (path:/tmp/pip-wpjcJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:21 INFO - Running setup.py (path:/tmp/pip-Rr4GPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:21 INFO - Running setup.py (path:/tmp/pip-I5p7G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:21 INFO - Running setup.py (path:/tmp/pip-Wa98sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:21 INFO - Running setup.py (path:/tmp/pip-3eJfWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:21 INFO - Running setup.py (path:/tmp/pip-XwXPWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:21 INFO - Running setup.py (path:/tmp/pip-EqeIpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:21 INFO - Running setup.py (path:/tmp/pip-zvOzGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:21 INFO - Running setup.py (path:/tmp/pip-ckWF3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:21 INFO - Running setup.py (path:/tmp/pip-SAflin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:22 INFO - Running setup.py (path:/tmp/pip-b1g7WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:22 INFO - Running setup.py (path:/tmp/pip-A24rai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:22 INFO - Running setup.py (path:/tmp/pip-BwhOKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:22 INFO - Running setup.py (path:/tmp/pip-gwA5Pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:22 INFO - Running setup.py (path:/tmp/pip-ht_e_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:22 INFO - Running setup.py install for manifestparser 09:03:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for mozcrash 09:03:22 INFO - Running setup.py install for mozdebug 09:03:22 INFO - Running setup.py install for mozdevice 09:03:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for mozfile 09:03:22 INFO - Running setup.py install for mozhttpd 09:03:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for mozinfo 09:03:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Running setup.py install for mozInstall 09:03:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Running setup.py install for mozleak 09:03:23 INFO - Running setup.py install for mozlog 09:03:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Running setup.py install for moznetwork 09:03:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Running setup.py install for mozprocess 09:03:23 INFO - Running setup.py install for mozprofile 09:03:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Running setup.py install for mozrunner 09:03:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Running setup.py install for mozscreenshot 09:03:23 INFO - Running setup.py install for moztest 09:03:24 INFO - Running setup.py install for mozversion 09:03:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:03:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:24 INFO - Cleaning up... 09:03:24 INFO - Return code: 0 09:03:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:24 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 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:03:24 INFO - Using env: {'DISPLAY': ':0', 09:03:24 INFO - 'HOME': '/home/cltbld', 09:03:24 INFO - 'LANG': 'en_US.UTF-8', 09:03:24 INFO - 'LANGUAGE': 'en_US:en', 09:03:24 INFO - 'LOGNAME': 'cltbld', 09:03:24 INFO - 'MAIL': '/var/mail/cltbld', 09:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:24 INFO - 'MOZ_NO_REMOTE': '1', 09:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:24 INFO - 'NO_EM_RESTART': '1', 09:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:24 INFO - 'PWD': '/builds/slave/test', 09:03:24 INFO - 'SHELL': '/bin/bash', 09:03:24 INFO - 'SHLVL': '1', 09:03:24 INFO - 'TERM': 'linux', 09:03:24 INFO - 'TMOUT': '86400', 09:03:24 INFO - 'USER': 'cltbld', 09:03:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:24 INFO - '_': '/tools/buildbot/bin/python'} 09:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:24 INFO - Running setup.py (path:/tmp/pip-Ajze43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:24 INFO - Running setup.py (path:/tmp/pip-TPW0Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:24 INFO - Running setup.py (path:/tmp/pip-eSVg11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:24 INFO - Running setup.py (path:/tmp/pip-_5eEue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:24 INFO - Running setup.py (path:/tmp/pip-JI450z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:24 INFO - Running setup.py (path:/tmp/pip-_tFQI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:24 INFO - Running setup.py (path:/tmp/pip-5qKAdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:24 INFO - Running setup.py (path:/tmp/pip-zR4lmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:24 INFO - Running setup.py (path:/tmp/pip-IorMnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:25 INFO - Running setup.py (path:/tmp/pip-hE8wTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:25 INFO - Running setup.py (path:/tmp/pip-rGEJVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:25 INFO - Running setup.py (path:/tmp/pip-I2ykFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:25 INFO - Running setup.py (path:/tmp/pip-DtwRuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:25 INFO - Running setup.py (path:/tmp/pip-6fS88u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:25 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)) 09:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:25 INFO - Running setup.py (path:/tmp/pip-gj3vQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:25 INFO - Running setup.py (path:/tmp/pip-nJjRQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:25 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)) 09:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:25 INFO - Running setup.py (path:/tmp/pip-Lef_Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:03:25 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)) 09:03:25 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)) 09:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:03:25 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:25 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03: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 09:03: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 09:03: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 09:03: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 09:03: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 09:03: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 09:03:26 INFO - Downloading blessings-1.6.tar.gz 09:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:26 INFO - Installing collected packages: blessings 09:03:26 INFO - Running setup.py install for blessings 09:03:26 INFO - Successfully installed blessings 09:03:26 INFO - Cleaning up... 09:03:26 INFO - Return code: 0 09:03:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:27 INFO - Reading from file tmpfile_stdout 09:03:27 INFO - Current package versions: 09:03:27 INFO - argparse == 1.2.1 09:03:27 INFO - blessings == 1.6 09:03:27 INFO - blobuploader == 1.2.4 09:03:27 INFO - docopt == 0.6.1 09:03:27 INFO - functools32 == 3.2.3-2 09:03:27 INFO - jsonschema == 2.5.1 09:03:27 INFO - manifestparser == 1.1 09:03:27 INFO - mozInstall == 1.12 09:03:27 INFO - mozcrash == 1.0 09:03:27 INFO - mozdebug == 0.1 09:03:27 INFO - mozdevice == 0.50 09:03:27 INFO - mozfile == 1.2 09:03:27 INFO - mozhttpd == 0.7 09:03:27 INFO - mozinfo == 0.9 09:03:27 INFO - mozleak == 0.1 09:03:27 INFO - mozlog == 3.4 09:03:27 INFO - moznetwork == 0.27 09:03:27 INFO - mozprocess == 0.25 09:03:27 INFO - mozprofile == 0.28 09:03:27 INFO - mozrunner == 6.13 09:03:27 INFO - mozscreenshot == 0.1 09:03:27 INFO - mozsystemmonitor == 0.3 09:03:27 INFO - moztest == 0.8 09:03:27 INFO - mozversion == 1.4 09:03:27 INFO - psutil == 3.1.1 09:03:27 INFO - requests == 1.2.3 09:03:27 INFO - wsgiref == 0.1.2 09:03:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:27 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 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:03:27 INFO - Using env: {'DISPLAY': ':0', 09:03:27 INFO - 'HOME': '/home/cltbld', 09:03:27 INFO - 'LANG': 'en_US.UTF-8', 09:03:27 INFO - 'LANGUAGE': 'en_US:en', 09:03:27 INFO - 'LOGNAME': 'cltbld', 09:03:27 INFO - 'MAIL': '/var/mail/cltbld', 09:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:27 INFO - 'MOZ_NO_REMOTE': '1', 09:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:27 INFO - 'NO_EM_RESTART': '1', 09:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:27 INFO - 'PWD': '/builds/slave/test', 09:03:27 INFO - 'SHELL': '/bin/bash', 09:03:27 INFO - 'SHLVL': '1', 09:03:27 INFO - 'TERM': 'linux', 09:03:27 INFO - 'TMOUT': '86400', 09:03:27 INFO - 'USER': 'cltbld', 09:03:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:27 INFO - '_': '/tools/buildbot/bin/python'} 09:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:03:27 INFO - Cleaning up... 09:03:27 INFO - Return code: 0 09:03:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2858b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03: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', 'jsonschema'] in /builds/slave/test/build 09:03: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 jsonschema 09:03:27 INFO - Using env: {'DISPLAY': ':0', 09:03:27 INFO - 'HOME': '/home/cltbld', 09:03:27 INFO - 'LANG': 'en_US.UTF-8', 09:03:27 INFO - 'LANGUAGE': 'en_US:en', 09:03:27 INFO - 'LOGNAME': 'cltbld', 09:03:27 INFO - 'MAIL': '/var/mail/cltbld', 09:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:27 INFO - 'MOZ_NO_REMOTE': '1', 09:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:27 INFO - 'NO_EM_RESTART': '1', 09:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:27 INFO - 'PWD': '/builds/slave/test', 09:03:27 INFO - 'SHELL': '/bin/bash', 09:03:27 INFO - 'SHLVL': '1', 09:03:27 INFO - 'TERM': 'linux', 09:03:27 INFO - 'TMOUT': '86400', 09:03:27 INFO - 'USER': 'cltbld', 09:03:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:27 INFO - '_': '/tools/buildbot/bin/python'} 09:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:03:27 INFO - Cleaning up... 09:03:27 INFO - Return code: 0 09:03:27 INFO - Running post-action listener: _resource_record_post_action 09:03:27 INFO - Running post-action listener: _start_resource_monitoring 09:03:27 INFO - Starting resource monitoring. 09:03:27 INFO - [mozharness: 2017-05-04 16:03:27.624129Z] Finished create-virtualenv step (success) 09:03:27 INFO - [mozharness: 2017-05-04 16:03:27.624650Z] Running install step. 09:03:27 INFO - Running pre-action listener: _resource_record_pre_action 09:03:27 INFO - Running main action method: install 09:03:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:27 INFO - Reading from file tmpfile_stdout 09:03:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:03:27 INFO - Reading from file tmpfile_stdout 09:03:27 INFO - Output received: 09:03:27 INFO - Usage: mozinstall [options] installer 09:03:27 INFO - Options: 09:03:27 INFO - -h, --help show this help message and exit 09:03:27 INFO - -d DEST, --destination=DEST 09:03:27 INFO - Directory to install application into. [default: 09:03:27 INFO - "/builds/slave/test"] 09:03:27 INFO - --app=APP Application being installed. [default: firefox] 09:03:27 INFO - mkdir: /builds/slave/test/build/application 09:03:27 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'] 09:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:03:42 INFO - Reading from file tmpfile_stdout 09:03:42 INFO - Output received: 09:03:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:03:42 INFO - Running post-action listener: _resource_record_post_action 09:03:42 INFO - [mozharness: 2017-05-04 16:03:42.782426Z] Finished install step (success) 09:03:42 INFO - [mozharness: 2017-05-04 16:03:42.782702Z] Running run-tests step. 09:03:42 INFO - Running pre-action listener: _resource_record_pre_action 09:03:42 INFO - Running main action method: run_tests 09:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:03:42 INFO - Python 2.7.3 09:03:42 INFO - Return code: 0 09:03:42 INFO - grabbing minidump binary from tooltool 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:42 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 0x2856290>, '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 0x2856b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2857040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:03:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:03:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:03:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:03:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:03:42 INFO - Return code: 0 09:03:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:03:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:03:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:03:42 INFO - ENV: RUST_BACKTRACE is now 1 09:03:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:03:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:03:42 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/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 09:03:42 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/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 09:03:42 INFO - Using env: {'DISPLAY': ':0', 09:03:42 INFO - 'HOME': '/home/cltbld', 09:03:42 INFO - 'LANG': 'en_US.UTF-8', 09:03:42 INFO - 'LANGUAGE': 'en_US:en', 09:03:42 INFO - 'LOGNAME': 'cltbld', 09:03:42 INFO - 'MAIL': '/var/mail/cltbld', 09:03:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:03:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:42 INFO - 'MOZ_NO_REMOTE': '1', 09:03:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:42 INFO - 'NO_EM_RESTART': '1', 09:03:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:42 INFO - 'PWD': '/builds/slave/test', 09:03:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:03:42 INFO - 'RUST_BACKTRACE': '1', 09:03:42 INFO - 'SHELL': '/bin/bash', 09:03:42 INFO - 'SHLVL': '1', 09:03:42 INFO - 'TERM': 'linux', 09:03:42 INFO - 'TMOUT': '86400', 09:03:42 INFO - 'USER': 'cltbld', 09:03:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462', 09:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:42 INFO - '_': '/tools/buildbot/bin/python'} 09:03:42 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/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 09:03:43 INFO - mozversion application_buildid: 20170504154001 09:03:43 INFO - mozversion application_changeset: 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a 09:03:43 INFO - mozversion application_display_name: Nightly 09:03:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:03:43 INFO - mozversion application_name: Firefox 09:03:43 INFO - mozversion application_remotingname: firefox 09:03:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:03:43 INFO - mozversion application_vendor: Mozilla 09:03:43 INFO - mozversion application_version: 55.0a1 09:03:43 INFO - mozversion platform_buildid: 20170504154001 09:03:43 INFO - mozversion platform_changeset: 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a 09:03:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:03:43 INFO - mozversion platform_version: 55.0a1 09:03:43 INFO - using testdate: 1493913823 09:03:43 INFO - actual date: 1493913823 09:03:43 INFO - starting webserver on 'localhost:59647' 09:03:43 INFO - SUITE-START | Running 2 tests 09:03:43 INFO - TEST-START | dromaeo_css 09:03:43 INFO - operating with platform_type : linux_ 09:03:43 INFO - Initialising browser for dromaeo_css test... 09:03:43 INFO - TEST-INFO | started process 26335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZrUIe9/profile http://localhost:59647/getInfo.html) 09:03:47 INFO - PID 26335 | __metrics Screen width/height:1600/1200 09:03:47 INFO - PID 26335 | colorDepth:24 09:03:47 INFO - PID 26335 | Browser inner width/height: 1024/695 09:03:47 INFO - PID 26335 | __metrics 09:03:48 INFO - PID 26335 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:03:48 INFO - PID 26335 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:03:49 INFO - TEST-INFO | 26335: exit 0 09:03:49 INFO - Browser initialized. 09:03:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:03:49 INFO - TEST-INFO | started process 26428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZrUIe9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:01 INFO - PID 26428 | RSS: Main: 154251264 09:04:01 INFO - PID 26428 | 09:07:08 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59647/tests/dromaeo/cssquery-ext.html) 09:07:10 INFO - PID 26428 | RSS: Main: 255168512 09:07:10 INFO - PID 26428 | 09:10:12 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-ext.html (next: http://localhost:59647/tests/dromaeo/cssquery-jquery.html) 09:10:13 INFO - PID 26428 | RSS: Main: 232910848 09:10:13 INFO - PID 26428 | 09:13:15 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59647/tests/dromaeo/cssquery-mootools.html) 09:13:16 INFO - PID 26428 | RSS: Main: 175239168 09:13:16 INFO - PID 26428 | 09:16:18 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59647/tests/dromaeo/cssquery-prototype.html) 09:16:19 INFO - PID 26428 | RSS: Main: 231792640 09:16:19 INFO - PID 26428 | 09:19:22 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59647/tests/dromaeo/cssquery-yui.html) 09:19:22 INFO - PID 26428 | RSS: Main: 177111040 09:19:22 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-yui.html (next: http://localhost:59647/tests/dromaeo/cssquery-dojo.html) 09:22:24 INFO - PID 26428 | RSS: Main: 273051648 09:22:24 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | __start_tp_report 09:22:24 INFO - PID 26428 | _x_x_mozilla_page_load 09:22:24 INFO - PID 26428 | _x_x_mozilla_page_load_details 09:22:24 INFO - PID 26428 | |i|pagename|runs| 09:22:24 INFO - PID 26428 | |0;dojo.html;2715.253305341032;2716.9456610867783;2751.064638023072;2760.516909540831;2761.226856480186;5154.716490593016;5260.158374660045;5290.735463226838;5314.78740850366;5336.573074154063;5285.471452854713;5298.682079075248;5306.124489459235;5350.705711185883;5359.9732001339935;4387.868363949071;4560.475545312298;4654.371659825931;4696.29555566666;4749.691270067452;4713.7643117844145;4713.835015774465;4737.92893106602;4745.21703918853;4774.331593576902;4610.585047345755;4651;4673.369095172142;4678.508756580544;4724.929126063112;4698.718076915396;4702.059588082363;4703.576678098988;4748.881277968078;4769.332293478916;4634.21218392874;4685.320628508881;4706.858794236178;4716.245400735866;4748.121597504438;5174.327337446146;5226.268322434862;5240.685558866442;5262.131748261532;5288;5639.295088113986;5643.8589035274035;5647.463490968393;5652.265205523256;5653.886922261532;5671.829845104653;5672.06410942194;5681.857953551153;5684.317881854163;5689.402612725687;5291.867703307448;5344.118220493653;5370.382406023318;5380.166074258496;5398.568114550826;5744.827655170351;5822.970885145547;5875.177475153482;5888.587798854125;5888.646681199141;5567.582431317667;5573.60984731073;5588.832335029955;5653.632513886584;5655.095184770417;5735.8852822944145;5737.483626473638;5740.42595740431;5741.712914354265;5743.396943320975;5662.943370566324;5676.858078547987;5718.79984200551;5720.771169153188;5722.313322401338;5693.658380497183;5734.225879506297;5743.368229494752;5750;5754.309482862083;4754.809807607657;4754.97767979886;4755.358026666425;4757.26262429324;4800.73595952226;4002.3796311571755;4073.103917138225;4099.61053699898;4104.076582768853;4138.255114079495;4749.501302363271;4782.0914026334885;4834.274858771142;4835.1296766581645;4854.951450485521;5717.656940583495;5739.139129130664;5739.827805165852;5741.569382296345;5750;4786.1863483207935;4800.039992001543;4801.51984801517;4807.4471435784635;4846.878828029327;4971.254311853251;5036.11867923112;5041.546260836542;5112.514311140436;5112.821051263188;5247.396549396868;5248.8425347239645;5249.632525723163;5252.763625636779;5298.125809241432;5672.716364181857;5674.290713660793;5675.7445914933105;5702.885942281214;5725.255716756795;5197.922031169611;5252.474752524717;5252.711100889488;5258.342707161605;5342.839714808562;5641.887162256814;5648.887022259614;5667.85830354228;5673.602847800615;5699.5725320600295;5669.4047125051275;5714.742836572281;5723.6851973141875;5725.370209276893;5745.856353591026;5373.9731301343245;5503.477169668875;5506.614536982373;5550.222968784454;5556.805511807067;5485.122380419114;5533.418991006048;5564.666120032811;5566.693831839126;5577.832665020056;5317.1226747586215;5381.515663590296;5459.972700136474;5484.808031718871;5487.122060470306;5544.41783612731;5559.944400555943;5593.860153496195;5612.214289999321;5619.550435965031;5367.543758780547;5368.624196306221;5432.972835135957;5435.293411856592;5435.701036443033 09:22:24 INFO - PID 26428 | |1;ext.html;727.7052793618585;743.4758495260842;1056.5245639462244;1066.6266806617684;1073.3077165228433;29782.851085744594;32936.67063329366;32948;33039.50440743385;33089.172770680685;33959.83020084896;34420.31159376811;34438.31123377537;34469.65530344696;34489.65510344896;5324.148136298193;6845.965770171155;6970.372666460017;6974.476914231427;6978.79063628092;5356.678599284036;6823.556468829535;6974.965125174367;6975.337342952437;6976.755813546527;7011.158660960692;7044.119485064367;7060;7065.89401158983;7067.399271061966;5313.335833020872;6992.230854605989;7052.5415847970235;7054.894176587355;7060.152781666233;5390.0836857734275;6763.729450821961;6936.271691472423;6946.965265173692;6951.096357473547;32699.50950735741;33012.339753205044;33112.50331245033;33112.834435827666;33139.171520711934;3069.109958112145;3086.9536956945662;3110.0514343125337;3111.828849413281;3114.5172498262577;24426.633600496007;24588.385290367885;24602.753972460403;24639.876800615883;24650.630240546227;2678.450917561895;2678.7053424123333;2690.3543149643942;2697.5818748094075;2706.930762348861;141755;142020;142210;142216;143460.28269858687;34321.31357372839;35043.4743478848;40819.7959010209;40850.18299633991;40854.591454085676;39639.80180099081;41628.58371416308;41650.37524437136;41665;41672;11583.247088939192;11676.124290678234;11679.240849344766;11688.240264382788;11688.298702077902;9267.675631353006;9277.443353398818;9277.67528136512;9284.675036373694;9287.117723816227;11676.883231167749;11685.415729213675;11690.590829321103;11729.765404691858;11862.347570883512;4868.732219727878;4873.512648735098;4873.853784386474;4877.487863774252;4900.730459824744;857.9356548258905;859.7893516088474;891.5675897189988;915.2540679346312;924.5931790012507;20206.59586808285;20611.58776824455;25592.331795761216;26595.468090638467;26630.866845666034;960.9327347085637;962.1869520255373;967.5506818193119;973.075578200698;979.3177652028425;10791.892081079246;11145.554177832795;11421.086313094933;11484.310941343547;11512.309261444172;170313;170614;170778;170899;170942;39225.60774392277;39265.41101883474;39267.60732392697;39281.21437571233;39424.80287598601;1177.929625756879;1230.3171739684383;1230.6062060140669;1232.38380809597;1234.0621127942827;19520.707189391887;19860.70208946896;20203.79796202019;20328.59342813165;20733.89633051825;28750;28806.670765908373;28810.135695929155;28811.135665930055;28821.855890720413;146584;148549;148668.256658716;149996;150066;24466.633000505364;24989.625155623045;24999.12503062384;27456.862715686293;27637.58543621807;29808.552871707376;30331.39337213199;30352.241193970327;30362;34200.82899585486;25563.744362556135;26911.192664220103;26974.865125674245;27141.86429067842;28006;25793.613095803954;26502.07242746572;26897;27059.594106088818;27411.86294068517;28886.277843054093;28939.42121157523;29180;29359;29504.557431638972;25063.373415664755;25541.87229063843;25624.23127306184;25956.09153679612;27068.1879543614;19421.51446213856;20740.438734313255;21118.155273788878;21238.681419779026;21314.467138321666 09:22:24 INFO - PID 26428 | |2;jquery.html;400.7495315427859;409.61700809742894;409.93441049432096;423.6970566045277;426.14770459081836;12698.4920603176;14899.32953017114;16944.91527542362;17662.38181663642;17677.734833977484;17819.287228510875;18077.7288340675;18362;18386.540336491595;18685.626287474275;5540.168974653804;5630.634008789416;5658.688772117532;5661.405552416999;5664.0937450008005;5564.360098588673;5612.102063669814;5614;5615.101583746601;5616.382197958222;5533.142362933731;5571.888562228753;5571.8885622287735;5589.161625756149;5593.944060559383;5346.679199248058;5500.80747173851;5505.119180931052;5505.229267902497;5508;4861.246506791453;4997.325361076245;5003.774830132653;5009.223570346566;5012.27322038306;22181.667274990887;22460;22465.550688986128;22663.886680566655;22858.88570557153;1654.586353411647;1669.8413650703164;1677.714788485948;1680.9579760505962;1681.0502066332606;13827.308634568331;14162.530180105838;14570.052946558546;14668.706625867422;14708.411663533447;2029.4013266086392;2032.400441869652;2067;2075.968860467094;2126.1070350452846;68953.65523172352;84187;84796.81784564938;87808.56095719544;88699;10716.892831071746;10928.836067458995;10980.121590272758;10994.560217591366;11072.667819965414;15123.243837808066;15146.091234525964;15212.315445804965;15225.543233703007;15227.477252274684;7191.316824901626;7261.963690181621;7375.557466552024;7476.140243871915;7511.8497630047095;6530.477561795045;6611.933880661228;6704.329567043256;6815.897761533581;6872.484563657746;6846.383825455733;6925.272846351161;6978.825529361807;6999.243540231764;7015.403690686348;1939.7478327817576;1970.6748386516065;1974.59520798236;2005;2061.814436700704;821.6631181215673;851.6848765956636;872.9127087291347;884.9070847561043;894.1684233662756;16724.58188545296;16741;16838.410655627238;17128.486145415656;17314.740278895828;858.3390789092489;867.2714919467552;869.9391042627082;872.6422166911536;879.9780005499914;9101.022143958107;9221.262299016063;9448.244140468745;9495.620175193053;9724.805503890024;341518;344927;344957;347461;348096;78459;80345.19654803495;80459.19540804517;80898.59550702326;81378;1057.3074636113358;1066.9679909602569;1104.100158370925;1109.6615532262738;1111.344306858957;17947.192376342835;18291.1768970394;18797.812021879607;18931.242750290385;19162.904185478983;37399.626003740705;38619;38852.41721374125;38868;39656;48345;48672.75663621659;48979.75510122427;49073.5092649069;51783.2232516505;8232.547209903512;8249.381296402673;8281.503109813431;8408.411411201158;8651.95674021626;12401.813972790234;12472.002239820975;12713;13130.606081817561;13211.933940330237;10862.456877155953;11311.321320720783;11470.082393408675;11526.711832204262;11791.174617776673;10370.844437333295;10468.371897686164;10715.624953126604;10732.946335268274;10778.784424311627;10658.520366583367;11104.888951110708;11494.94252528732;11571.826422603499;11581.073514119018;8179.955011247188;8216.548089855116;8247.835043298981;8431.241188293083;8445.239928406472;11195.328280303207;11222.158338124511;11375.374354410587;11473;11884.643460696192 09:22:24 INFO - PID 26428 | |3;mootools.html;1219.5975328141715;1276.6361586947721;1289.516431338248;1292.5476083370816;1295.391166151909;9615.278854085946;10021.098101170894;10021.544721543214;10032.147267482254;10033.548490317935;9806.264530160232;10391.116755075827;10395.896041039587;10397.480125993688;10412;2126.0220298662634;2127.266093197848;2147.473868902121;2160.351894431672;2170.717806685129;1627.6988757079919;1980.6137803128324;2018.7476565429322;2051.9589608207825;2094.937151885446;1836.9632607347912;1955.4426988308335;2084.114251443131;2093.7592176899625;2095.6123117223287;2032.8373730101557;2035.033359154412;2037.5109973606227;2042.5404284036122;2044.580860923507;1711;1891.8581106417073;1924.5765931495048;1926.364299781069;1930.2664987304875;8802.471851688855;8866.86699699505;8868.822623547492;8874.600642971081;8877.467351958903;5298.443663415324;5545.944540554583;5551.805686800943;5555.916661250085;5576.052071147915;3097.3185899102164;3307.090550098718;3392.406328892434;3418.060033490785;3432.5537680101675;1055.219137838002;1062.5909025025421;1084.804735147673;1087.445402844547;1093.5953697132034;14710.338034788354;15009.024413413093;15014.399424023026;15017.549473515703;15061.623459413493;4781.42622885256;4973.577245934136;5091.872703182376;5096.413912400121;5114.258432527263;12594.488661360696;12614.495420183273;12623.810642840364;12624;12651.493940242472;5681.233033540502;5682.289713785777;5682.573806964411;5690.829275121753;5692.345380281238;4892;5041.6722913010535;5078.873028174251;5111.846644600668;5122.564582010571;4117.3206420940205;4211.557786432441;4216.304309788912;4231.8730438086295;4273.850415235452;1305.432137020399;1339.430741934674;1344.9058565900293;1354.1130559483554;1361.659585103724;672.7611697847292;703.426707233603;703.8486725354073;713.2688993781416;720.92069872314;5084.3644544431945;5232.450592687789;5244.659097158673;5354.7858085676135;5424.267723857308;538.6687187379733;544.5833937038169;544.8283790605947;546.281639643867;555.8777069044804;3388.186835159593;3758.4550240215017;3769.7172712046704;3830.984789030909;3937.7637341759587;12907.419166137546;13340.799888001688;13419.597412077457;13512.59462216135;13513.054086213871;12718.682032949066;13117.147385419918;13117.409716562586;13165.802512962313;13334.33328333599;7417.777466676009;7423.4061275097865;7598.620068996528;7614.619269036526;7704.92295077042;6160.10678451631;6376.426121649074;6383.946648802896;6418.93581064202;6427.453666438405;11574.131940104695;11587.246828956091;11775;11938.940305298418;11993.940030300142;11806.114541409257;11968.222065565711;12005.939970300093;12039.518419263482;12239.20445171061;8310.33517318601;8362.038365588036;8424.83150337002;8442.746717598482;8446.070932197576;9439.292053096182;9521.143097121292;9598.040195980626;9602;9602.08780165883;7780.805479863048;7984.321332686786;7984.680612775656;8095.433319667567;8134.471259368122;7742.187070357757;7744.186860379579;7760.18518055596;7817.101033381006;7832.37341012729;7417.406607471497;7528.962355188189;7530.4352173588295;7532.133804612539;7535.095788505414;4360.869173924787;4998.300237966615;5033.245013248042;5209.869753256199;5285.524302812765;5244.554212891947;5331.627425795484;5342.652727572696;5352.652077614943;5389.218563308376 09:22:24 INFO - PID 26428 | |4;prototype.html;337.6960735338195;360.4395165517619;363.083214882422;364.92519033598114;365.3496775739184;5258.342707161605;5333.706646134461;5354.196870469432;5367.973160134204;5369.355677318717;5284.656497327681;5285.947140528594;5287.206918962158;5293.364796224459;5294.205869119634;3847.865324713636;3986.66113380363;4112.074783173792;4127.215828992489;4134.813933373005;3959.8812035638975;3970.7293666026885;3974.125692347679;3992.8203230854538;3997.060690737674;3928.273269445162;3944.3097457944887;3944.7238693291483;3946.881593552198;3951.565327813938;3952.5256969163884;3954.110325176841;3955.2287303975736;3956.9208615827665;3966;3383.238771276443;3395.2360718838313;3412.7952322860706;3447.413939630269;3454.1882657575447;5098.643094983353;5102.591792656615;5128.640995130342;5131.589472842201;5146.150885103953;4617.492075871652;4624.791884365211;4635.490096089427;4636.629069674418;4649.697769644996;5406.432324605899;5529.391766905637;5551.361593416728;5559.63862348946;5567.109262517978;3825.7948746144875;3831.0613899594778;3834.9808250958845;3835.9232815343817;3837.0791010157363;5528.75120619573;5749.482546570829;5779.248697669276;5813.505852002585;5902.557308201902;3885.1841113365945;3897.512810898638;3903.746256493319;3916.8433262669746;3920.764754114762;3953.5453422856162;3961.088949541622;3965.0682089708894;3967.7024223183375;3970.1265721541213;4310.655147588185;4379.868603941887;4545.545445455494;4600.861974140781;4611.884702882455;5533.312339736419;5575.414581468968;5576.330840299109;5589.189567512688;5590.664560126405;1362.121431676583;1368.2679766324968;1371.0128707330705;1374.271636032904;1374.656335916021;877.7849426890452;880.7930136417937;885.964561417549;909.1999040844147;916.3493919317226;4839.201531747292;4845.63657725665;4850.83022094225;4851.927221091686;4874.927515946557;5731.197632331477;5756.7121643917635;5770.971145144247;5784.595078344475;5794.565407594448;4760.285957106393;4811.422629284439;4839.806407743651;4841.878953026203;4865.854024379274;3009.7441717453826;3044.1476386611785;3046.786724929278;3049.679783622688;3056.2512184514935;5333.146696528537;5368.489993450616;5405.21624364465;5415.972920135374;5416.51251387377;5764.942350576441;5847.567346000172;5903.173555702205;5906.26171728534;5913.58604897653;5339.252504649352;5352.437994010651;5355.196720491879;5383.730813459233;5384.5692344612335;5539.81177434919;5735.8566035849435;5756.30924289088;5776.855578610568;5777.653340799566;5705.600607957569;5742.425757424224;5747.885042299215;5753.165790960371;5759.424057594207;5159;5204.7918083276245;5305.9469405307;5388.946110539001;5421.801137328837;3852.2295540892496;3853.8073096345634;3858.247641709952;3858.826352814186;3863.4011728182177;5819.301683797971;5821.438567030493;5822.2140011099655;5824.912626310524;5824.912626310694;5422.15956526739;5569.387367389665;5606.159076138449;5612.607117501736;5618.410066943075;5627.971860140673;5630.690312032878;5639.605227634191;5649.689267090185;5657.349404818334;5422.783088676567;5479.53423958968;5529.22590837275;5530.364008139116;5545.195946587642;5656.915146272727;5659.745311461076;5665.320161580472;5679.318481782213;5690.203371527907;5493.7802487900035;5498.285222920995;5521.254630624814;5529;5539.8892022158525 09:22:24 INFO - PID 26428 | |5;yui.html;748.3676293531963;761.4137114421895;769.9990012983124;774.3572834547326;789.1083076123979;13112.73774524509;14252.144871307715;14279.571612851605;14319.140851548915;14334.283285835705;13826.516071937484;15118.773218401733;15319.846801531981;15475.14886681232;15636.374545018214;894.8881389826255;903.0382642485731;905.0496978172926;905.6286922361833;906.4968942237056;893.9731808045736;918.6968300460832;921.6774129054844;921.7511271956567;922.0180507759248;957.0907637744136;969.7042402067367;970.5923512124924;971.4414211828192;973.352720440906;956.0344052506948;965.7392504023944;966.4104896013391;967.709687093869;969.9030096990244;705.4885208223997;710.0875375142916;710.6872975890592;710.783211120608;712.1240873725295;13336.19982801035;13418.731625367536;14478.565643030726;14649.19429431381;14660.56018319452;15816.76274855878;15818.841811581968;15980;16072.75890861638;16176.75734863978;12320.322382268972;12335.814962775565;12419.130660853743;12551.560695375709;12558;2991.4764916139807;3010.3377257003426;3015.577819105327;3016.366563021768;3017.969820301791;71190;71594.28405715928;71780.6410967947;73314;74254;12434.502619895284;12542;12679.683007924692;12724.427400766803;12820.80768788469;23002.654960175612;23293.184738534408;23487.41281467977;23495.88252058763;23516.059357625847;6103.816885493442;6106.419890110433;6134.263888333428;6167.105769663373;6216.471599913967;2995.955060674092;3040.619922509686;3064.9540256896166;3077.6306843178963;3079.337942342407;3473.2879759649213;3546.3971124908826;3560.412531932254;3573.338932297533;3576.7675101118343;611.5596770325359;623.1058431151313;623.3361470034399;623.7536173211556;625.8654389306321;581.3401788969466;597.1758972617846;600.5465873265656;604.4559896093463;617.1853153836893;8531.189536993976;8755.921565491999;9336.673216437392;9399.953000234955;9637.469939153274;590.0470739755265;595.2529575382866;600.7326739600923;606.0485038489529;611.1688104178314;4163.5836416358125;4180.435641188401;4224.831006759757;4253.787310634456;4288.206681763883;57999.4200057994;59975;60582.39417605856;64641.35358646447;65097.67451162809;52067.73966130145;52985.735071324394;53058;53067.46932530625;55114.448855511735;48443.757781210865;48738.512614874104;50746;50782.74608627007;50987;10222.655371467245;10441.321314114559;10754.946225268823;10760.515776789907;10993;25162.874185628956;25459.490810184063;25595.74404256008;26668;26854.731452685224;31114.844425777726;31578.36843263168;31609.5258571117;31782.84108579442;32779.50830737589;13886.375113120135;13986.300684965507;14143.575692729235;14150.363233654305;14190.219537925514;15448.536543903701;15473.690526189188;15774.211289435712;15926.362945482051;16106.758398624264;13809.930950345184;14709.705805883608;14769.409223631365;14964.476243331432;15169.848301516844;13819.101758385672;13884.86115138876;13902.791458128338;14096.859031409555;14221.14673119616;12473.251604903735;13004.739905202032;13114.60656180316;13118.803217951929;13322.40049197769;9461.290403219647;9646.855297170408;9662.806743864943;9833.262505311986;10138.290319677551;9852.852207216754;9968.252381071594;10103.696889093339;10144.898551014396;10365.222608304257 09:22:24 INFO - PID 26428 | __end_tp_report 09:22:24 INFO - PID 26428 | __start_cc_report 09:22:24 INFO - PID 26428 | _x_x_mozilla_cycle_collect,2403 09:22:24 INFO - PID 26428 | __end_cc_report 09:22:24 INFO - PID 26428 | __startTimestamp1493914944961__endTimestamp 09:22:24 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | ------- Summary: start ------- 09:22:24 INFO - PID 26428 | Number of tests: 6 09:22:24 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | [#0] dojo.html Cycles:165 Average:5201.09 Median:5359.97 stddev:618.49 (11.5%) stddev-sans-first:588.84 09:22:24 INFO - PID 26428 | Values: 2715.3 2716.9 2751.1 2760.5 2761.2 5154.7 5260.2 5290.7 5314.8 5336.6 5285.5 5298.7 5306.1 5350.7 5360.0 4387.9 4560.5 4654.4 4696.3 4749.7 4713.8 4713.8 4737.9 4745.2 4774.3 4610.6 4651.0 4673.4 4678.5 4724.9 4698.7 4702.1 4703.6 4748.9 4769.3 4634.2 4685.3 4706.9 4716.2 4748.1 5174.3 5226.3 5240.7 5262.1 5288.0 5639.3 5643.9 5647.5 5652.3 5653.9 5671.8 5672.1 5681.9 5684.3 5689.4 5291.9 5344.1 5370.4 5380.2 5398.6 5744.8 5823.0 5875.2 5888.6 5888.6 5567.6 5573.6 5588.8 5653.6 5655.1 5735.9 5737.5 5740.4 5741.7 5743.4 5662.9 5676.9 5718.8 5720.8 5722.3 5693.7 5734.2 5743.4 5750.0 5754.3 4754.8 4755.0 4755.4 4757.3 4800.7 4002.4 4073.1 4099.6 4104.1 4138.3 4749.5 4782.1 4834.3 4835.1 4855.0 5717.7 5739.1 5739.8 5741.6 5750.0 4786.2 4800.0 4801.5 4807.4 4846.9 4971.3 5036.1 5041.5 5112.5 5112.8 5247.4 5248.8 5249.6 5252.8 5298.1 5672.7 5674.3 5675.7 5702.9 5725.3 5197.9 5252.5 5252.7 5258.3 5342.8 5641.9 5648.9 5667.9 5673.6 5699.6 5669.4 5714.7 5723.7 5725.4 5745.9 5374.0 5503.5 5506.6 5550.2 5556.8 5485.1 5533.4 5564.7 5566.7 5577.8 5317.1 5381.5 5460.0 5484.8 5487.1 5544.4 5559.9 5593.9 5612.2 5619.6 5367.5 5368.6 5433.0 5435.3 5435.7 09:22:24 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | [#1] ext.html Cycles:180 Average:29346.51 Median:29269.50 stddev:39827.57 (136.1%) stddev-sans-first:39881.32 09:22:24 INFO - PID 26428 | Values: 727.7 743.5 1056.5 1066.6 1073.3 29782.9 32936.7 32948.0 33039.5 33089.2 33959.8 34420.3 34438.3 34469.7 34489.7 5324.1 6846.0 6970.4 6974.5 6978.8 5356.7 6823.6 6975.0 6975.3 6976.8 7011.2 7044.1 7060.0 7065.9 7067.4 5313.3 6992.2 7052.5 7054.9 7060.2 5390.1 6763.7 6936.3 6947.0 6951.1 32699.5 33012.3 33112.5 33112.8 33139.2 3069.1 3087.0 3110.1 3111.8 3114.5 24426.6 24588.4 24602.8 24639.9 24650.6 2678.5 2678.7 2690.4 2697.6 2706.9 141755.0 142020.0 142210.0 142216.0 143460.3 34321.3 35043.5 40819.8 40850.2 40854.6 39639.8 41628.6 41650.4 41665.0 41672.0 11583.2 11676.1 11679.2 11688.2 11688.3 9267.7 9277.4 9277.7 9284.7 9287.1 11676.9 11685.4 11690.6 11729.8 11862.3 4868.7 4873.5 4873.9 4877.5 4900.7 857.9 859.8 891.6 915.3 924.6 20206.6 20611.6 25592.3 26595.5 26630.9 960.9 962.2 967.6 973.1 979.3 10791.9 11145.6 11421.1 11484.3 11512.3 170313.0 170614.0 170778.0 170899.0 170942.0 39225.6 39265.4 39267.6 39281.2 39424.8 1177.9 1230.3 1230.6 1232.4 1234.1 19520.7 19860.7 20203.8 20328.6 20733.9 28750.0 28806.7 28810.1 28811.1 28821.9 146584.0 148549.0 148668.3 149996.0 150066.0 24466.6 24989.6 24999.1 27456.9 27637.6 29808.6 30331.4 30352.2 30362.0 34200.8 25563.7 26911.2 26974.9 27141.9 28006.0 25793.6 26502.1 26897.0 27059.6 27411.9 28886.3 28939.4 29180.0 29359.0 29504.6 25063.4 25541.9 25624.2 25956.1 27068.2 19421.5 20740.4 21118.2 21238.7 21314.5 09:22:24 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | [#2] jquery.html Cycles:180 Average:24175.43 Median:38009.31 stddev:57669.53 (151.7%) stddev-sans-first:57803.68 09:22:24 INFO - PID 26428 | Values: 400.7 409.6 409.9 423.7 426.1 12698.5 14899.3 16944.9 17662.4 17677.7 17819.3 18077.7 18362.0 18386.5 18685.6 5540.2 5630.6 5658.7 5661.4 5664.1 5564.4 5612.1 5614.0 5615.1 5616.4 5533.1 5571.9 5571.9 5589.2 5593.9 5346.7 5500.8 5505.1 5505.2 5508.0 4861.2 4997.3 5003.8 5009.2 5012.3 22181.7 22460.0 22465.6 22663.9 22858.9 1654.6 1669.8 1677.7 1681.0 1681.1 13827.3 14162.5 14570.1 14668.7 14708.4 2029.4 2032.4 2067.0 2076.0 2126.1 68953.7 84187.0 84796.8 87808.6 88699.0 10716.9 10928.8 10980.1 10994.6 11072.7 15123.2 15146.1 15212.3 15225.5 15227.5 7191.3 7262.0 7375.6 7476.1 7511.8 6530.5 6611.9 6704.3 6815.9 6872.5 6846.4 6925.3 6978.8 6999.2 7015.4 1939.7 1970.7 1974.6 2005.0 2061.8 821.7 851.7 872.9 884.9 894.2 16724.6 16741.0 16838.4 17128.5 17314.7 858.3 867.3 869.9 872.6 880.0 9101.0 9221.3 9448.2 9495.6 9724.8 341518.0 344927.0 344957.0 347461.0 348096.0 78459.0 80345.2 80459.2 80898.6 81378.0 1057.3 1067.0 1104.1 1109.7 1111.3 17947.2 18291.2 18797.8 18931.2 19162.9 37399.6 38619.0 38852.4 38868.0 39656.0 48345.0 48672.8 48979.8 49073.5 51783.2 8232.5 8249.4 8281.5 8408.4 8652.0 12401.8 12472.0 12713.0 13130.6 13211.9 10862.5 11311.3 11470.1 11526.7 11791.2 10370.8 10468.4 10715.6 10732.9 10778.8 10658.5 11104.9 11494.9 11571.8 11581.1 8180.0 8216.5 8247.8 8431.2 8445.2 11195.3 11222.2 11375.4 11473.0 11884.6 09:22:24 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | [#3] mootools.html Cycles:180 Average:6252.76 Median:4224.09 stddev:4073.35 (96.4%) stddev-sans-first:4067.22 09:22:24 INFO - PID 26428 | Values: 1219.6 1276.6 1289.5 1292.5 1295.4 9615.3 10021.1 10021.5 10032.1 10033.5 9806.3 10391.1 10395.9 10397.5 10412.0 2126.0 2127.3 2147.5 2160.4 2170.7 1627.7 1980.6 2018.7 2052.0 2094.9 1837.0 1955.4 2084.1 2093.8 2095.6 2032.8 2035.0 2037.5 2042.5 2044.6 1711.0 1891.9 1924.6 1926.4 1930.3 8802.5 8866.9 8868.8 8874.6 8877.5 5298.4 5545.9 5551.8 5555.9 5576.1 3097.3 3307.1 3392.4 3418.1 3432.6 1055.2 1062.6 1084.8 1087.4 1093.6 14710.3 15009.0 15014.4 15017.5 15061.6 4781.4 4973.6 5091.9 5096.4 5114.3 12594.5 12614.5 12623.8 12624.0 12651.5 5681.2 5682.3 5682.6 5690.8 5692.3 4892.0 5041.7 5078.9 5111.8 5122.6 4117.3 4211.6 4216.3 4231.9 4273.9 1305.4 1339.4 1344.9 1354.1 1361.7 672.8 703.4 703.8 713.3 720.9 5084.4 5232.5 5244.7 5354.8 5424.3 538.7 544.6 544.8 546.3 555.9 3388.2 3758.5 3769.7 3831.0 3937.8 12907.4 13340.8 13419.6 13512.6 13513.1 12718.7 13117.1 13117.4 13165.8 13334.3 7417.8 7423.4 7598.6 7614.6 7704.9 6160.1 6376.4 6383.9 6418.9 6427.5 11574.1 11587.2 11775.0 11938.9 11993.9 11806.1 11968.2 12005.9 12039.5 12239.2 8310.3 8362.0 8424.8 8442.7 8446.1 9439.3 9521.1 9598.0 9602.0 9602.1 7780.8 7984.3 7984.7 8095.4 8134.5 7742.2 7744.2 7760.2 7817.1 7832.4 7417.4 7529.0 7530.4 7532.1 7535.1 4360.9 4998.3 5033.2 5209.9 5285.5 5244.6 5331.6 5342.7 5352.7 5389.2 09:22:24 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | [#4] prototype.html Cycles:180 Average:4578.24 Median:5290.29 stddev:1375.03 (26.0%) stddev-sans-first:1341.54 09:22:24 INFO - PID 26428 | Values: 337.7 360.4 363.1 364.9 365.3 5258.3 5333.7 5354.2 5368.0 5369.4 5284.7 5285.9 5287.2 5293.4 5294.2 3847.9 3986.7 4112.1 4127.2 4134.8 3959.9 3970.7 3974.1 3992.8 3997.1 3928.3 3944.3 3944.7 3946.9 3951.6 3952.5 3954.1 3955.2 3956.9 3966.0 3383.2 3395.2 3412.8 3447.4 3454.2 5098.6 5102.6 5128.6 5131.6 5146.2 4617.5 4624.8 4635.5 4636.6 4649.7 5406.4 5529.4 5551.4 5559.6 5567.1 3825.8 3831.1 3835.0 3835.9 3837.1 5528.8 5749.5 5779.2 5813.5 5902.6 3885.2 3897.5 3903.7 3916.8 3920.8 3953.5 3961.1 3965.1 3967.7 3970.1 4310.7 4379.9 4545.5 4600.9 4611.9 5533.3 5575.4 5576.3 5589.2 5590.7 1362.1 1368.3 1371.0 1374.3 1374.7 877.8 880.8 886.0 909.2 916.3 4839.2 4845.6 4850.8 4851.9 4874.9 5731.2 5756.7 5771.0 5784.6 5794.6 4760.3 4811.4 4839.8 4841.9 4865.9 3009.7 3044.1 3046.8 3049.7 3056.3 5333.1 5368.5 5405.2 5416.0 5416.5 5764.9 5847.6 5903.2 5906.3 5913.6 5339.3 5352.4 5355.2 5383.7 5384.6 5539.8 5735.9 5756.3 5776.9 5777.7 5705.6 5742.4 5747.9 5753.2 5759.4 5159.0 5204.8 5305.9 5388.9 5421.8 3852.2 3853.8 3858.2 3858.8 3863.4 5819.3 5821.4 5822.2 5824.9 5824.9 5422.2 5569.4 5606.2 5612.6 5618.4 5628.0 5630.7 5639.6 5649.7 5657.3 5422.8 5479.5 5529.2 5530.4 5545.2 5656.9 5659.7 5665.3 5679.3 5690.2 5493.8 5498.3 5521.3 5529.0 5539.9 09:22:24 INFO - PID 26428 | 09:22:24 INFO - PID 26428 | [#5] yui.html Cycles:180 Average:15021.75 Median:3553.40 stddev:17689.23 (497.8%) stddev-sans-first:17706.38 09:22:24 INFO - PID 26428 | Values: 748.4 761.4 770.0 774.4 789.1 13112.7 14252.1 14279.6 14319.1 14334.3 13826.5 15118.8 15319.8 15475.1 15636.4 894.9 903.0 905.0 905.6 906.5 894.0 918.7 921.7 921.8 922.0 957.1 969.7 970.6 971.4 973.4 956.0 965.7 966.4 967.7 969.9 705.5 710.1 710.7 710.8 712.1 13336.2 13418.7 14478.6 14649.2 14660.6 15816.8 15818.8 15980.0 16072.8 16176.8 12320.3 12335.8 12419.1 12551.6 12558.0 2991.5 3010.3 3015.6 3016.4 3018.0 71190.0 71594.3 71780.6 73314.0 74254.0 12434.5 12542.0 12679.7 12724.4 12820.8 23002.7 23293.2 23487.4 23495.9 23516.1 6103.8 6106.4 6134.3 6167.1 6216.5 2996.0 3040.6 3065.0 3077.6 3079.3 3473.3 3546.4 3560.4 3573.3 3576.8 611.6 623.1 623.3 623.8 625.9 581.3 597.2 600.5 604.5 617.2 8531.2 8755.9 9336.7 9400.0 9637.5 590.0 595.3 600.7 606.0 611.2 4163.6 4180.4 4224.8 4253.8 4288.2 57999.4 59975.0 60582.4 64641.4 65097.7 52067.7 52985.7 53058.0 53067.5 55114.4 48443.8 48738.5 50746.0 50782.7 50987.0 10222.7 10441.3 10754.9 10760.5 10993.0 25162.9 25459.5 25595.7 26668.0 26854.7 31114.8 31578.4 31609.5 31782.8 32779.5 13886.4 13986.3 14143.6 14150.4 14190.2 15448.5 15473.7 15774.2 15926.4 16106.8 13809.9 14709.7 14769.4 14964.5 15169.8 13819.1 13884.9 13902.8 14096.9 14221.1 12473.3 13004.7 13114.6 13118.8 13322.4 9461.3 9646.9 9662.8 9833.3 10138.3 9852.9 9968.3 10103.7 10144.9 10365.2 09:22:24 INFO - PID 26428 | -------- Summary: end -------- 09:22:24 INFO - PID 26428 | 09:22:25 INFO - TEST-INFO | 26428: exit 0 09:22:25 INFO - TEST-OK | dromaeo_css | took 1122805ms 09:22:25 INFO - TEST-START | kraken 09:22:25 INFO - operating with platform_type : linux_ 09:22:25 INFO - Initialising browser for kraken test... 09:22:25 INFO - TEST-INFO | started process 26756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpODPtQ5/profile http://localhost:59647/getInfo.html) 09:22:30 INFO - PID 26756 | __metrics Screen width/height:1600/1200 09:22:30 INFO - PID 26756 | colorDepth:24 09:22:30 INFO - PID 26756 | Browser inner width/height: 1024/695 09:22:30 INFO - PID 26756 | __metrics 09:22:31 INFO - PID 26756 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:22:31 INFO - PID 26756 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:32 INFO - TEST-INFO | 26756: exit 0 09:22:32 INFO - Browser initialized. 09:22:32 INFO - Running cycle 1/1 for kraken test... 09:22:32 INFO - TEST-INFO | started process 26855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpODPtQ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:44 INFO - PID 26855 | RSS: Main: 153686016 09:22:44 INFO - PID 26855 | 09:22:46 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59647/tests/kraken/driver.html?testName=audio-beat-detection) 09:22:47 INFO - PID 26855 | RSS: Main: 225824768 09:22:47 INFO - PID 26855 | 09:22:50 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59647/tests/kraken/driver.html?testName=audio-dft) 09:22:51 INFO - PID 26855 | RSS: Main: 186683392 09:22:51 INFO - PID 26855 | 09:22:54 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59647/tests/kraken/driver.html?testName=audio-fft) 09:22:54 INFO - PID 26855 | RSS: Main: 268972032 09:22:54 INFO - PID 26855 | 09:22:56 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59647/tests/kraken/driver.html?testName=audio-oscillator) 09:22:57 INFO - PID 26855 | RSS: Main: 178995200 09:22:57 INFO - PID 26855 | 09:22:59 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59647/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:00 INFO - PID 26855 | RSS: Main: 182423552 09:23:00 INFO - PID 26855 | 09:23:03 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59647/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:04 INFO - PID 26855 | RSS: Main: 242757632 09:23:04 INFO - PID 26855 | 09:23:07 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59647/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:08 INFO - PID 26855 | RSS: Main: 241451008 09:23:08 INFO - PID 26855 | 09:23:11 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59647/tests/kraken/driver.html?testName=json-parse-financial) 09:23:11 INFO - PID 26855 | RSS: Main: 239480832 09:23:11 INFO - PID 26855 | 09:23:13 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59647/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:23:13 INFO - PID 26855 | RSS: Main: 204419072 09:23:13 INFO - PID 26855 | 09:23:15 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:23:16 INFO - PID 26855 | RSS: Main: 191340544 09:23:16 INFO - PID 26855 | 09:23:18 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:23:18 INFO - PID 26855 | RSS: Main: 218972160 09:23:18 INFO - PID 26855 | 09:23:21 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:23:22 INFO - PID 26855 | RSS: Main: 228884480 09:23:22 INFO - PID 26855 | 09:23:25 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:26 INFO - PID 26855 | RSS: Main: 223653888 09:23:26 INFO - PID 26855 | 09:23:27 INFO - PID 26855 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59647/tests/kraken/driver.html?testName=ai-astar) 09:23:28 INFO - PID 26855 | RSS: Main: 274333696 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | __start_tp_report 09:23:28 INFO - PID 26855 | _x_x_mozilla_page_load 09:23:28 INFO - PID 26855 | _x_x_mozilla_page_load_details 09:23:28 INFO - PID 26855 | |i|pagename|runs| 09:23:28 INFO - PID 26855 | |0;ai-astar;113;114;112;112;113;111;112;111;111;111 09:23:28 INFO - PID 26855 | |1;audio-beat-detection;153;127;122;157;123;122;122;122;158;123 09:23:28 INFO - PID 26855 | |2;audio-dft;161;160;160;163;162;162;161;161;163;161 09:23:28 INFO - PID 26855 | |3;audio-fft;74;76;74;111;78;75;75;75;96;75 09:23:28 INFO - PID 26855 | |4;audio-oscillator;83;83;106;83;83;84;96;84;83;112 09:23:28 INFO - PID 26855 | |5;imaging-gaussian-blur;113;113;113;113;115;113;113;114;113;113 09:23:28 INFO - PID 26855 | |6;imaging-darkroom;149;149;149;150;149;148;148;149;149;148 09:23:28 INFO - PID 26855 | |7;imaging-desaturate;94;93;94;94;94;93;94;94;94;94 09:23:28 INFO - PID 26855 | |8;json-parse-financial;54;54;53;54;55;55;55;55;53;54 09:23:28 INFO - PID 26855 | |9;json-stringify-tinderbox;55;55;55;54;54;54;55;54;55;55 09:23:28 INFO - PID 26855 | |10;stanford-crypto-aes;81;81;79;79;80;80;81;80;79;82 09:23:28 INFO - PID 26855 | |11;stanford-crypto-ccm;147;131;128;137;130;129;129;132;177;134 09:23:28 INFO - PID 26855 | |12;stanford-crypto-pbkdf2;180;189;190;196;183;189;190;189;189;187 09:23:28 INFO - PID 26855 | |13;stanford-crypto-sha256-iterative;70;70;73;71;71;72;73;74;69;70 09:23:28 INFO - PID 26855 | __end_tp_report 09:23:28 INFO - PID 26855 | __start_cc_report 09:23:28 INFO - PID 26855 | _x_x_mozilla_cycle_collect,1968 09:23:28 INFO - PID 26855 | __end_cc_report 09:23:28 INFO - PID 26855 | __startTimestamp1493915008189__endTimestamp 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | ------- Summary: start ------- 09:23:28 INFO - PID 26855 | Number of tests: 14 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 09:23:28 INFO - PID 26855 | Values: 113.0 114.0 112.0 112.0 113.0 111.0 112.0 111.0 111.0 111.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:125.00 stddev:16.06 (12.8%) stddev-sans-first:15.30 09:23:28 INFO - PID 26855 | Values: 153.0 127.0 122.0 157.0 123.0 122.0 122.0 122.0 158.0 123.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 09:23:28 INFO - PID 26855 | Values: 161.0 160.0 160.0 163.0 162.0 162.0 161.0 161.0 163.0 161.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.48 (16.6%) stddev-sans-first:12.98 09:23:28 INFO - PID 26855 | Values: 74.0 76.0 74.0 111.0 78.0 75.0 75.0 75.0 96.0 75.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:83.00 stddev:11.02 (13.3%) stddev-sans-first:11.41 09:23:28 INFO - PID 26855 | Values: 83.0 83.0 106.0 83.0 83.0 84.0 96.0 84.0 83.0 112.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:23:28 INFO - PID 26855 | Values: 113.0 113.0 113.0 113.0 115.0 113.0 113.0 114.0 113.0 113.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:23:28 INFO - PID 26855 | Values: 149.0 149.0 149.0 150.0 149.0 148.0 148.0 149.0 149.0 148.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:23:28 INFO - PID 26855 | Values: 94.0 93.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:0.79 (1.4%) stddev-sans-first:0.83 09:23:28 INFO - PID 26855 | Values: 54.0 54.0 53.0 54.0 55.0 55.0 55.0 55.0 53.0 54.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:23:28 INFO - PID 26855 | Values: 55.0 55.0 55.0 54.0 54.0 54.0 55.0 54.0 55.0 55.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:1.03 (1.3%) stddev-sans-first:1.05 09:23:28 INFO - PID 26855 | Values: 81.0 81.0 79.0 79.0 80.0 80.0 81.0 80.0 79.0 82.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:133.00 stddev:15.01 (11.3%) stddev-sans-first:15.51 09:23:28 INFO - PID 26855 | Values: 147.0 131.0 128.0 137.0 130.0 129.0 129.0 132.0 177.0 134.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.20 Median:189.00 stddev:4.29 (2.3%) stddev-sans-first:3.37 09:23:28 INFO - PID 26855 | Values: 180.0 189.0 190.0 196.0 183.0 189.0 190.0 189.0 189.0 187.0 09:23:28 INFO - PID 26855 | 09:23:28 INFO - PID 26855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:1.64 (2.3%) stddev-sans-first:1.67 09:23:28 INFO - PID 26855 | Values: 70.0 70.0 73.0 71.0 71.0 72.0 73.0 74.0 69.0 70.0 09:23:28 INFO - PID 26855 | -------- Summary: end -------- 09:23:28 INFO - PID 26855 | 09:23:29 INFO - TEST-INFO | 26855: exit 0 09:23:29 INFO - TEST-OK | kraken | took 63702ms 09:23:29 INFO - SUITE-END | took 1186s 09:23:29 INFO - Completed test suite (00:19:46) 09:23:29 INFO - javascript benchmark 09:23:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6607.248858338907, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2715.253305341032, 2716.9456610867783, 2751.064638023072, 2760.516909540831, 2761.226856480186, 5154.716490593016, 5260.158374660045, 5290.735463226838, 5314.78740850366, 5336.573074154063, 5285.471452854713, 5298.682079075248, 5306.124489459235, 5350.705711185883, 5359.9732001339935, 4387.868363949071, 4560.475545312298, 4654.371659825931, 4696.29555566666, 4749.691270067452, 4713.7643117844145, 4713.835015774465, 4737.92893106602, 4745.21703918853, 4774.331593576902, 4610.585047345755, 4651.0, 4673.369095172142, 4678.508756580544, 4724.929126063112, 4698.718076915396, 4702.059588082363, 4703.576678098988, 4748.881277968078, 4769.332293478916, 4634.21218392874, 4685.320628508881, 4706.858794236178, 4716.245400735866, 4748.121597504438, 5174.327337446146, 5226.268322434862, 5240.685558866442, 5262.131748261532, 5288.0, 5639.295088113986, 5643.8589035274035, 5647.463490968393, 5652.265205523256, 5653.886922261532, 5671.829845104653, 5672.06410942194, 5681.857953551153, 5684.317881854163, 5689.402612725687, 5291.867703307448, 5344.118220493653, 5370.382406023318, 5380.166074258496, 5398.568114550826, 5744.827655170351, 5822.970885145547, 5875.177475153482, 5888.587798854125, 5888.646681199141, 5567.582431317667, 5573.60984731073, 5588.832335029955, 5653.632513886584, 5655.095184770417, 5735.8852822944145, 5737.483626473638, 5740.42595740431, 5741.712914354265, 5743.396943320975, 5662.943370566324, 5676.858078547987, 5718.79984200551, 5720.771169153188, 5722.313322401338, 5693.658380497183, 5734.225879506297, 5743.368229494752, 5750.0, 5754.309482862083, 4754.809807607657, 4754.97767979886, 4755.358026666425, 4757.26262429324, 4800.73595952226, 4002.3796311571755, 4073.103917138225, 4099.61053699898, 4104.076582768853, 4138.255114079495, 4749.501302363271, 4782.0914026334885, 4834.274858771142, 4835.1296766581645, 4854.951450485521, 5717.656940583495, 5739.139129130664, 5739.827805165852, 5741.569382296345, 5750.0, 4786.1863483207935, 4800.039992001543, 4801.51984801517, 4807.4471435784635, 4846.878828029327, 4971.254311853251, 5036.11867923112, 5041.546260836542, 5112.514311140436, 5112.821051263188, 5247.396549396868, 5248.8425347239645, 5249.632525723163, 5252.763625636779, 5298.125809241432, 5672.716364181857, 5674.290713660793, 5675.7445914933105, 5702.885942281214, 5725.255716756795, 5197.922031169611, 5252.474752524717, 5252.711100889488, 5258.342707161605, 5342.839714808562, 5641.887162256814, 5648.887022259614, 5667.85830354228, 5673.602847800615, 5699.5725320600295, 5669.4047125051275, 5714.742836572281, 5723.6851973141875, 5725.370209276893, 5745.856353591026, 5373.9731301343245, 5503.477169668875, 5506.614536982373, 5550.222968784454, 5556.805511807067, 5485.122380419114, 5533.418991006048, 5564.666120032811, 5566.693831839126, 5577.832665020056, 5317.1226747586215, 5381.515663590296, 5459.972700136474, 5484.808031718871, 5487.122060470306, 5544.41783612731, 5559.944400555943, 5593.860153496195, 5612.214289999321, 5619.550435965031, 5367.543758780547, 5368.624196306221, 5432.972835135957, 5435.293411856592, 5435.701036443033], "value": 5155.718981805828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.7052793618585, 743.4758495260842, 1056.5245639462244, 1066.6266806617684, 1073.3077165228433, 29782.851085744594, 32936.67063329366, 32948.0, 33039.50440743385, 33089.172770680685, 33959.83020084896, 34420.31159376811, 34438.31123377537, 34469.65530344696, 34489.65510344896, 5324.148136298193, 6845.965770171155, 6970.372666460017, 6974.476914231427, 6978.79063628092, 5356.678599284036, 6823.556468829535, 6974.965125174367, 6975.337342952437, 6976.755813546527, 7011.158660960692, 7044.119485064367, 7060.0, 7065.89401158983, 7067.399271061966, 5313.335833020872, 6992.230854605989, 7052.5415847970235, 7054.894176587355, 7060.152781666233, 5390.0836857734275, 6763.729450821961, 6936.271691472423, 6946.965265173692, 6951.096357473547, 32699.50950735741, 33012.339753205044, 33112.50331245033, 33112.834435827666, 33139.171520711934, 3069.109958112145, 3086.9536956945662, 3110.0514343125337, 3111.828849413281, 3114.5172498262577, 24426.633600496007, 24588.385290367885, 24602.753972460403, 24639.876800615883, 24650.630240546227, 2678.450917561895, 2678.7053424123333, 2690.3543149643942, 2697.5818748094075, 2706.930762348861, 141755.0, 142020.0, 142210.0, 142216.0, 143460.28269858687, 34321.31357372839, 35043.4743478848, 40819.7959010209, 40850.18299633991, 40854.591454085676, 39639.80180099081, 41628.58371416308, 41650.37524437136, 41665.0, 41672.0, 11583.247088939192, 11676.124290678234, 11679.240849344766, 11688.240264382788, 11688.298702077902, 9267.675631353006, 9277.443353398818, 9277.67528136512, 9284.675036373694, 9287.117723816227, 11676.883231167749, 11685.415729213675, 11690.590829321103, 11729.765404691858, 11862.347570883512, 4868.732219727878, 4873.512648735098, 4873.853784386474, 4877.487863774252, 4900.730459824744, 857.9356548258905, 859.7893516088474, 891.5675897189988, 915.2540679346312, 924.5931790012507, 20206.59586808285, 20611.58776824455, 25592.331795761216, 26595.468090638467, 26630.866845666034, 960.9327347085637, 962.1869520255373, 967.5506818193119, 973.075578200698, 979.3177652028425, 10791.892081079246, 11145.554177832795, 11421.086313094933, 11484.310941343547, 11512.309261444172, 170313.0, 170614.0, 170778.0, 170899.0, 170942.0, 39225.60774392277, 39265.41101883474, 39267.60732392697, 39281.21437571233, 39424.80287598601, 1177.929625756879, 1230.3171739684383, 1230.6062060140669, 1232.38380809597, 1234.0621127942827, 19520.707189391887, 19860.70208946896, 20203.79796202019, 20328.59342813165, 20733.89633051825, 28750.0, 28806.670765908373, 28810.135695929155, 28811.135665930055, 28821.855890720413, 146584.0, 148549.0, 148668.256658716, 149996.0, 150066.0, 24466.633000505364, 24989.625155623045, 24999.12503062384, 27456.862715686293, 27637.58543621807, 29808.552871707376, 30331.39337213199, 30352.241193970327, 30362.0, 34200.82899585486, 25563.744362556135, 26911.192664220103, 26974.865125674245, 27141.86429067842, 28006.0, 25793.613095803954, 26502.07242746572, 26897.0, 27059.594106088818, 27411.86294068517, 28886.277843054093, 28939.42121157523, 29180.0, 29359.0, 29504.557431638972, 25063.373415664755, 25541.87229063843, 25624.23127306184, 25956.09153679612, 27068.1879543614, 19421.51446213856, 20740.438734313255, 21118.155273788878, 21238.681419779026, 21314.467138321666], "value": 14035.520199345232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.7495315427859, 409.61700809742894, 409.93441049432096, 423.6970566045277, 426.14770459081836, 12698.4920603176, 14899.32953017114, 16944.91527542362, 17662.38181663642, 17677.734833977484, 17819.287228510875, 18077.7288340675, 18362.0, 18386.540336491595, 18685.626287474275, 5540.168974653804, 5630.634008789416, 5658.688772117532, 5661.405552416999, 5664.0937450008005, 5564.360098588673, 5612.102063669814, 5614.0, 5615.101583746601, 5616.382197958222, 5533.142362933731, 5571.888562228753, 5571.8885622287735, 5589.161625756149, 5593.944060559383, 5346.679199248058, 5500.80747173851, 5505.119180931052, 5505.229267902497, 5508.0, 4861.246506791453, 4997.325361076245, 5003.774830132653, 5009.223570346566, 5012.27322038306, 22181.667274990887, 22460.0, 22465.550688986128, 22663.886680566655, 22858.88570557153, 1654.586353411647, 1669.8413650703164, 1677.714788485948, 1680.9579760505962, 1681.0502066332606, 13827.308634568331, 14162.530180105838, 14570.052946558546, 14668.706625867422, 14708.411663533447, 2029.4013266086392, 2032.400441869652, 2067.0, 2075.968860467094, 2126.1070350452846, 68953.65523172352, 84187.0, 84796.81784564938, 87808.56095719544, 88699.0, 10716.892831071746, 10928.836067458995, 10980.121590272758, 10994.560217591366, 11072.667819965414, 15123.243837808066, 15146.091234525964, 15212.315445804965, 15225.543233703007, 15227.477252274684, 7191.316824901626, 7261.963690181621, 7375.557466552024, 7476.140243871915, 7511.8497630047095, 6530.477561795045, 6611.933880661228, 6704.329567043256, 6815.897761533581, 6872.484563657746, 6846.383825455733, 6925.272846351161, 6978.825529361807, 6999.243540231764, 7015.403690686348, 1939.7478327817576, 1970.6748386516065, 1974.59520798236, 2005.0, 2061.814436700704, 821.6631181215673, 851.6848765956636, 872.9127087291347, 884.9070847561043, 894.1684233662756, 16724.58188545296, 16741.0, 16838.410655627238, 17128.486145415656, 17314.740278895828, 858.3390789092489, 867.2714919467552, 869.9391042627082, 872.6422166911536, 879.9780005499914, 9101.022143958107, 9221.262299016063, 9448.244140468745, 9495.620175193053, 9724.805503890024, 341518.0, 344927.0, 344957.0, 347461.0, 348096.0, 78459.0, 80345.19654803495, 80459.19540804517, 80898.59550702326, 81378.0, 1057.3074636113358, 1066.9679909602569, 1104.100158370925, 1109.6615532262738, 1111.344306858957, 17947.192376342835, 18291.1768970394, 18797.812021879607, 18931.242750290385, 19162.904185478983, 37399.626003740705, 38619.0, 38852.41721374125, 38868.0, 39656.0, 48345.0, 48672.75663621659, 48979.75510122427, 49073.5092649069, 51783.2232516505, 8232.547209903512, 8249.381296402673, 8281.503109813431, 8408.411411201158, 8651.95674021626, 12401.813972790234, 12472.002239820975, 12713.0, 13130.606081817561, 13211.933940330237, 10862.456877155953, 11311.321320720783, 11470.082393408675, 11526.711832204262, 11791.174617776673, 10370.844437333295, 10468.371897686164, 10715.624953126604, 10732.946335268274, 10778.784424311627, 10658.520366583367, 11104.888951110708, 11494.94252528732, 11571.826422603499, 11581.073514119018, 8179.955011247188, 8216.548089855116, 8247.835043298981, 8431.241188293083, 8445.239928406472, 11195.328280303207, 11222.158338124511, 11375.374354410587, 11473.0, 11884.643460696192], "value": 8821.445491767488, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.5975328141715, 1276.6361586947721, 1289.516431338248, 1292.5476083370816, 1295.391166151909, 9615.278854085946, 10021.098101170894, 10021.544721543214, 10032.147267482254, 10033.548490317935, 9806.264530160232, 10391.116755075827, 10395.896041039587, 10397.480125993688, 10412.0, 2126.0220298662634, 2127.266093197848, 2147.473868902121, 2160.351894431672, 2170.717806685129, 1627.6988757079919, 1980.6137803128324, 2018.7476565429322, 2051.9589608207825, 2094.937151885446, 1836.9632607347912, 1955.4426988308335, 2084.114251443131, 2093.7592176899625, 2095.6123117223287, 2032.8373730101557, 2035.033359154412, 2037.5109973606227, 2042.5404284036122, 2044.580860923507, 1711.0, 1891.8581106417073, 1924.5765931495048, 1926.364299781069, 1930.2664987304875, 8802.471851688855, 8866.86699699505, 8868.822623547492, 8874.600642971081, 8877.467351958903, 5298.443663415324, 5545.944540554583, 5551.805686800943, 5555.916661250085, 5576.052071147915, 3097.3185899102164, 3307.090550098718, 3392.406328892434, 3418.060033490785, 3432.5537680101675, 1055.219137838002, 1062.5909025025421, 1084.804735147673, 1087.445402844547, 1093.5953697132034, 14710.338034788354, 15009.024413413093, 15014.399424023026, 15017.549473515703, 15061.623459413493, 4781.42622885256, 4973.577245934136, 5091.872703182376, 5096.413912400121, 5114.258432527263, 12594.488661360696, 12614.495420183273, 12623.810642840364, 12624.0, 12651.493940242472, 5681.233033540502, 5682.289713785777, 5682.573806964411, 5690.829275121753, 5692.345380281238, 4892.0, 5041.6722913010535, 5078.873028174251, 5111.846644600668, 5122.564582010571, 4117.3206420940205, 4211.557786432441, 4216.304309788912, 4231.8730438086295, 4273.850415235452, 1305.432137020399, 1339.430741934674, 1344.9058565900293, 1354.1130559483554, 1361.659585103724, 672.7611697847292, 703.426707233603, 703.8486725354073, 713.2688993781416, 720.92069872314, 5084.3644544431945, 5232.450592687789, 5244.659097158673, 5354.7858085676135, 5424.267723857308, 538.6687187379733, 544.5833937038169, 544.8283790605947, 546.281639643867, 555.8777069044804, 3388.186835159593, 3758.4550240215017, 3769.7172712046704, 3830.984789030909, 3937.7637341759587, 12907.419166137546, 13340.799888001688, 13419.597412077457, 13512.59462216135, 13513.054086213871, 12718.682032949066, 13117.147385419918, 13117.409716562586, 13165.802512962313, 13334.33328333599, 7417.777466676009, 7423.4061275097865, 7598.620068996528, 7614.619269036526, 7704.92295077042, 6160.10678451631, 6376.426121649074, 6383.946648802896, 6418.93581064202, 6427.453666438405, 11574.131940104695, 11587.246828956091, 11775.0, 11938.940305298418, 11993.940030300142, 11806.114541409257, 11968.222065565711, 12005.939970300093, 12039.518419263482, 12239.20445171061, 8310.33517318601, 8362.038365588036, 8424.83150337002, 8442.746717598482, 8446.070932197576, 9439.292053096182, 9521.143097121292, 9598.040195980626, 9602.0, 9602.08780165883, 7780.805479863048, 7984.321332686786, 7984.680612775656, 8095.433319667567, 8134.471259368122, 7742.187070357757, 7744.186860379579, 7760.18518055596, 7817.101033381006, 7832.37341012729, 7417.406607471497, 7528.962355188189, 7530.4352173588295, 7532.133804612539, 7535.095788505414, 4360.869173924787, 4998.300237966615, 5033.245013248042, 5209.869753256199, 5285.524302812765, 5244.554212891947, 5331.627425795484, 5342.652727572696, 5352.652077614943, 5389.218563308376], "value": 4642.865784854592, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.6960735338195, 360.4395165517619, 363.083214882422, 364.92519033598114, 365.3496775739184, 5258.342707161605, 5333.706646134461, 5354.196870469432, 5367.973160134204, 5369.355677318717, 5284.656497327681, 5285.947140528594, 5287.206918962158, 5293.364796224459, 5294.205869119634, 3847.865324713636, 3986.66113380363, 4112.074783173792, 4127.215828992489, 4134.813933373005, 3959.8812035638975, 3970.7293666026885, 3974.125692347679, 3992.8203230854538, 3997.060690737674, 3928.273269445162, 3944.3097457944887, 3944.7238693291483, 3946.881593552198, 3951.565327813938, 3952.5256969163884, 3954.110325176841, 3955.2287303975736, 3956.9208615827665, 3966.0, 3383.238771276443, 3395.2360718838313, 3412.7952322860706, 3447.413939630269, 3454.1882657575447, 5098.643094983353, 5102.591792656615, 5128.640995130342, 5131.589472842201, 5146.150885103953, 4617.492075871652, 4624.791884365211, 4635.490096089427, 4636.629069674418, 4649.697769644996, 5406.432324605899, 5529.391766905637, 5551.361593416728, 5559.63862348946, 5567.109262517978, 3825.7948746144875, 3831.0613899594778, 3834.9808250958845, 3835.9232815343817, 3837.0791010157363, 5528.75120619573, 5749.482546570829, 5779.248697669276, 5813.505852002585, 5902.557308201902, 3885.1841113365945, 3897.512810898638, 3903.746256493319, 3916.8433262669746, 3920.764754114762, 3953.5453422856162, 3961.088949541622, 3965.0682089708894, 3967.7024223183375, 3970.1265721541213, 4310.655147588185, 4379.868603941887, 4545.545445455494, 4600.861974140781, 4611.884702882455, 5533.312339736419, 5575.414581468968, 5576.330840299109, 5589.189567512688, 5590.664560126405, 1362.121431676583, 1368.2679766324968, 1371.0128707330705, 1374.271636032904, 1374.656335916021, 877.7849426890452, 880.7930136417937, 885.964561417549, 909.1999040844147, 916.3493919317226, 4839.201531747292, 4845.63657725665, 4850.83022094225, 4851.927221091686, 4874.927515946557, 5731.197632331477, 5756.7121643917635, 5770.971145144247, 5784.595078344475, 5794.565407594448, 4760.285957106393, 4811.422629284439, 4839.806407743651, 4841.878953026203, 4865.854024379274, 3009.7441717453826, 3044.1476386611785, 3046.786724929278, 3049.679783622688, 3056.2512184514935, 5333.146696528537, 5368.489993450616, 5405.21624364465, 5415.972920135374, 5416.51251387377, 5764.942350576441, 5847.567346000172, 5903.173555702205, 5906.26171728534, 5913.58604897653, 5339.252504649352, 5352.437994010651, 5355.196720491879, 5383.730813459233, 5384.5692344612335, 5539.81177434919, 5735.8566035849435, 5756.30924289088, 5776.855578610568, 5777.653340799566, 5705.600607957569, 5742.425757424224, 5747.885042299215, 5753.165790960371, 5759.424057594207, 5159.0, 5204.7918083276245, 5305.9469405307, 5388.946110539001, 5421.801137328837, 3852.2295540892496, 3853.8073096345634, 3858.247641709952, 3858.826352814186, 3863.4011728182177, 5819.301683797971, 5821.438567030493, 5822.2140011099655, 5824.912626310524, 5824.912626310694, 5422.15956526739, 5569.387367389665, 5606.159076138449, 5612.607117501736, 5618.410066943075, 5627.971860140673, 5630.690312032878, 5639.605227634191, 5649.689267090185, 5657.349404818334, 5422.783088676567, 5479.53423958968, 5529.22590837275, 5530.364008139116, 5545.195946587642, 5656.915146272727, 5659.745311461076, 5665.320161580472, 5679.318481782213, 5690.203371527907, 5493.7802487900035, 5498.285222920995, 5521.254630624814, 5529.0, 5539.8892022158525], "value": 4148.334400541354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.3676293531963, 761.4137114421895, 769.9990012983124, 774.3572834547326, 789.1083076123979, 13112.73774524509, 14252.144871307715, 14279.571612851605, 14319.140851548915, 14334.283285835705, 13826.516071937484, 15118.773218401733, 15319.846801531981, 15475.14886681232, 15636.374545018214, 894.8881389826255, 903.0382642485731, 905.0496978172926, 905.6286922361833, 906.4968942237056, 893.9731808045736, 918.6968300460832, 921.6774129054844, 921.7511271956567, 922.0180507759248, 957.0907637744136, 969.7042402067367, 970.5923512124924, 971.4414211828192, 973.352720440906, 956.0344052506948, 965.7392504023944, 966.4104896013391, 967.709687093869, 969.9030096990244, 705.4885208223997, 710.0875375142916, 710.6872975890592, 710.783211120608, 712.1240873725295, 13336.19982801035, 13418.731625367536, 14478.565643030726, 14649.19429431381, 14660.56018319452, 15816.76274855878, 15818.841811581968, 15980.0, 16072.75890861638, 16176.75734863978, 12320.322382268972, 12335.814962775565, 12419.130660853743, 12551.560695375709, 12558.0, 2991.4764916139807, 3010.3377257003426, 3015.577819105327, 3016.366563021768, 3017.969820301791, 71190.0, 71594.28405715928, 71780.6410967947, 73314.0, 74254.0, 12434.502619895284, 12542.0, 12679.683007924692, 12724.427400766803, 12820.80768788469, 23002.654960175612, 23293.184738534408, 23487.41281467977, 23495.88252058763, 23516.059357625847, 6103.816885493442, 6106.419890110433, 6134.263888333428, 6167.105769663373, 6216.471599913967, 2995.955060674092, 3040.619922509686, 3064.9540256896166, 3077.6306843178963, 3079.337942342407, 3473.2879759649213, 3546.3971124908826, 3560.412531932254, 3573.338932297533, 3576.7675101118343, 611.5596770325359, 623.1058431151313, 623.3361470034399, 623.7536173211556, 625.8654389306321, 581.3401788969466, 597.1758972617846, 600.5465873265656, 604.4559896093463, 617.1853153836893, 8531.189536993976, 8755.921565491999, 9336.673216437392, 9399.953000234955, 9637.469939153274, 590.0470739755265, 595.2529575382866, 600.7326739600923, 606.0485038489529, 611.1688104178314, 4163.5836416358125, 4180.435641188401, 4224.831006759757, 4253.787310634456, 4288.206681763883, 57999.4200057994, 59975.0, 60582.39417605856, 64641.35358646447, 65097.67451162809, 52067.73966130145, 52985.735071324394, 53058.0, 53067.46932530625, 55114.448855511735, 48443.757781210865, 48738.512614874104, 50746.0, 50782.74608627007, 50987.0, 10222.655371467245, 10441.321314114559, 10754.946225268823, 10760.515776789907, 10993.0, 25162.874185628956, 25459.490810184063, 25595.74404256008, 26668.0, 26854.731452685224, 31114.844425777726, 31578.36843263168, 31609.5258571117, 31782.84108579442, 32779.50830737589, 13886.375113120135, 13986.300684965507, 14143.575692729235, 14150.363233654305, 14190.219537925514, 15448.536543903701, 15473.690526189188, 15774.211289435712, 15926.362945482051, 16106.758398624264, 13809.930950345184, 14709.705805883608, 14769.409223631365, 14964.476243331432, 15169.848301516844, 13819.101758385672, 13884.86115138876, 13902.791458128338, 14096.859031409555, 14221.14673119616, 12473.251604903735, 13004.739905202032, 13114.60656180316, 13118.803217951929, 13322.40049197769, 9461.290403219647, 9646.855297170408, 9662.806743864943, 9833.262505311986, 10138.290319677551, 9852.852207216754, 9968.252381071594, 10103.696889093339, 10144.898551014396, 10365.222608304257], "value": 6766.6569727776805, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 112.0, 112.0, 113.0, 111.0, 112.0, 111.0, 111.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 122.0, 157.0, 123.0, 122.0, 122.0, 122.0, 158.0, 123.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 163.0, 162.0, 162.0, 161.0, 161.0, 163.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 111.0, 78.0, 75.0, 75.0, 75.0, 96.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 83.0, 83.0, 84.0, 96.0, 84.0, 83.0, 112.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 115.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 149.0, 148.0, 148.0, 149.0, 149.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 55.0, 55.0, 55.0, 55.0, 53.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 79.0, 79.0, 80.0, 80.0, 81.0, 80.0, 79.0, 82.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 131.0, 128.0, 137.0, 130.0, 129.0, 129.0, 132.0, 177.0, 134.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 189.0, 190.0, 196.0, 183.0, 189.0, 190.0, 189.0, 189.0, 187.0], "value": 188.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 71.0, 71.0, 72.0, 73.0, 74.0, 69.0, 70.0], "value": 71.3, "unit": "score"}]}]} 09:23:29 INFO - Return code: 0 09:23:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:23:29 INFO - # TBPL SUCCESS # 09:23:29 INFO - Running post-action listener: _resource_record_post_action 09:23:29 INFO - [mozharness: 2017-05-04 16:23:29.981005Z] Finished run-tests step (success) 09:23:29 INFO - Running post-run listener: _resource_record_post_run 09:23:30 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 350101504; Read time: 28; Write time: 267176 09:23:30 INFO - TinderboxPrint: CPU usage
12.9% 09:23:30 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 09:23:30 INFO - TinderboxPrint: I/O write bytes / time
350,101,504 / 267,176 09:23:30 INFO - TinderboxPrint: CPU idle
8,353.2 (87.1%) 09:23:30 INFO - TinderboxPrint: CPU user
1,197.1 (12.5%) 09:23:30 INFO - TinderboxPrint: Swap in / out
0 / 0 09:23:30 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 97443840; Read time: 0; Write time: 113240 09:23:30 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252055552; Read time: 16; Write time: 153904 09:23:30 INFO - Running post-run listener: _upload_blobber_files 09:23:30 INFO - Blob upload gear active. 09:23:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:23:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:23:30 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'] 09:23:30 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 09:23:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:23:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:23:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:23:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:31 INFO - (blobuploader) - INFO - Done attempting. 09:23:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:23:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:23:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:32 INFO - (blobuploader) - INFO - Done attempting. 09:23:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:23:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:23:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:33 INFO - (blobuploader) - INFO - Done attempting. 09:23:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:23:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:23:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:36 INFO - (blobuploader) - INFO - Done attempting. 09:23:36 INFO - (blobuploader) - INFO - Iteration through files over. 09:23:36 INFO - Return code: 0 09:23:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:23:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:23:36 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c05d9e411e6fcee2757f1bac15570ad319717c4e82fff81893c5571667c7d988492a5c45b6c792575cc22c361ff4d1b13848613e91976d549a5d8ba46138ab8f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/debd73d59b0ec02a1dc7cbf1b0e29b28a6aa583b9581ec1a6b3a39f070bc2117d20a705475e986d3a769028dc11d41a11caae8444baf48c8325134ca80216bd1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6e0b51ac4e2d3eebfc3d0740824f1dd768e9a8de72a48073e9f3baba7eb6d405d99a3e7c3c7882a95db4eb559e3db55e8c3206902b412d3db8f9111639fb235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/226e56144dd8db2139dbec6db0bc6e4ef6834b686189c2c54e975b7bd0683e97b5e54b060d7786245c5cee37eac6dfa42633cd7424d45dc9c31a437e26a97c30"} 09:23:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:23:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:23:36 INFO - Contents: 09:23:36 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c05d9e411e6fcee2757f1bac15570ad319717c4e82fff81893c5571667c7d988492a5c45b6c792575cc22c361ff4d1b13848613e91976d549a5d8ba46138ab8f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/debd73d59b0ec02a1dc7cbf1b0e29b28a6aa583b9581ec1a6b3a39f070bc2117d20a705475e986d3a769028dc11d41a11caae8444baf48c8325134ca80216bd1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6e0b51ac4e2d3eebfc3d0740824f1dd768e9a8de72a48073e9f3baba7eb6d405d99a3e7c3c7882a95db4eb559e3db55e8c3206902b412d3db8f9111639fb235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/226e56144dd8db2139dbec6db0bc6e4ef6834b686189c2c54e975b7bd0683e97b5e54b060d7786245c5cee37eac6dfa42633cd7424d45dc9c31a437e26a97c30"} 09:23:36 INFO - Running post-run listener: copy_logs_to_upload_dir 09:23:36 INFO - Copying logs to upload dir... 09:23:36 INFO - mkdir: /builds/slave/test/build/upload/logs 09:23:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.678154 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-04 09:23:36.085295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 09:23:36.088986) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c05d9e411e6fcee2757f1bac15570ad319717c4e82fff81893c5571667c7d988492a5c45b6c792575cc22c361ff4d1b13848613e91976d549a5d8ba46138ab8f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/debd73d59b0ec02a1dc7cbf1b0e29b28a6aa583b9581ec1a6b3a39f070bc2117d20a705475e986d3a769028dc11d41a11caae8444baf48c8325134ca80216bd1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6e0b51ac4e2d3eebfc3d0740824f1dd768e9a8de72a48073e9f3baba7eb6d405d99a3e7c3c7882a95db4eb559e3db55e8c3206902b412d3db8f9111639fb235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/226e56144dd8db2139dbec6db0bc6e4ef6834b686189c2c54e975b7bd0683e97b5e54b060d7786245c5cee37eac6dfa42633cd7424d45dc9c31a437e26a97c30"} build_url:https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c05d9e411e6fcee2757f1bac15570ad319717c4e82fff81893c5571667c7d988492a5c45b6c792575cc22c361ff4d1b13848613e91976d549a5d8ba46138ab8f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/debd73d59b0ec02a1dc7cbf1b0e29b28a6aa583b9581ec1a6b3a39f070bc2117d20a705475e986d3a769028dc11d41a11caae8444baf48c8325134ca80216bd1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6e0b51ac4e2d3eebfc3d0740824f1dd768e9a8de72a48073e9f3baba7eb6d405d99a3e7c3c7882a95db4eb559e3db55e8c3206902b412d3db8f9111639fb235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/226e56144dd8db2139dbec6db0bc6e4ef6834b686189c2c54e975b7bd0683e97b5e54b060d7786245c5cee37eac6dfa42633cd7424d45dc9c31a437e26a97c30"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 09:23:36.115245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:23:36.115588) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1493904596.143784-1088667462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:23:36.198744) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 09:23:36.199234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 09:23:36.199724) ========= ========= Total master_lag: 0.16 =========