builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1494020238.99 results: success (0) revision: ff83fde8be946eabcf27ea97d4676f601c122194 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:18.990260) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:18.990726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:18.991009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:19.021688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:19.022083) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 14:37:19-- 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% 42.6M=0s 2017-05-05 14:37:19 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126760 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:19.169085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:19.169450) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017816 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:19.223428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 14:37:19.226963) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff83fde8be946eabcf27ea97d4676f601c122194 --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 ff83fde8be946eabcf27ea97d4676f601c122194 --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=9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 14:37:19,290 truncating revision to first 12 chars 2017-05-05 14:37:19,290 Setting DEBUG logging. 2017-05-05 14:37:19,290 attempt 1/10 2017-05-05 14:37:19,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff83fde8be94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 14:37:20,577 unpacking tar archive at: mozilla-central-ff83fde8be94/testing/mozharness/ program finished with exit code 0 elapsedTime=1.587797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 14:37:20.828358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:20.828673) ========= script_repo_revision: ff83fde8be946eabcf27ea97d4676f601c122194 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:20.829052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:20.829728) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:20.840453) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-05 14:37:20.840866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:37:20 INFO - MultiFileLogger online at 20170505 14:37:20 in /builds/slave/test 14:37:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:37:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:37:20 INFO - {'append_to_log': False, 14:37:20 INFO - 'base_work_dir': '/builds/slave/test', 14:37:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:37:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:37:20 INFO - 'branch': 'Firefox-Non-PGO', 14:37:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:37:20 INFO - 'config_files': ('talos/linux_config.py',), 14:37:20 INFO - 'default_actions': ('clobber', 14:37:20 INFO - 'read-buildbot-config', 14:37:20 INFO - 'download-and-extract', 14:37:20 INFO - 'populate-webroot', 14:37:20 INFO - 'create-virtualenv', 14:37:20 INFO - 'install', 14:37:20 INFO - 'run-tests'), 14:37:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:37:20 INFO - 'download_minidump_stackwalk': True, 14:37:20 INFO - 'download_symbols': 'ondemand', 14:37:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:37:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:37:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:37:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:37:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:37:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:37:20 INFO - 'gecko_profile': False, 14:37:20 INFO - 'gecko_profile_interval': 0, 14:37:20 INFO - 'installer_path': 'installer.exe', 14:37:20 INFO - 'log_level': 'info', 14:37:20 INFO - 'log_name': 'talos', 14:37:20 INFO - 'log_to_console': True, 14:37:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:37:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:37:21 INFO - 'opt_config_files': (), 14:37:21 INFO - 'pip_index': False, 14:37:21 INFO - 'suite': 'dromaeojs-e10s', 14:37:21 INFO - 'system_bits': '32', 14:37:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:37:21 INFO - 'title': 'talos-linux64-ix-040', 14:37:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:37:21 INFO - 'use_talos_json': True, 14:37:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:37:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:37:21 INFO - 'work_dir': 'build'} 14:37:21 INFO - [mozharness: 2017-05-05 21:37:21.000855Z] Running clobber step. 14:37:21 INFO - Running pre-action listener: _resource_record_pre_action 14:37:21 INFO - Running main action method: clobber 14:37:21 INFO - rmtree: /builds/slave/test/build 14:37:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:37:21 INFO - Running post-action listener: _resource_record_post_action 14:37:21 INFO - [mozharness: 2017-05-05 21:37:21.931903Z] Finished clobber step (success) 14:37:21 INFO - [mozharness: 2017-05-05 21:37:21.932003Z] Running read-buildbot-config step. 14:37:21 INFO - Running pre-action listener: _resource_record_pre_action 14:37:21 INFO - Running main action method: read_buildbot_config 14:37:21 INFO - Using buildbot properties: 14:37:21 INFO - { 14:37:21 INFO - "project": "", 14:37:21 INFO - "product": "firefox", 14:37:21 INFO - "who": "kwierso@gmail.com", 14:37:21 INFO - "installer_path": "public/build/target.tar.bz2", 14:37:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:37:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:37:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:37:21 INFO - "stage_platform": "linux64", 14:37:21 INFO - "basedir": "/builds/slave/test", 14:37:21 INFO - "buildnumber": 855, 14:37:21 INFO - "platform": "ubuntu64_hw", 14:37:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:37:21 INFO - "slavebuilddir": "test", 14:37:21 INFO - "taskId": "TX3nRpS-RiOYaXKsXScd4g", 14:37:21 INFO - "branch": "mozilla-central", 14:37:21 INFO - "script_repo_revision": "production", 14:37:21 INFO - "revision": "ff83fde8be946eabcf27ea97d4676f601c122194", 14:37:21 INFO - "slavename": "talos-linux64-ix-040", 14:37:21 INFO - "repo_path": "mozilla-central" 14:37:21 INFO - } 14:37:21 INFO - Finding installer, test and symbols from parent task. 14:37:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TX3nRpS-RiOYaXKsXScd4g'}, attempt #1 14:37:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TX3nRpS-RiOYaXKsXScd4g'}, attempt #1 14:37:22 INFO - Task dependencies: WnUDgc1lSIy5CIwmv0vY0g 14:37:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g'}, attempt #1 14:37:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 14:37:23 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/test_packages.json 14:37:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.crashreporter-symbols.zip 14:37:23 INFO - Running post-action listener: _resource_record_post_action 14:37:23 INFO - [mozharness: 2017-05-05 21:37:23.303644Z] Finished read-buildbot-config step (success) 14:37:23 INFO - [mozharness: 2017-05-05 21:37:23.303862Z] Running download-and-extract step. 14:37:23 INFO - Running pre-action listener: _resource_record_pre_action 14:37:23 INFO - Running main action method: download_and_extract 14:37:23 INFO - mkdir: /builds/slave/test/build/tests 14:37:23 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')]} 14:37:23 INFO - trying https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.test_packages.json 14:37:23 INFO - Downloading https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:37:23 INFO - Downloaded 986 bytes. 14:37:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:37:23 INFO - Using the following test package requirements: 14:37:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:37:23 INFO - u'common': [u'target.common.tests.zip'], 14:37:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:37:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:37:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:37:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:37:23 INFO - u'mozbase': [u'target.common.tests.zip'], 14:37:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:37:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:37:23 INFO - u'web-platform': [u'target.common.tests.zip', 14:37:23 INFO - u'target.web-platform.tests.zip'], 14:37:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:37:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:37:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip 14:37:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:37:23 INFO - Fetch https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip into memory 14:37:24 INFO - Content-Length response header: 58438136 14:37:24 INFO - Bytes received: 58438136 14:37:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:37:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip 14:37:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:37:34 INFO - Fetch https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip into memory 14:37:35 INFO - Content-Length response header: 58438136 14:37:35 INFO - Bytes received: 58438136 14:37:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.talos.tests.zip 14:37:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:37:46 INFO - Fetch https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.talos.tests.zip into memory 14:37:47 INFO - Content-Length response header: 14408697 14:37:47 INFO - Bytes received: 14408697 14:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:47 INFO - trying https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 14:37:47 INFO - Downloading https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:37:48 INFO - Downloaded 58380545 bytes. 14:37:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 14:37:48 INFO - mkdir: /builds/slave/test/properties 14:37:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:37:48 INFO - Writing to file /builds/slave/test/properties/build_url 14:37:48 INFO - Contents: 14:37:48 INFO - build_url:https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 14:37:48 INFO - Running post-action listener: _resource_record_post_action 14:37:48 INFO - Running post-action listener: set_extra_try_arguments 14:37:48 INFO - [mozharness: 2017-05-05 21:37:48.691719Z] Finished download-and-extract step (success) 14:37:48 INFO - [mozharness: 2017-05-05 21:37:48.691816Z] Running populate-webroot step. 14:37:48 INFO - Running pre-action listener: _resource_record_pre_action 14:37:48 INFO - Running main action method: populate_webroot 14:37:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:37:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:37:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:37:48 INFO - '--tppagecycles', 14:37:48 INFO - '7'], 14:37:48 INFO - 'tests': ['tsvgm']}}, 14:37:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:37:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:37:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:37:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:37:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:37:48 INFO - 'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:37:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:37:48 INFO - 'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['damp', 'tps']}, 14:37:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:37:48 INFO - 'tests': ['damp', 'tps']}, 14:37:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['dromaeo_dom']}, 14:37:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:37:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:37:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:37:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['a11yr', 14:37:48 INFO - 'ts_paint', 14:37:48 INFO - 'tpaint', 14:37:48 INFO - 'sessionrestore', 14:37:48 INFO - 'sessionrestore_no_auto_restore', 14:37:48 INFO - 'tabpaint']}, 14:37:48 INFO - 'other-e10s': {'tests': ['a11yr', 14:37:48 INFO - 'ts_paint', 14:37:48 INFO - 'tpaint', 14:37:48 INFO - 'sessionrestore', 14:37:48 INFO - 'sessionrestore_no_auto_restore', 14:37:48 INFO - 'tabpaint']}, 14:37:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:37:48 INFO - 'ts_paint', 14:37:48 INFO - 'tpaint', 14:37:48 INFO - 'sessionrestore', 14:37:48 INFO - 'sessionrestore_no_auto_restore', 14:37:48 INFO - 'tabpaint']}, 14:37:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:37:48 INFO - 'ts_paint', 14:37:48 INFO - 'tpaint', 14:37:48 INFO - 'sessionrestore', 14:37:48 INFO - 'sessionrestore_no_auto_restore', 14:37:48 INFO - 'tabpaint']}, 14:37:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['a11yr', 14:37:48 INFO - 'ts_paint', 14:37:48 INFO - 'tpaint', 14:37:48 INFO - 'sessionrestore', 14:37:48 INFO - 'sessionrestore_no_auto_restore', 14:37:48 INFO - 'tabpaint']}, 14:37:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['a11yr', 14:37:48 INFO - 'ts_paint', 14:37:48 INFO - 'tpaint', 14:37:48 INFO - 'sessionrestore', 14:37:48 INFO - 'sessionrestore_no_auto_restore', 14:37:48 INFO - 'tabpaint']}, 14:37:48 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:37:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:37:48 INFO - 'bloom_basic_ref']}, 14:37:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['tsvgx', 14:37:48 INFO - 'tsvgr_opacity', 14:37:48 INFO - 'tart', 14:37:48 INFO - 'tscrollx', 14:37:48 INFO - 'cart', 14:37:48 INFO - 'tsvg_static']}, 14:37:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:37:48 INFO - 'tsvgr_opacity', 14:37:48 INFO - 'tart', 14:37:48 INFO - 'tscrollx', 14:37:48 INFO - 'cart', 14:37:48 INFO - 'tsvg_static']}, 14:37:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:37:48 INFO - 'talos_options': ['--disable-e10s'], 14:37:48 INFO - 'tests': ['tp5o']}, 14:37:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:37:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:37:48 INFO - 'talos_options': ['--disable-e10s', 14:37:48 INFO - '--xperf_path', 14:37:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:48 INFO - 'tests': ['tp5n']}, 14:37:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:37:48 INFO - 'talos_options': ['--xperf_path', 14:37:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:48 INFO - 'tests': ['tp5n']}}, 14:37:48 INFO - 'talos.zip': {'path': '', 14:37:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:37:48 INFO - Running post-action listener: _resource_record_post_action 14:37:48 INFO - [mozharness: 2017-05-05 21:37:48.705526Z] Finished populate-webroot step (success) 14:37:48 INFO - [mozharness: 2017-05-05 21:37:48.705616Z] Running create-virtualenv step. 14:37:48 INFO - Running pre-action listener: _resource_record_pre_action 14:37:48 INFO - Running main action method: create_virtualenv 14:37:48 INFO - Creating virtualenv /builds/slave/test/build/venv 14:37:48 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 14:37:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:37:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:37:48 INFO - Using real prefix '/usr' 14:37:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:37:49 INFO - Installing distribute.............................................................................................................................................................................................done. 14:37:51 INFO - Installing pip.................done. 14:37:51 INFO - Return code: 0 14:37:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:37:51 INFO - Reading from file tmpfile_stdout 14:37:51 INFO - Output received: 14:37:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:37:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:37:51 INFO - Using env: {'DISPLAY': ':0', 14:37:51 INFO - 'HOME': '/home/cltbld', 14:37:51 INFO - 'LANG': 'en_US.UTF-8', 14:37:51 INFO - 'LANGUAGE': 'en_US:en', 14:37:51 INFO - 'LOGNAME': 'cltbld', 14:37:51 INFO - 'MAIL': '/var/mail/cltbld', 14:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:51 INFO - 'MOZ_NO_REMOTE': '1', 14:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:51 INFO - 'NO_EM_RESTART': '1', 14:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:51 INFO - 'PWD': '/builds/slave/test', 14:37:51 INFO - 'SHELL': '/bin/bash', 14:37:51 INFO - 'SHLVL': '1', 14:37:51 INFO - 'TERM': 'linux', 14:37:51 INFO - 'TMOUT': '86400', 14:37:51 INFO - 'USER': 'cltbld', 14:37:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:51 INFO - '_': '/tools/buildbot/bin/python'} 14:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:51 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 14:37:51 INFO - Cleaning up... 14:37:51 INFO - Return code: 0 14:37:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:37:51 INFO - Using env: {'DISPLAY': ':0', 14:37:51 INFO - 'HOME': '/home/cltbld', 14:37:51 INFO - 'LANG': 'en_US.UTF-8', 14:37:51 INFO - 'LANGUAGE': 'en_US:en', 14:37:51 INFO - 'LOGNAME': 'cltbld', 14:37:51 INFO - 'MAIL': '/var/mail/cltbld', 14:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:51 INFO - 'MOZ_NO_REMOTE': '1', 14:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:51 INFO - 'NO_EM_RESTART': '1', 14:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:51 INFO - 'PWD': '/builds/slave/test', 14:37:51 INFO - 'SHELL': '/bin/bash', 14:37:51 INFO - 'SHLVL': '1', 14:37:51 INFO - 'TERM': 'linux', 14:37:51 INFO - 'TMOUT': '86400', 14:37:51 INFO - 'USER': 'cltbld', 14:37:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:51 INFO - '_': '/tools/buildbot/bin/python'} 14:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:51 INFO - Downloading/unpacking psutil>=3.1.1 14:37:51 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 14:37:51 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 14:37:51 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 14:37:51 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 14:37:51 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 14:37:51 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 14:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:53 INFO - Installing collected packages: psutil 14:37:53 INFO - Running setup.py install for psutil 14:37:53 INFO - building 'psutil._psutil_linux' extension 14:37:53 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 14:37:53 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 14:37:53 INFO - building 'psutil._psutil_posix' extension 14:37:53 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 14:37:53 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 14:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:53 INFO - Successfully installed psutil 14:37:53 INFO - Cleaning up... 14:37:53 INFO - Return code: 0 14:37:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:37:53 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')]} 14:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:53 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')]} 14:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:53 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 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:37:53 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 14:37:53 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 14:37:53 INFO - Using env: {'DISPLAY': ':0', 14:37:53 INFO - 'HOME': '/home/cltbld', 14:37:53 INFO - 'LANG': 'en_US.UTF-8', 14:37:53 INFO - 'LANGUAGE': 'en_US:en', 14:37:53 INFO - 'LOGNAME': 'cltbld', 14:37:53 INFO - 'MAIL': '/var/mail/cltbld', 14:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:53 INFO - 'MOZ_NO_REMOTE': '1', 14:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:53 INFO - 'NO_EM_RESTART': '1', 14:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:53 INFO - 'PWD': '/builds/slave/test', 14:37:53 INFO - 'SHELL': '/bin/bash', 14:37:53 INFO - 'SHLVL': '1', 14:37:53 INFO - 'TERM': 'linux', 14:37:53 INFO - 'TMOUT': '86400', 14:37:53 INFO - 'USER': 'cltbld', 14:37:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:53 INFO - '_': '/tools/buildbot/bin/python'} 14:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:37:55 INFO - Installing collected packages: mozsystemmonitor 14:37:55 INFO - Running setup.py install for mozsystemmonitor 14:37:55 INFO - Successfully installed mozsystemmonitor 14:37:55 INFO - Cleaning up... 14:37:55 INFO - Return code: 0 14:37:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:37:55 INFO - Using env: {'DISPLAY': ':0', 14:37:55 INFO - 'HOME': '/home/cltbld', 14:37:55 INFO - 'LANG': 'en_US.UTF-8', 14:37:55 INFO - 'LANGUAGE': 'en_US:en', 14:37:55 INFO - 'LOGNAME': 'cltbld', 14:37:55 INFO - 'MAIL': '/var/mail/cltbld', 14:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:55 INFO - 'MOZ_NO_REMOTE': '1', 14:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:55 INFO - 'NO_EM_RESTART': '1', 14:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:55 INFO - 'PWD': '/builds/slave/test', 14:37:55 INFO - 'SHELL': '/bin/bash', 14:37:55 INFO - 'SHLVL': '1', 14:37:55 INFO - 'TERM': 'linux', 14:37:55 INFO - 'TMOUT': '86400', 14:37:55 INFO - 'USER': 'cltbld', 14:37:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:55 INFO - '_': '/tools/buildbot/bin/python'} 14:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:55 INFO - Downloading/unpacking jsonschema==2.5.1 14:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:37:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:37:56 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 14:37:56 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 14:37:56 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 14:37:56 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 14:37:56 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 14:37:56 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 14:37:56 INFO - Downloading functools32-3.2.3-2.tar.gz 14:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:37:56 INFO - warning: no files found matching '*.txt' 14:37:56 INFO - no previously-included directories found matching 'build' 14:37:56 INFO - no previously-included directories found matching 'dist' 14:37:56 INFO - no previously-included directories found matching '.git*' 14:37:56 INFO - Installing collected packages: jsonschema, functools32 14:37:56 INFO - Running setup.py install for functools32 14:37:56 INFO - warning: no files found matching '*.txt' 14:37:56 INFO - no previously-included directories found matching 'build' 14:37:56 INFO - no previously-included directories found matching 'dist' 14:37:56 INFO - no previously-included directories found matching '.git*' 14:37:56 INFO - Successfully installed jsonschema functools32 14:37:56 INFO - Cleaning up... 14:37:56 INFO - Return code: 0 14:37:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:37:56 INFO - Using env: {'DISPLAY': ':0', 14:37:56 INFO - 'HOME': '/home/cltbld', 14:37:56 INFO - 'LANG': 'en_US.UTF-8', 14:37:56 INFO - 'LANGUAGE': 'en_US:en', 14:37:56 INFO - 'LOGNAME': 'cltbld', 14:37:56 INFO - 'MAIL': '/var/mail/cltbld', 14:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:56 INFO - 'MOZ_NO_REMOTE': '1', 14:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:56 INFO - 'NO_EM_RESTART': '1', 14:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:56 INFO - 'PWD': '/builds/slave/test', 14:37:56 INFO - 'SHELL': '/bin/bash', 14:37:56 INFO - 'SHLVL': '1', 14:37:56 INFO - 'TERM': 'linux', 14:37:56 INFO - 'TMOUT': '86400', 14:37:56 INFO - 'USER': 'cltbld', 14:37:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:56 INFO - '_': '/tools/buildbot/bin/python'} 14:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:37:57 INFO - Cleaning up... 14:37:57 INFO - Return code: 0 14:37:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:37:57 INFO - Using env: {'DISPLAY': ':0', 14:37:57 INFO - 'HOME': '/home/cltbld', 14:37:57 INFO - 'LANG': 'en_US.UTF-8', 14:37:57 INFO - 'LANGUAGE': 'en_US:en', 14:37:57 INFO - 'LOGNAME': 'cltbld', 14:37:57 INFO - 'MAIL': '/var/mail/cltbld', 14:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:57 INFO - 'MOZ_NO_REMOTE': '1', 14:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:57 INFO - 'NO_EM_RESTART': '1', 14:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:57 INFO - 'PWD': '/builds/slave/test', 14:37:57 INFO - 'SHELL': '/bin/bash', 14:37:57 INFO - 'SHLVL': '1', 14:37:57 INFO - 'TERM': 'linux', 14:37:57 INFO - 'TMOUT': '86400', 14:37:57 INFO - 'USER': 'cltbld', 14:37:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:57 INFO - '_': '/tools/buildbot/bin/python'} 14:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:57 INFO - Downloading/unpacking blobuploader==1.2.4 14:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:58 INFO - Downloading blobuploader-1.2.4.tar.gz 14:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:37:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:37:58 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 14:37:58 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 14:37:58 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 14:37:58 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 14:37:58 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 14:37:58 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 14:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:37:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:37:58 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 14:37:58 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 14:37:58 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 14:37:58 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 14:37:58 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 14:37:58 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 14:37:58 INFO - Downloading docopt-0.6.1.tar.gz 14:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:37:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:37:59 INFO - Running setup.py install for blobuploader 14:37:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:37:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:37:59 INFO - Running setup.py install for requests 14:37:59 INFO - Running setup.py install for docopt 14:37:59 INFO - Successfully installed blobuploader requests docopt 14:37:59 INFO - Cleaning up... 14:37:59 INFO - Return code: 0 14:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:59 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 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:37:59 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 14:37:59 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 14:37:59 INFO - Using env: {'DISPLAY': ':0', 14:37:59 INFO - 'HOME': '/home/cltbld', 14:37:59 INFO - 'LANG': 'en_US.UTF-8', 14:37:59 INFO - 'LANGUAGE': 'en_US:en', 14:37:59 INFO - 'LOGNAME': 'cltbld', 14:37:59 INFO - 'MAIL': '/var/mail/cltbld', 14:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:59 INFO - 'MOZ_NO_REMOTE': '1', 14:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:59 INFO - 'NO_EM_RESTART': '1', 14:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:59 INFO - 'PWD': '/builds/slave/test', 14:37:59 INFO - 'SHELL': '/bin/bash', 14:37:59 INFO - 'SHLVL': '1', 14:37:59 INFO - 'TERM': 'linux', 14:37:59 INFO - 'TMOUT': '86400', 14:37:59 INFO - 'USER': 'cltbld', 14:37:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:59 INFO - '_': '/tools/buildbot/bin/python'} 14:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:59 INFO - Running setup.py (path:/tmp/pip-pJ5r2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:59 INFO - Running setup.py (path:/tmp/pip-gdve0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:38:00 INFO - Running setup.py (path:/tmp/pip-uIjy5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:38:00 INFO - Running setup.py (path:/tmp/pip-AIilI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:38:00 INFO - Running setup.py (path:/tmp/pip-acwJSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:38:00 INFO - Running setup.py (path:/tmp/pip-Nydb_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:38:00 INFO - Running setup.py (path:/tmp/pip-KHr7sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:38:00 INFO - Running setup.py (path:/tmp/pip-9ZA4Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:38:00 INFO - Running setup.py (path:/tmp/pip-DzXBT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:38:00 INFO - Running setup.py (path:/tmp/pip-obVVor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:38:00 INFO - Running setup.py (path:/tmp/pip-BB2exa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:38:00 INFO - Running setup.py (path:/tmp/pip-KnMCFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:38:00 INFO - Running setup.py (path:/tmp/pip-mMQnzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:38:00 INFO - Running setup.py (path:/tmp/pip-f5Yx93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:00 INFO - Running setup.py (path:/tmp/pip-EbdXSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:38:00 INFO - Running setup.py (path:/tmp/pip-LIhtLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:38:01 INFO - Running setup.py (path:/tmp/pip-7WekWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:38:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:38:01 INFO - Running setup.py install for manifestparser 14:38:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:38:01 INFO - Running setup.py install for mozcrash 14:38:01 INFO - Running setup.py install for mozdebug 14:38:01 INFO - Running setup.py install for mozdevice 14:38:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:38:01 INFO - Running setup.py install for mozfile 14:38:01 INFO - Running setup.py install for mozhttpd 14:38:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:38:01 INFO - Running setup.py install for mozinfo 14:38:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:38:01 INFO - Running setup.py install for mozInstall 14:38:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:38:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:38:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:38:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:38:01 INFO - Running setup.py install for mozleak 14:38:02 INFO - Running setup.py install for mozlog 14:38:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:38:02 INFO - Running setup.py install for moznetwork 14:38:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:38:02 INFO - Running setup.py install for mozprocess 14:38:02 INFO - Running setup.py install for mozprofile 14:38:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:38:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:38:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:38:02 INFO - Running setup.py install for mozrunner 14:38:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:38:02 INFO - Running setup.py install for mozscreenshot 14:38:02 INFO - Running setup.py install for moztest 14:38:02 INFO - Running setup.py install for mozversion 14:38:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:38:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:38:02 INFO - Cleaning up... 14:38:02 INFO - Return code: 0 14:38:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:02 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 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:38:02 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 14:38:02 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 14:38:02 INFO - Using env: {'DISPLAY': ':0', 14:38:02 INFO - 'HOME': '/home/cltbld', 14:38:02 INFO - 'LANG': 'en_US.UTF-8', 14:38:02 INFO - 'LANGUAGE': 'en_US:en', 14:38:02 INFO - 'LOGNAME': 'cltbld', 14:38:02 INFO - 'MAIL': '/var/mail/cltbld', 14:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:02 INFO - 'MOZ_NO_REMOTE': '1', 14:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:02 INFO - 'NO_EM_RESTART': '1', 14:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:02 INFO - 'PWD': '/builds/slave/test', 14:38:02 INFO - 'SHELL': '/bin/bash', 14:38:02 INFO - 'SHLVL': '1', 14:38:02 INFO - 'TERM': 'linux', 14:38:02 INFO - 'TMOUT': '86400', 14:38:02 INFO - 'USER': 'cltbld', 14:38:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:02 INFO - '_': '/tools/buildbot/bin/python'} 14:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:38:03 INFO - Running setup.py (path:/tmp/pip-C7yhYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:38:03 INFO - Running setup.py (path:/tmp/pip-jVxJom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:38:03 INFO - Running setup.py (path:/tmp/pip-KTPRWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:38:03 INFO - Running setup.py (path:/tmp/pip-AfiVIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:38:03 INFO - Running setup.py (path:/tmp/pip-SRltO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:38:03 INFO - Running setup.py (path:/tmp/pip-S5Phv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:38:03 INFO - Running setup.py (path:/tmp/pip-tH60zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:38:03 INFO - Running setup.py (path:/tmp/pip-gsIZQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:38:03 INFO - Running setup.py (path:/tmp/pip-9lPwO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:38:03 INFO - Running setup.py (path:/tmp/pip-Mbche0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:38:03 INFO - Running setup.py (path:/tmp/pip-VkTiFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:38:03 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)) 14:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:38:03 INFO - Running setup.py (path:/tmp/pip-ViMHdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:38:04 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)) 14:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:38:04 INFO - Running setup.py (path:/tmp/pip-_9TRXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:38:04 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)) 14:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:38:04 INFO - Running setup.py (path:/tmp/pip-bTGBEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:38:04 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)) 14:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:04 INFO - Running setup.py (path:/tmp/pip-HP3UiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:04 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)) 14:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:38:04 INFO - Running setup.py (path:/tmp/pip-YfXJSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:38:04 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)) 14:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:38:04 INFO - Running setup.py (path:/tmp/pip-GFKNqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:38:04 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)) 14:38:04 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)) 14:38:04 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)) 14:38:04 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)) 14:38:04 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)) 14:38:04 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)) 14:38:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:05 INFO - Downloading blessings-1.6.tar.gz 14:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:38:05 INFO - Installing collected packages: blessings 14:38:05 INFO - Running setup.py install for blessings 14:38:05 INFO - Successfully installed blessings 14:38:05 INFO - Cleaning up... 14:38:05 INFO - Return code: 0 14:38:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:38:05 INFO - Reading from file tmpfile_stdout 14:38:05 INFO - Current package versions: 14:38:05 INFO - argparse == 1.2.1 14:38:05 INFO - blessings == 1.6 14:38:05 INFO - blobuploader == 1.2.4 14:38:05 INFO - docopt == 0.6.1 14:38:05 INFO - functools32 == 3.2.3-2 14:38:05 INFO - jsonschema == 2.5.1 14:38:05 INFO - manifestparser == 1.1 14:38:05 INFO - mozInstall == 1.12 14:38:05 INFO - mozcrash == 1.0 14:38:05 INFO - mozdebug == 0.1 14:38:05 INFO - mozdevice == 0.50 14:38:05 INFO - mozfile == 1.2 14:38:05 INFO - mozhttpd == 0.7 14:38:05 INFO - mozinfo == 0.9 14:38:05 INFO - mozleak == 0.1 14:38:05 INFO - mozlog == 3.4 14:38:05 INFO - moznetwork == 0.27 14:38:05 INFO - mozprocess == 0.25 14:38:05 INFO - mozprofile == 0.28 14:38:05 INFO - mozrunner == 6.13 14:38:05 INFO - mozscreenshot == 0.1 14:38:05 INFO - mozsystemmonitor == 0.3 14:38:05 INFO - moztest == 0.8 14:38:05 INFO - mozversion == 1.4 14:38:05 INFO - psutil == 3.1.1 14:38:05 INFO - requests == 1.2.3 14:38:05 INFO - wsgiref == 0.1.2 14:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:05 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')]} 14:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:05 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')]} 14:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:05 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 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:38:05 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 14:38:05 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 14:38:05 INFO - Using env: {'DISPLAY': ':0', 14:38:05 INFO - 'HOME': '/home/cltbld', 14:38:05 INFO - 'LANG': 'en_US.UTF-8', 14:38:05 INFO - 'LANGUAGE': 'en_US:en', 14:38:05 INFO - 'LOGNAME': 'cltbld', 14:38:05 INFO - 'MAIL': '/var/mail/cltbld', 14:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:05 INFO - 'MOZ_NO_REMOTE': '1', 14:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:05 INFO - 'NO_EM_RESTART': '1', 14:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:05 INFO - 'PWD': '/builds/slave/test', 14:38:05 INFO - 'SHELL': '/bin/bash', 14:38:05 INFO - 'SHLVL': '1', 14:38:05 INFO - 'TERM': 'linux', 14:38:05 INFO - 'TMOUT': '86400', 14:38:05 INFO - 'USER': 'cltbld', 14:38:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:05 INFO - '_': '/tools/buildbot/bin/python'} 14:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 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)) 14:38:06 INFO - Cleaning up... 14:38:06 INFO - Return code: 0 14:38:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:38:06 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')]} 14:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:06 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')]} 14:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:06 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 0x1b321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', '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 14:38:06 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 14:38:06 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 14:38:06 INFO - Using env: {'DISPLAY': ':0', 14:38:06 INFO - 'HOME': '/home/cltbld', 14:38:06 INFO - 'LANG': 'en_US.UTF-8', 14:38:06 INFO - 'LANGUAGE': 'en_US:en', 14:38:06 INFO - 'LOGNAME': 'cltbld', 14:38:06 INFO - 'MAIL': '/var/mail/cltbld', 14:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:06 INFO - 'MOZ_NO_REMOTE': '1', 14:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:06 INFO - 'NO_EM_RESTART': '1', 14:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:06 INFO - 'PWD': '/builds/slave/test', 14:38:06 INFO - 'SHELL': '/bin/bash', 14:38:06 INFO - 'SHLVL': '1', 14:38:06 INFO - 'TERM': 'linux', 14:38:06 INFO - 'TMOUT': '86400', 14:38:06 INFO - 'USER': 'cltbld', 14:38:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:06 INFO - '_': '/tools/buildbot/bin/python'} 14:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:38:06 INFO - Cleaning up... 14:38:06 INFO - Return code: 0 14:38:06 INFO - Running post-action listener: _resource_record_post_action 14:38:06 INFO - Running post-action listener: _start_resource_monitoring 14:38:06 INFO - Starting resource monitoring. 14:38:06 INFO - [mozharness: 2017-05-05 21:38:06.384134Z] Finished create-virtualenv step (success) 14:38:06 INFO - [mozharness: 2017-05-05 21:38:06.384596Z] Running install step. 14:38:06 INFO - Running pre-action listener: _resource_record_pre_action 14:38:06 INFO - Running main action method: install 14:38:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:38:06 INFO - Reading from file tmpfile_stdout 14:38:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:38:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:38:06 INFO - Reading from file tmpfile_stdout 14:38:06 INFO - Output received: 14:38:06 INFO - Usage: mozinstall [options] installer 14:38:06 INFO - Options: 14:38:06 INFO - -h, --help show this help message and exit 14:38:06 INFO - -d DEST, --destination=DEST 14:38:06 INFO - Directory to install application into. [default: 14:38:06 INFO - "/builds/slave/test"] 14:38:06 INFO - --app=APP Application being installed. [default: firefox] 14:38:06 INFO - mkdir: /builds/slave/test/build/application 14:38:06 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'] 14:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:38:22 INFO - Reading from file tmpfile_stdout 14:38:22 INFO - Output received: 14:38:22 INFO - /builds/slave/test/build/application/firefox/firefox 14:38:22 INFO - Running post-action listener: _resource_record_post_action 14:38:22 INFO - [mozharness: 2017-05-05 21:38:22.181999Z] Finished install step (success) 14:38:22 INFO - [mozharness: 2017-05-05 21:38:22.182270Z] Running run-tests step. 14:38:22 INFO - Running pre-action listener: _resource_record_pre_action 14:38:22 INFO - Running main action method: run_tests 14:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:38:22 INFO - Python 2.7.3 14:38:22 INFO - Return code: 0 14:38:22 INFO - grabbing minidump binary from tooltool 14:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:22 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 0x1dcd290>, '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 0x1dcdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dce040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:38:22 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 14:38:22 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 14:38:22 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 14:38:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:38:22 INFO - Return code: 0 14:38:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:38:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:38:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:38:22 INFO - ENV: RUST_BACKTRACE is now 1 14:38:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:38:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:38:22 INFO - Using env: {'DISPLAY': ':0', 14:38:22 INFO - 'HOME': '/home/cltbld', 14:38:22 INFO - 'LANG': 'en_US.UTF-8', 14:38:22 INFO - 'LANGUAGE': 'en_US:en', 14:38:22 INFO - 'LOGNAME': 'cltbld', 14:38:22 INFO - 'MAIL': '/var/mail/cltbld', 14:38:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:38:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:22 INFO - 'MOZ_NO_REMOTE': '1', 14:38:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:22 INFO - 'NO_EM_RESTART': '1', 14:38:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:22 INFO - 'PWD': '/builds/slave/test', 14:38:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:38:22 INFO - 'RUST_BACKTRACE': '1', 14:38:22 INFO - 'SHELL': '/bin/bash', 14:38:22 INFO - 'SHLVL': '1', 14:38:22 INFO - 'TERM': 'linux', 14:38:22 INFO - 'TMOUT': '86400', 14:38:22 INFO - 'USER': 'cltbld', 14:38:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151', 14:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:22 INFO - '_': '/tools/buildbot/bin/python'} 14:38:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:38:22 INFO - mozversion application_buildid: 20170505210647 14:38:22 INFO - mozversion application_changeset: ff83fde8be946eabcf27ea97d4676f601c122194 14:38:22 INFO - mozversion application_display_name: Nightly 14:38:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:38:22 INFO - mozversion application_name: Firefox 14:38:22 INFO - mozversion application_remotingname: firefox 14:38:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:38:22 INFO - mozversion application_vendor: Mozilla 14:38:22 INFO - mozversion application_version: 55.0a1 14:38:22 INFO - mozversion platform_buildid: 20170505210647 14:38:22 INFO - mozversion platform_changeset: ff83fde8be946eabcf27ea97d4676f601c122194 14:38:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:38:22 INFO - mozversion platform_version: 55.0a1 14:38:22 INFO - using testdate: 1494020302 14:38:22 INFO - actual date: 1494020302 14:38:22 INFO - starting webserver on 'localhost:54350' 14:38:22 INFO - SUITE-START | Running 2 tests 14:38:22 INFO - TEST-START | dromaeo_css 14:38:22 INFO - operating with platform_type : linux_ 14:38:22 INFO - Initialising browser for dromaeo_css test... 14:38:22 INFO - TEST-INFO | started process 5880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt3uZGN/profile http://localhost:54350/getInfo.html) 14:38:26 INFO - PID 5880 | __metrics Screen width/height:1600/1200 14:38:26 INFO - PID 5880 | colorDepth:24 14:38:26 INFO - PID 5880 | Browser inner width/height: 1024/695 14:38:26 INFO - PID 5880 | __metrics 14:38:29 INFO - TEST-INFO | 5880: exit 0 14:38:29 INFO - Browser initialized. 14:38:29 INFO - Running cycle 1/1 for dromaeo_css test... 14:38:29 INFO - TEST-INFO | started process 6051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt3uZGN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:41 INFO - PID 6051 | RSS: Main: 179732480 14:38:41 INFO - PID 6051 | 14:41:45 INFO - PID 6051 | Cycle 1(1): loaded http://localhost:54350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54350/tests/dromaeo/cssquery-ext.html) 14:41:49 INFO - PID 6051 | RSS: Main: 171917312 14:41:49 INFO - PID 6051 | 14:44:51 INFO - PID 6051 | Cycle 1(1): loaded http://localhost:54350/tests/dromaeo/cssquery-ext.html (next: http://localhost:54350/tests/dromaeo/cssquery-jquery.html) 14:44:51 INFO - PID 6051 | RSS: Main: 166850560 14:44:51 INFO - PID 6051 | 14:47:53 INFO - PID 6051 | Cycle 1(1): loaded http://localhost:54350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54350/tests/dromaeo/cssquery-mootools.html) 14:47:54 INFO - PID 6051 | RSS: Main: 175251456 14:47:54 INFO - PID 6051 | 14:50:56 INFO - PID 6051 | Cycle 1(1): loaded http://localhost:54350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54350/tests/dromaeo/cssquery-prototype.html) 14:50:56 INFO - PID 6051 | RSS: Main: 167473152 14:50:56 INFO - PID 6051 | 14:53:59 INFO - PID 6051 | Cycle 1(1): loaded http://localhost:54350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54350/tests/dromaeo/cssquery-yui.html) 14:54:00 INFO - PID 6051 | RSS: Main: 172363776 14:54:00 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | Cycle 1(1): loaded http://localhost:54350/tests/dromaeo/cssquery-yui.html (next: http://localhost:54350/tests/dromaeo/cssquery-dojo.html) 14:57:02 INFO - PID 6051 | RSS: Main: 174051328 14:57:02 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | __start_tp_report 14:57:02 INFO - PID 6051 | _x_x_mozilla_page_load 14:57:02 INFO - PID 6051 | _x_x_mozilla_page_load_details 14:57:02 INFO - PID 6051 | |i|pagename|runs| 14:57:02 INFO - PID 6051 | |0;dojo.html;2732.84969326687;2733.3030077330304;2743.561030235163;2763.3367991682;2778.7638050765686;5297.364316282052;5332.840014799557;5349.91975120373;5376.301080859483;5423.593230507713;5330.466953304667;5372.194170874371;5398.64908780929;5457.399686034533;5494.2857428534335;4489.889398898746;4743.146233677945;4750.311204875291;4777.283407488887;4779.259214821708;4781.995780886018;4793.065352256312;4834.9033019339595;4851.539103785135;4862.246351815475;4652.837150699709;4709.552592503741;4711.458182309044;4770.308305295747;4791.401074865642;4784.114938736345;4796.400449943757;4808.134535783557;4832.589229915427;4861.246506791453;4737.976310118427;4778.331033655291;4780.832670856538;4798.160321943646;4812.831550895702;5253.3170687810725;5257.7108259045735;5370.785168593252;5408.594355423359;5432.70120143392;5802.738876750556;5824.417558244184;5847.152162936393;5861.238039054895;5878.764849406019;5774.740136693817;5826.883462330729;5829.09649004405;5830.242068531106;5838.795642152504;5306.62853600252;5383.946160538345;5443.618946673774;5448.237246785453;5457.590680698924;5924.822255332347;6039.063945088518;6061.242344706911;6079.756809727562;6080.331163572004;5634.070378387602;5659.688717120515;5726.513246374022;5746.741396637161;5753.712314384264;5694.886102278014;5737.082066869364;5743.54051675865;5765.250517432707;5795.768169273266;5633.859153521113;5714.0571805652435;5717.056685646905;5724.513416359656;5734.913976290359;5684;5801.042827933428;5832.270966129234;5834.299884013945;5846.152307915413;4852.902941941142;4853.587445067209;4862.902741945141;4863.197572400514;4905.950940490549;4055.8174882129783;4121.814518346681;4163.708540402143;4172.040430700895;4196.076863090116;4864.756762161877;4890.095332363524;4976.154053810861;4982.227754698028;4983;5930.525557955353;5931.58478906481;5940;5966.194563733927;5987.670678112659;4964.081644895706;4988.700677959334;4990.932390102055;4999.400071991385;5005.998800239967;5068.6451948363265;5239.973800131052;5252.317198764136;5257.211418287287;5274.129768588216;5318.680879147263;5335.199720042025;5373.6238463308755;5380;5397.8380648580605;5676.716164191691;5678.943210568007;5719.142128680731;5720.513756330592;5720.513756330759;5322.175062865262;5361.812336568201;5363.463653634762;5385.46145385474;5385.892282154413;5655.1517272409465;5683.715814209356;5684.005299072563;5695.117256825199;5696.914546281726;5795.82612521625;5796.304443466811;5798.884022319615;5801.129830525455;5812.680302583399;5560.916586251128;5601.831945041656;5678.517326027334;5740.885182296247;5770.769169233184;5690.459406356389;5698.287714035746;5708.743106560298;5713.742881570256;5723.6851973141875;5560.860978475571;5589.329280486368;5628.409017053151;5643.661380317194;5650.350209725934;5572.4148964358155;5592.7203639817035;5643.915341269802;5658.236138121301;5667.659940403589;5495;5500.367457742411;5585.916211256916;5602.66384016944;5632.971835140798 14:57:02 INFO - PID 6051 | |1;ext.html;689.07663730601;715.2204097533689;1048.6801525534713;1071.3625392891227;1133.2067552713092;30519.54220686689;33824.4926326105;33902;33983.15042123948;34119.82940085296;31646.208844778834;31897;32052.519212211835;32066.519002214925;32068;6421;6487.156669632953;6576.539642225046;6601.339866013384;6610.8677826443445;7033;7074.82312942178;7124.323189297009;7142.25006374331;7147.249538798429;7099;7111.146662400519;7129.215786263507;7171.677274522659;7178.066851309322;7113.435044290248;7129;7137.536060156125;7144.142702875636;7145.7141714331365;6971.407430368425;7017.719291228344;7024.719011239545;7038.416356319838;7045.436365090781;32443.837780810944;32827;33130.337393252;33139.171520711934;33141.6685833141;3087.6294844618565;3098.055093196574;3102.612173478315;3120.937581248385;3135.0751528299206;25221.495570088497;25246;25292.367690807692;25387.61918571223;25407.364815879566;2713;2743.43759529296;2763.019128209497;2766.39139389334;2776.986115069412;146491;147256;148225;148495;149063;39880;42411.57588424076;42876.78561607172;42958.35562466565;43052.569474305485;43700.56299437029;43746;43966.90082747893;44198.55801442009;44316.778416107714;11341.376224307742;11414.771704565863;11465.197436179387;11467;11529.48117334722;8834.160754728291;8864.64541418349;8890.86663700045;8901.243394311556;8911.15344042315;13075.150115242479;13196.802047969288;13256.801147982787;13324.400401981935;13457.730845383037;5282.471752824764;5307.708076055854;5350.785968561292;5402.243685883979;5409.377921538995;875.4134729731095;891.9063498332712;928.8931772846074;942.9198518125899;959.2613687460756;22405.96692595316;22493;22528.549429011327;22586.548269034527;22895;987.3779518903045;996.6511720897628;998.0967224661692;1011.9595216191417;1019.7654539455966;11011;11589.072874170046;11794;11839.881601183877;11931.940340298243;175455;176197;176761;176994;177375;43578.12843743107;43739.34390984138;43743.12513749771;43747.56252437498;43815.78092109583;1183.9973207381909;1232.7472868062025;1237.6287113865803;1239.578543295284;1241.2242348531986;20414.38756837297;21383.144674212857;22102.668459973436;22118.557628847655;22387.552248954606;28995.565066523595;29172.854135730035;29248.26879328034;29303.560446592892;29325.26686832846;147454;147580;147815.2609236947;148003.2599836994;148611.2569437189;30815.383692326475;30908;31861.36277274488;32685.836570816995;32707.672923271413;38260.426093609174;38471.230575388894;38491.037724056005;38622.6137738619;38632.42051369175;27027;29049.854750726958;29101;29702.554461683525;30538.847305763327;28970.27574310659;29072.854635726686;29246.853765731033;29316.70683293225;29923.850380747957;32901.83549082239;32963.175920602174;32992;33068.83465582657;33103.83448082744;27729;27763.02829400961;28625.856870715514;28960.13119606415;29336;22689.659655105515;22871.542569148856;23237.3028809136;23736.881315593313;23896 14:57:02 INFO - PID 6051 | |2;jquery.html;425.3449687481279;427.1435771278586;428.59069588542945;434.73263942675254;439.8856297362687;16624.750628740578;17085.914570427147;17669.057630472405;17709.114544272798;17880.195391207395;18339.724904126448;18573.53566160847;19205;19820.40538783839;19830.206791728313;5425.647332923367;5502.752376143063;5534.169874518814;5558.055130627803;5566.693831839248;5599.944000559983;5694.373618901917;5696.515796157331;5706.77172913083;5726.62776919501;5444.972775136119;5472.425395333493;5484.424135465779;5492.972535137319;5499.4225606311165;5415.48552887475;5492.615516913837;5493.368262649807;5501.0648189807425;5533.972330138344;4948.604111671058;5113.156329205676;5114.667546609458;5119.488051194888;5126.538611524943;20490.282840100524;20999.160033598637;22334;22415.551688966294;22663.546729065325;1593.2591345024503;1601.991990040054;1617.5066604685567;1623.5048310265365;1637.435084895709;14788.40846366144;14887.702245955128;15361.385544578203;15403.22983850803;15570.29933652977;2100.380387785607;2140.77521860204;2163.9567208655894;2165.761766205716;2193.616117179487;88365;91021.54489227578;91729.54135229281;91912;92691;11025.196307273978;11315;11367.545298188144;11467.598634047936;11572.36352000648;15985.200739962955;15985.280662369989;16039.759403608956;16044;16046.27791749374;7156.928430715626;7315.926840731631;7446.218147094477;7507.809181098011;7521.7743467696055;6479.125318082093;6485.67571621417;6507.381798729113;6706.932930670729;6717.596944183365;7104.502684812117;7174.856502869913;7222.383771075961;7290.872548340157;7338.608414884453;2076.9376918692465;2077.574097310048;2091.550316681921;2108.525581744126;2261.8755968421565;859.6647307550061;890.1454603580506;901.1889299630254;905.3526728389234;921.6451666108462;16980.235889385007;17261.72027314806;17698.734518982226;17725.822741772416;18171.364002259856;870.2907130688469;875.4397185801092;882.3602887906217;895.7402353317595;903.1826197291462;9330.720078397659;9379.859302110473;9673.70978870635;9716.125548700651;9736.90656508854;339068;340935;343198;345853;350686.42449330556;77709.61145194237;78342;78471.2152878464;80107.19892800998;80767;1027.275770581738;1031.504877658728;1047.2407504559285;1053.2837670384213;1058.169337070396;14587;15075.773863391838;15112.09327440357;15147.924260378628;15472.303746331218;36581;36983.63016369802;37356.62643373531;37852;38721.2255754889;47630.52369476399;47902.760486197345;48076.75961620169;48168.518314817804;49330.50669493259;8115.959420202861;8151.918480815116;8161.591920404075;8213.383996200428;8570.842936203782;12552.309622970459;12684.556040538537;12695.55565555201;13020.153690010118;13086.476540938256;10722.89277107219;10954.397508137128;11119.388433636228;11311.7737645245;11379.089672825989;10413.843792343272;10563.260571759904;10564.894351056391;10565.683029509128;10641.627543035956;10683.679489615324;10899.346039237671;11132.499037543168;11306.49120789583;11393.259438136494;8126.187381261827;8205.384596155433;8206.753797386087;8262.256396924306;8374.65509657297;11114.722131946766;11580.594679186188;11606.30362178272;11677.007454366134;12086.818697719365 14:57:02 INFO - PID 6051 | |3;mootools.html;1240.8014717645176;1310.10912579446;1311.0756916373957;1316.0918965913513;1321.828162338897;9207.539623018847;9441.103095205961;9650.662226822064;9661.951690241547;10044;9704.757381065478;9841.114299713025;9878.851817222747;9900.405975641448;9915.702528924126;2225.098834971839;2255.109231853425;2261.819054475638;2269.092363054775;2273.3975496493445;2183.355910006544;2236.2173239366252;2238.0488292475716;2242.9887850560726;2251.212075773474;1987.7912819153998;1999.8300144487737;2026.503506640875;2030.2691031228746;2040.5000774810192;1972.8224459798614;1975.8320542753884;1982.4250967219489;1988.8309493693052;1992.1832048860042;1862.5995410986702;1875.409246087478;1923.7210604462414;1943.9902800486047;2141.5716856628583;9778.07108324715;9836.557354918974;9844.36011659247;9862.852057219148;9874.111329980264;5510.889782204334;5724.856878578027;5740.741666625012;5751.597388182829;5755.568332375088;3297.8141133426448;3333.1333853198103;3356.412627790127;3443.0531603808904;3462.982685086584;1036.19694736579;1074.3929679730927;1081.7403823082482;1105.3975583307117;1111.0889070961814;13834.515791947233;13845.376958036912;13918.234497102554;13952.093113947662;13980.440782368692;4550.522195169526;4653.302004699322;4849.030193961151;4875.366202393666;4934.111859865258;9887;9927.40435573868;9928.404295742279;9976.950115249523;9997.200223982063;5437.537809286255;5483.561315094783;5492.615516913777;5497.312835895513;5512.972435137799;4840.443349014838;4972.5276098770555;5043.697378157322;5134.666246693953;5199.766010529535;3763.303788799081;3809.7523660961947;3894.2406230784727;3929.548101968253;3936.2127574485216;1074.699084256394;1085.5766251162054;1108.2630051016145;1109.4341885638382;1113.7661091170783;725.3906718356606;754.1628792040831;760.0840986611121;766.2835249042164;767.6277005652254;5656.547476201894;5724.885502289931;5795.275590551181;5849.093390524476;5864.44287792659;844.8352571248671;846.4498076250486;871.0897112517434;873.0352959979258;877.2718643525858;3922.764634121962;4009.699272554512;4064;4086.346184610448;4095.4266402703647;12053.819192712117;12625;12779;12804.231746095264;12837.679058023437;11891.821622675667;12665.240085594894;12681.653894029634;12714.046446516548;12731.61805145847;7128.501004929709;7329.486935914435;7334.48658593904;7342.559446433231;7359.190489046201;5949.910751338647;6161.815145545641;6251.6561589113035;6280.313270255206;6441.452476539546;10750.46247687628;11118.444077795915;11233.775324493628;11383.829242561535;11472.598459053894;11491.425428728362;11500.884991149982;11513.251638643462;11613.593524226611;11636.06911447099;7857.489263197874;8112.18878112184;8184.468009579358;8201.26188643025;8204.876926845982;9199.908000919904;9260.768480788034;9272.629094836131;9285.117913798178;9294.209992150472;7908.920910790818;7933.8413231736195;8136.87794683092;8177.836443271221;8278.420510564203;7841.098273698598;7869.370450363843;7877.330426913776;7976.880346794686;8092.150324215872;7264.963675181591;7349.816254593464;7358.264173582599;7373.9262607375385;7390.076240469942;4735.171345014677;5218.452062533379;5236.109861323508;5331.626786124934;5534.308211473566;5480.753366098615;5490.121580547093;5517.779288828402;5547.44525547442;5647.237622920853 14:57:02 INFO - PID 6051 | |4;prototype.html;352.6508756331233;385.72227995842985;386.7949986507151;390.4358202397537;396.7778044295195;5481.588880833943;5621.8475212581425;5698.430156984305;5702.429757024295;5711.485966263041;5377.462253774621;5555.055640541108;5561.360443548983;5561.833145005646;5596.944030559694;4409.625181859546;4424.402705634747;4427.358033085201;4431.88920276994;4445.911081778362;4055.290324193269;4181.644560212386;4222.451081359419;4412.58797184901;4452.820002699271;4123.402106694542;4124.731892426983;4134.979325103385;4138.33786594145;4139.151473947833;4151.107511884929;4165.458490396244;4171.499420069611;4174.749515029092;4193.287141186006;3532.6643968823178;3629.201575653352;3652.068722475778;3666.1934374437583;3667.991302391837;5435.402105768362;5441.29263195782;5454.563634909197;5464.535514481234;5492.450754924515;4943;4943.950560494385;4960.801567937278;4968.577670897978;4983.700977941335;5801.390853960358;5892.733062391563;5916.674582897939;5938.287405511366;5938.940610593882;4112.321466957948;4114.794260286973;4118.629323360882;4120.340745480738;4121.361189015707;6046.788362407295;6230.937690623126;6276.403741644536;6291.779787707408;6360.9045864312075;4138.8551400700835;4180.352045432963;4184.267753143188;4188.81150348235;4195.370694395804;4225.007123326016;4233.5131459881895;4234.216669916075;4236.5763423658;4250.53244143144;4772;4840.394950631171;4885.193942999436;4902.534259245366;4904.253617973946;5894.705264736746;5908.172855800191;5916.1421593868645;5921.7631294747725;5926.67403292823;1425.950091746784;1472.234438092186;1472.49935022093;1473.4327283995524;1477.5788900163402;939.9765005874908;957.2581249531669;976.5215044628223;980.07872599756;1006.808706345792;5133.820316288987;5137.974310128426;5152.793888244429;5156.716380599028;5169.147090730063;6143.0105646993825;6146;6157.6613286269685;6159.4456498915315;6159.84600384994;4944.678595891256;5084.1102807009365;5091.701616087874;5169.327987361619;5190.55880250183;3252.9837350813095;3278.5246139310143;3282.622498412665;3290.901272961815;3298.0376675877815;5532.197831314517;5667.489925906688;5694.202811606378;5713.5714821388565;5753.913691294634;6227.377262273736;6278.537672225102;6340;6353.523485738496;6365.936340636535;5734.340550836624;5737.971310143423;5753.33836608787;5758.424157584208;5762.394948530427;5975.25309336333;6131.724072416663;6196.318404975359;6206.441420272197;6212.409821066992;5907.763689452374;6061.484773794277;6071.848203794941;6077.56058327803;6107.4197951194565;5701.201831743642;5754.273717884535;5758.3090029196765;5772.528005358607;5788.623739456922;4166.1251137261515;4178.7283826551175;4188.41362209297;4200.306949353322;4201.810918508613;6068.9089663654195;6178.135061091541;6208.875822483616;6210.503159747119;6244.875102498016;5945.840561090546;5982.611130276518;6001;6005.90991135142;6028.57799953999;5858.5898987070495;5938.851528711817;5942.554308426799;5956.374580668968;5977.3424923257535;5842.415758424124;5905.793297234748;5915.752014234563;5940.732667030081;5946.13781001761;6045.304789949212;6060.545459090674;6077.665728384804;6079.148919151234;6081.361457047124;5632.971835140798;5796.710164491843;5813.128030795415;5833.854153646193;5865.120231965239 14:57:02 INFO - PID 6051 | |5;yui.html;755.1655420760063;775.78278082137;776.5418403142148;787.3307688464805;791.9841603167937;11913.821292680595;12348.01215902728;13686.726265474685;14221;14237.857621423796;14723.411063557445;14904;15219.84780152198;15232.619184520392;15297.617559561017;839.2949922065463;861.3539845116163;863.8704194370832;869.9956500217522;871.7820544863785;912.885889263842;915.1900567997304;918.4948278446861;918.5590916360151;918.6463211663524;956.6651671914843;959.9952000239989;966.7196513011219;967.1344146988476;969.743018100204;946.9053094690545;947.6920000999703;947.7772723409993;948.7912659214961;951.1534734086669;702.5047341624143;706.6396137969673;707.0949185043153;707.3527722134241;709.0888208651909;15069.246537673182;15174.848251517564;15192.544223673198;15380.538583842503;15494.845051549453;15247;15437.768433473395;15485.14831684257;15618.609534761608;15759.763603545956;12475.438605262785;12588.496460141583;12670.873291267062;12745.936270318682;12895.29075900825;2687.852168130752;2702.797290203223;2708.471847989643;2709.2143278449225;2718.877650505732;65218.3478165217;65924.3407565923;66042;66361;67142.30717310547;10251.58993640261;10307.896921030844;10501.842472362921;10558.577656893793;10632.202584806017;17984.910075449538;18022.3692170776;18115.094245287684;18157.09214539268;18178.18198181085;5956.136360227742;6168.475679567197;6485.124508191334;6538.051982462612;6539.215294164731;2968.5992391027366;3009.623797025372;3037.9392412151633;3038.255627371308;3041.7718671099756;3371.4942758585917;3423.606285277225;3428.502867084259;3439.9656003439645;3478.982605087009;720.2545365546634;722.37514549915;726.0525014855664;727.0838743183521;729.9087614048244;546.8496163554975;597.6175247841385;600.0848705723719;604.3684349854412;615.1326629452451;9912.405255684538;10014.949925250472;10148.746281343025;10418.374897506174;10709;594.8810237952426;600.1747597054051;609.2110716621985;616.3959319866556;623.9953674583916;4572.634189264851;4610.861674149781;4792.412097467329;4837.201861692852;4991.450940396553;61782.38217617856;63296.683516582125;63339;64622.67688661621;65369.673151633935;54050;55686.72156639191;55866.44133558694;56651.15023274654;57129;50524.74737626362;51730.224046639334;52697.47302526925;53466.73266633642;54325.72837135789;9427.952860235655;9709.6601618943;9767.951160244153;10146.797064058825;10160.847587286344;26587.081389942923;26693.332666682712;27012.72987270102;27671.446571068867;28036.85981570079;32302;32516;32524.674753252166;32555;33213.50179747257;12400.441980110736;12548.556915954417;12575.119741618364;12712.491500340253;12713.80929286043;13377.598672039854;13842.792358114435;13937.651558711113;13976.231307278198;13978.790318145033;12792.296423696785;12812.295323757282;12880.227186368847;13009.609711708665;13112;12430.254184748945;12449;12759.808602870778;12803.80794288105;12947.158434701714;12412.875871241533;12424.192427492184;12540.561080362144;12562.748745024866;12621;8342.16578342161;8398.286145677686;8680.262177714965;8730.730010197267;8848;10600.522976465923;10712.839307410239;10785.298955567863;10900.07349375312;10946.616868409568 14:57:02 INFO - PID 6051 | __end_tp_report 14:57:02 INFO - PID 6051 | __start_cc_report 14:57:02 INFO - PID 6051 | _x_x_mozilla_cycle_collect,388 14:57:02 INFO - PID 6051 | __end_cc_report 14:57:02 INFO - PID 6051 | __startTimestamp1494021422539__endTimestamp 14:57:02 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | ------- Summary: start ------- 14:57:02 INFO - PID 6051 | Number of tests: 6 14:57:02 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | [#0] dojo.html Cycles:165 Average:5302.61 Median:5457.40 stddev:634.94 (11.6%) stddev-sans-first:604.04 14:57:02 INFO - PID 6051 | Values: 2732.8 2733.3 2743.6 2763.3 2778.8 5297.4 5332.8 5349.9 5376.3 5423.6 5330.5 5372.2 5398.6 5457.4 5494.3 4489.9 4743.1 4750.3 4777.3 4779.3 4782.0 4793.1 4834.9 4851.5 4862.2 4652.8 4709.6 4711.5 4770.3 4791.4 4784.1 4796.4 4808.1 4832.6 4861.2 4738.0 4778.3 4780.8 4798.2 4812.8 5253.3 5257.7 5370.8 5408.6 5432.7 5802.7 5824.4 5847.2 5861.2 5878.8 5774.7 5826.9 5829.1 5830.2 5838.8 5306.6 5383.9 5443.6 5448.2 5457.6 5924.8 6039.1 6061.2 6079.8 6080.3 5634.1 5659.7 5726.5 5746.7 5753.7 5694.9 5737.1 5743.5 5765.3 5795.8 5633.9 5714.1 5717.1 5724.5 5734.9 5684.0 5801.0 5832.3 5834.3 5846.2 4852.9 4853.6 4862.9 4863.2 4906.0 4055.8 4121.8 4163.7 4172.0 4196.1 4864.8 4890.1 4976.2 4982.2 4983.0 5930.5 5931.6 5940.0 5966.2 5987.7 4964.1 4988.7 4990.9 4999.4 5006.0 5068.6 5240.0 5252.3 5257.2 5274.1 5318.7 5335.2 5373.6 5380.0 5397.8 5676.7 5678.9 5719.1 5720.5 5720.5 5322.2 5361.8 5363.5 5385.5 5385.9 5655.2 5683.7 5684.0 5695.1 5696.9 5795.8 5796.3 5798.9 5801.1 5812.7 5560.9 5601.8 5678.5 5740.9 5770.8 5690.5 5698.3 5708.7 5713.7 5723.7 5560.9 5589.3 5628.4 5643.7 5650.4 5572.4 5592.7 5643.9 5658.2 5667.7 5495.0 5500.4 5585.9 5602.7 5633.0 14:57:02 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | [#1] ext.html Cycles:180 Average:30781.68 Median:3111.77 stddev:40799.00 (1311.1%) stddev-sans-first:40850.88 14:57:02 INFO - PID 6051 | Values: 689.1 715.2 1048.7 1071.4 1133.2 30519.5 33824.5 33902.0 33983.2 34119.8 31646.2 31897.0 32052.5 32066.5 32068.0 6421.0 6487.2 6576.5 6601.3 6610.9 7033.0 7074.8 7124.3 7142.3 7147.2 7099.0 7111.1 7129.2 7171.7 7178.1 7113.4 7129.0 7137.5 7144.1 7145.7 6971.4 7017.7 7024.7 7038.4 7045.4 32443.8 32827.0 33130.3 33139.2 33141.7 3087.6 3098.1 3102.6 3120.9 3135.1 25221.5 25246.0 25292.4 25387.6 25407.4 2713.0 2743.4 2763.0 2766.4 2777.0 146491.0 147256.0 148225.0 148495.0 149063.0 39880.0 42411.6 42876.8 42958.4 43052.6 43700.6 43746.0 43966.9 44198.6 44316.8 11341.4 11414.8 11465.2 11467.0 11529.5 8834.2 8864.6 8890.9 8901.2 8911.2 13075.2 13196.8 13256.8 13324.4 13457.7 5282.5 5307.7 5350.8 5402.2 5409.4 875.4 891.9 928.9 942.9 959.3 22406.0 22493.0 22528.5 22586.5 22895.0 987.4 996.7 998.1 1012.0 1019.8 11011.0 11589.1 11794.0 11839.9 11931.9 175455.0 176197.0 176761.0 176994.0 177375.0 43578.1 43739.3 43743.1 43747.6 43815.8 1184.0 1232.7 1237.6 1239.6 1241.2 20414.4 21383.1 22102.7 22118.6 22387.6 28995.6 29172.9 29248.3 29303.6 29325.3 147454.0 147580.0 147815.3 148003.3 148611.3 30815.4 30908.0 31861.4 32685.8 32707.7 38260.4 38471.2 38491.0 38622.6 38632.4 27027.0 29049.9 29101.0 29702.6 30538.8 28970.3 29072.9 29246.9 29316.7 29923.9 32901.8 32963.2 32992.0 33068.8 33103.8 27729.0 27763.0 28625.9 28960.1 29336.0 22689.7 22871.5 23237.3 23736.9 23896.0 14:57:02 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | [#2] jquery.html Cycles:180 Average:24284.17 Median:36782.32 stddev:57625.01 (156.7%) stddev-sans-first:57758.82 14:57:02 INFO - PID 6051 | Values: 425.3 427.1 428.6 434.7 439.9 16624.8 17085.9 17669.1 17709.1 17880.2 18339.7 18573.5 19205.0 19820.4 19830.2 5425.6 5502.8 5534.2 5558.1 5566.7 5599.9 5694.4 5696.5 5706.8 5726.6 5445.0 5472.4 5484.4 5493.0 5499.4 5415.5 5492.6 5493.4 5501.1 5534.0 4948.6 5113.2 5114.7 5119.5 5126.5 20490.3 20999.2 22334.0 22415.6 22663.5 1593.3 1602.0 1617.5 1623.5 1637.4 14788.4 14887.7 15361.4 15403.2 15570.3 2100.4 2140.8 2164.0 2165.8 2193.6 88365.0 91021.5 91729.5 91912.0 92691.0 11025.2 11315.0 11367.5 11467.6 11572.4 15985.2 15985.3 16039.8 16044.0 16046.3 7156.9 7315.9 7446.2 7507.8 7521.8 6479.1 6485.7 6507.4 6706.9 6717.6 7104.5 7174.9 7222.4 7290.9 7338.6 2076.9 2077.6 2091.6 2108.5 2261.9 859.7 890.1 901.2 905.4 921.6 16980.2 17261.7 17698.7 17725.8 18171.4 870.3 875.4 882.4 895.7 903.2 9330.7 9379.9 9673.7 9716.1 9736.9 339068.0 340935.0 343198.0 345853.0 350686.4 77709.6 78342.0 78471.2 80107.2 80767.0 1027.3 1031.5 1047.2 1053.3 1058.2 14587.0 15075.8 15112.1 15147.9 15472.3 36581.0 36983.6 37356.6 37852.0 38721.2 47630.5 47902.8 48076.8 48168.5 49330.5 8116.0 8151.9 8161.6 8213.4 8570.8 12552.3 12684.6 12695.6 13020.2 13086.5 10722.9 10954.4 11119.4 11311.8 11379.1 10413.8 10563.3 10564.9 10565.7 10641.6 10683.7 10899.3 11132.5 11306.5 11393.3 8126.2 8205.4 8206.8 8262.3 8374.7 11114.7 11580.6 11606.3 11677.0 12086.8 14:57:02 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | [#3] mootools.html Cycles:180 Average:6100.74 Median:5167.22 stddev:3780.48 (73.2%) stddev-sans-first:3773.44 14:57:02 INFO - PID 6051 | Values: 1240.8 1310.1 1311.1 1316.1 1321.8 9207.5 9441.1 9650.7 9662.0 10044.0 9704.8 9841.1 9878.9 9900.4 9915.7 2225.1 2255.1 2261.8 2269.1 2273.4 2183.4 2236.2 2238.0 2243.0 2251.2 1987.8 1999.8 2026.5 2030.3 2040.5 1972.8 1975.8 1982.4 1988.8 1992.2 1862.6 1875.4 1923.7 1944.0 2141.6 9778.1 9836.6 9844.4 9862.9 9874.1 5510.9 5724.9 5740.7 5751.6 5755.6 3297.8 3333.1 3356.4 3443.1 3463.0 1036.2 1074.4 1081.7 1105.4 1111.1 13834.5 13845.4 13918.2 13952.1 13980.4 4550.5 4653.3 4849.0 4875.4 4934.1 9887.0 9927.4 9928.4 9977.0 9997.2 5437.5 5483.6 5492.6 5497.3 5513.0 4840.4 4972.5 5043.7 5134.7 5199.8 3763.3 3809.8 3894.2 3929.5 3936.2 1074.7 1085.6 1108.3 1109.4 1113.8 725.4 754.2 760.1 766.3 767.6 5656.5 5724.9 5795.3 5849.1 5864.4 844.8 846.4 871.1 873.0 877.3 3922.8 4009.7 4064.0 4086.3 4095.4 12053.8 12625.0 12779.0 12804.2 12837.7 11891.8 12665.2 12681.7 12714.0 12731.6 7128.5 7329.5 7334.5 7342.6 7359.2 5949.9 6161.8 6251.7 6280.3 6441.5 10750.5 11118.4 11233.8 11383.8 11472.6 11491.4 11500.9 11513.3 11613.6 11636.1 7857.5 8112.2 8184.5 8201.3 8204.9 9199.9 9260.8 9272.6 9285.1 9294.2 7908.9 7933.8 8136.9 8177.8 8278.4 7841.1 7869.4 7877.3 7976.9 8092.2 7265.0 7349.8 7358.3 7373.9 7390.1 4735.2 5218.5 5236.1 5331.6 5534.3 5480.8 5490.1 5517.8 5547.4 5647.2 14:57:02 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | [#4] prototype.html Cycles:180 Average:4886.22 Median:5561.60 stddev:1462.29 (26.3%) stddev-sans-first:1426.25 14:57:02 INFO - PID 6051 | Values: 352.7 385.7 386.8 390.4 396.8 5481.6 5621.8 5698.4 5702.4 5711.5 5377.5 5555.1 5561.4 5561.8 5596.9 4409.6 4424.4 4427.4 4431.9 4445.9 4055.3 4181.6 4222.5 4412.6 4452.8 4123.4 4124.7 4135.0 4138.3 4139.2 4151.1 4165.5 4171.5 4174.7 4193.3 3532.7 3629.2 3652.1 3666.2 3668.0 5435.4 5441.3 5454.6 5464.5 5492.5 4943.0 4944.0 4960.8 4968.6 4983.7 5801.4 5892.7 5916.7 5938.3 5938.9 4112.3 4114.8 4118.6 4120.3 4121.4 6046.8 6230.9 6276.4 6291.8 6360.9 4138.9 4180.4 4184.3 4188.8 4195.4 4225.0 4233.5 4234.2 4236.6 4250.5 4772.0 4840.4 4885.2 4902.5 4904.3 5894.7 5908.2 5916.1 5921.8 5926.7 1426.0 1472.2 1472.5 1473.4 1477.6 940.0 957.3 976.5 980.1 1006.8 5133.8 5138.0 5152.8 5156.7 5169.1 6143.0 6146.0 6157.7 6159.4 6159.8 4944.7 5084.1 5091.7 5169.3 5190.6 3253.0 3278.5 3282.6 3290.9 3298.0 5532.2 5667.5 5694.2 5713.6 5753.9 6227.4 6278.5 6340.0 6353.5 6365.9 5734.3 5738.0 5753.3 5758.4 5762.4 5975.3 6131.7 6196.3 6206.4 6212.4 5907.8 6061.5 6071.8 6077.6 6107.4 5701.2 5754.3 5758.3 5772.5 5788.6 4166.1 4178.7 4188.4 4200.3 4201.8 6068.9 6178.1 6208.9 6210.5 6244.9 5945.8 5982.6 6001.0 6005.9 6028.6 5858.6 5938.9 5942.6 5956.4 5977.3 5842.4 5905.8 5915.8 5940.7 5946.1 6045.3 6060.5 6077.7 6079.1 6081.4 5633.0 5796.7 5813.1 5833.9 5865.1 14:57:02 INFO - PID 6051 | 14:57:02 INFO - PID 6051 | [#5] yui.html Cycles:180 Average:14715.65 Median:18292.50 stddev:17628.38 (96.4%) stddev-sans-first:17646.66 14:57:02 INFO - PID 6051 | Values: 755.2 775.8 776.5 787.3 792.0 11913.8 12348.0 13686.7 14221.0 14237.9 14723.4 14904.0 15219.8 15232.6 15297.6 839.3 861.4 863.9 870.0 871.8 912.9 915.2 918.5 918.6 918.6 956.7 960.0 966.7 967.1 969.7 946.9 947.7 947.8 948.8 951.2 702.5 706.6 707.1 707.4 709.1 15069.2 15174.8 15192.5 15380.5 15494.8 15247.0 15437.8 15485.1 15618.6 15759.8 12475.4 12588.5 12670.9 12745.9 12895.3 2687.9 2702.8 2708.5 2709.2 2718.9 65218.3 65924.3 66042.0 66361.0 67142.3 10251.6 10307.9 10501.8 10558.6 10632.2 17984.9 18022.4 18115.1 18157.1 18178.2 5956.1 6168.5 6485.1 6538.1 6539.2 2968.6 3009.6 3037.9 3038.3 3041.8 3371.5 3423.6 3428.5 3440.0 3479.0 720.3 722.4 726.1 727.1 729.9 546.8 597.6 600.1 604.4 615.1 9912.4 10014.9 10148.7 10418.4 10709.0 594.9 600.2 609.2 616.4 624.0 4572.6 4610.9 4792.4 4837.2 4991.5 61782.4 63296.7 63339.0 64622.7 65369.7 54050.0 55686.7 55866.4 56651.2 57129.0 50524.7 51730.2 52697.5 53466.7 54325.7 9428.0 9709.7 9768.0 10146.8 10160.8 26587.1 26693.3 27012.7 27671.4 28036.9 32302.0 32516.0 32524.7 32555.0 33213.5 12400.4 12548.6 12575.1 12712.5 12713.8 13377.6 13842.8 13937.7 13976.2 13978.8 12792.3 12812.3 12880.2 13009.6 13112.0 12430.3 12449.0 12759.8 12803.8 12947.2 12412.9 12424.2 12540.6 12562.7 12621.0 8342.2 8398.3 8680.3 8730.7 8848.0 10600.5 10712.8 10785.3 10900.1 10946.6 14:57:02 INFO - PID 6051 | -------- Summary: end -------- 14:57:02 INFO - PID 6051 | 14:57:03 INFO - TEST-INFO | 6051: exit 0 14:57:03 INFO - TEST-OK | dromaeo_css | took 1120927ms 14:57:03 INFO - TEST-START | kraken 14:57:03 INFO - operating with platform_type : linux_ 14:57:03 INFO - Initialising browser for kraken test... 14:57:03 INFO - TEST-INFO | started process 6470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj55quO/profile http://localhost:54350/getInfo.html) 14:57:07 INFO - PID 6470 | __metrics Screen width/height:1600/1200 14:57:07 INFO - PID 6470 | colorDepth:24 14:57:07 INFO - PID 6470 | Browser inner width/height: 1024/695 14:57:07 INFO - PID 6470 | __metrics 14:57:09 INFO - TEST-INFO | 6470: exit 0 14:57:09 INFO - Browser initialized. 14:57:09 INFO - Running cycle 1/1 for kraken test... 14:57:09 INFO - TEST-INFO | started process 6639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj55quO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:22 INFO - PID 6639 | RSS: Main: 179519488 14:57:22 INFO - PID 6639 | 14:57:24 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54350/tests/kraken/driver.html?testName=audio-beat-detection) 14:57:25 INFO - PID 6639 | RSS: Main: 182104064 14:57:25 INFO - PID 6639 | 14:57:28 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54350/tests/kraken/driver.html?testName=audio-dft) 14:57:29 INFO - PID 6639 | RSS: Main: 180772864 14:57:29 INFO - PID 6639 | 14:57:32 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54350/tests/kraken/driver.html?testName=audio-fft) 14:57:32 INFO - PID 6639 | RSS: Main: 171409408 14:57:32 INFO - PID 6639 | 14:57:34 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54350/tests/kraken/driver.html?testName=audio-oscillator) 14:57:35 INFO - PID 6639 | RSS: Main: 173219840 14:57:35 INFO - PID 6639 | 14:57:37 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:57:38 INFO - PID 6639 | RSS: Main: 173961216 14:57:38 INFO - PID 6639 | 14:57:41 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54350/tests/kraken/driver.html?testName=imaging-darkroom) 14:57:42 INFO - PID 6639 | RSS: Main: 178327552 14:57:42 INFO - PID 6639 | 14:57:45 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54350/tests/kraken/driver.html?testName=imaging-desaturate) 14:57:46 INFO - PID 6639 | RSS: Main: 174874624 14:57:46 INFO - PID 6639 | 14:57:49 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54350/tests/kraken/driver.html?testName=json-parse-financial) 14:57:50 INFO - PID 6639 | RSS: Main: 177799168 14:57:50 INFO - PID 6639 | 14:57:51 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:57:52 INFO - PID 6639 | RSS: Main: 178434048 14:57:52 INFO - PID 6639 | 14:57:54 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54350/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:57:54 INFO - PID 6639 | RSS: Main: 178601984 14:57:54 INFO - PID 6639 | 14:57:56 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:57:57 INFO - PID 6639 | RSS: Main: 178774016 14:57:57 INFO - PID 6639 | 14:58:00 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:58:01 INFO - PID 6639 | RSS: Main: 178937856 14:58:01 INFO - PID 6639 | 14:58:04 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:58:05 INFO - PID 6639 | RSS: Main: 178630656 14:58:05 INFO - PID 6639 | 14:58:06 INFO - PID 6639 | Cycle 1(1): loaded http://localhost:54350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54350/tests/kraken/driver.html?testName=ai-astar) 14:58:07 INFO - PID 6639 | RSS: Main: 181350400 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | __start_tp_report 14:58:07 INFO - PID 6639 | _x_x_mozilla_page_load 14:58:07 INFO - PID 6639 | _x_x_mozilla_page_load_details 14:58:07 INFO - PID 6639 | |i|pagename|runs| 14:58:07 INFO - PID 6639 | |0;ai-astar;104;111;112;112;112;113;113;112;112;112 14:58:07 INFO - PID 6639 | |1;audio-beat-detection;155;125;124;174;128;123;124;123;149;122 14:58:07 INFO - PID 6639 | |2;audio-dft;167;168;169;168;174;167;163;164;163;164 14:58:07 INFO - PID 6639 | |3;audio-fft;75;76;75;101;76;74;75;77;96;77 14:58:07 INFO - PID 6639 | |4;audio-oscillator;84;86;109;85;83;84;100;84;83;104 14:58:07 INFO - PID 6639 | |5;imaging-gaussian-blur;115;114;114;114;115;115;114;114;114;115 14:58:07 INFO - PID 6639 | |6;imaging-darkroom;151;150;151;149;152;151;150;152;150;151 14:58:07 INFO - PID 6639 | |7;imaging-desaturate;95;95;95;97;94;95;94;96;94;95 14:58:07 INFO - PID 6639 | |8;json-parse-financial;56;55;55;54;55;56;55;57;55;55 14:58:07 INFO - PID 6639 | |9;json-stringify-tinderbox;56;56;57;57;56;57;57;56;56;56 14:58:07 INFO - PID 6639 | |10;stanford-crypto-aes;82;83;81;80;82;82;81;83;80;80 14:58:07 INFO - PID 6639 | |11;stanford-crypto-ccm;139;138;138;132;131;135;130;150;184;133 14:58:07 INFO - PID 6639 | |12;stanford-crypto-pbkdf2;185;200;190;188;190;185;196;190;188;198 14:58:07 INFO - PID 6639 | |13;stanford-crypto-sha256-iterative;74;72;71;71;74;71;70;71;69;71 14:58:07 INFO - PID 6639 | __end_tp_report 14:58:07 INFO - PID 6639 | __start_cc_report 14:58:07 INFO - PID 6639 | _x_x_mozilla_cycle_collect,954 14:58:07 INFO - PID 6639 | __end_cc_report 14:58:07 INFO - PID 6639 | __startTimestamp1494021487150__endTimestamp 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | ------- Summary: start ------- 14:58:07 INFO - PID 6639 | Number of tests: 14 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.63 (2.3%) stddev-sans-first:0.60 14:58:07 INFO - PID 6639 | Values: 104.0 111.0 112.0 112.0 112.0 113.0 113.0 112.0 112.0 112.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:126.50 stddev:18.15 (14.3%) stddev-sans-first:17.70 14:58:07 INFO - PID 6639 | Values: 155.0 125.0 124.0 174.0 128.0 123.0 124.0 123.0 149.0 122.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#2] audio-dft Cycles:10 Average:166.70 Median:167.50 stddev:3.40 (2.0%) stddev-sans-first:3.61 14:58:07 INFO - PID 6639 | Values: 167.0 168.0 169.0 168.0 174.0 167.0 163.0 164.0 163.0 164.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.00 stddev:9.76 (12.8%) stddev-sans-first:10.17 14:58:07 INFO - PID 6639 | Values: 75.0 76.0 75.0 101.0 76.0 74.0 75.0 77.0 96.0 77.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:10.02 (11.9%) stddev-sans-first:10.37 14:58:07 INFO - PID 6639 | Values: 84.0 86.0 109.0 85.0 83.0 84.0 100.0 84.0 83.0 104.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:58:07 INFO - PID 6639 | Values: 115.0 114.0 114.0 114.0 115.0 115.0 114.0 114.0 114.0 115.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 14:58:07 INFO - PID 6639 | Values: 151.0 150.0 151.0 149.0 152.0 151.0 150.0 152.0 150.0 151.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 14:58:07 INFO - PID 6639 | Values: 95.0 95.0 95.0 97.0 94.0 95.0 94.0 96.0 94.0 95.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 14:58:07 INFO - PID 6639 | Values: 56.0 55.0 55.0 54.0 55.0 56.0 55.0 57.0 55.0 55.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 14:58:07 INFO - PID 6639 | Values: 56.0 56.0 57.0 57.0 56.0 57.0 57.0 56.0 56.0 56.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:1.17 (1.4%) stddev-sans-first:1.22 14:58:07 INFO - PID 6639 | Values: 82.0 83.0 81.0 80.0 82.0 82.0 81.0 83.0 80.0 80.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:138.00 stddev:16.17 (11.7%) stddev-sans-first:17.14 14:58:07 INFO - PID 6639 | Values: 139.0 138.0 138.0 132.0 131.0 135.0 130.0 150.0 184.0 133.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.00 Median:190.00 stddev:5.25 (2.8%) stddev-sans-first:5.10 14:58:07 INFO - PID 6639 | Values: 185.0 200.0 190.0 188.0 190.0 185.0 196.0 190.0 188.0 198.0 14:58:07 INFO - PID 6639 | 14:58:07 INFO - PID 6639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:1.58 (2.2%) stddev-sans-first:1.36 14:58:07 INFO - PID 6639 | Values: 74.0 72.0 71.0 71.0 74.0 71.0 70.0 71.0 69.0 71.0 14:58:07 INFO - PID 6639 | -------- Summary: end -------- 14:58:07 INFO - PID 6639 | 14:58:08 INFO - TEST-INFO | 6639: exit 0 14:58:08 INFO - TEST-OK | kraken | took 65193ms 14:58:08 INFO - SUITE-END | took 1186s 14:58:08 INFO - Completed test suite (00:19:46) 14:58:08 INFO - javascript benchmark 14:58:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6741.230164078961, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2732.84969326687, 2733.3030077330304, 2743.561030235163, 2763.3367991682, 2778.7638050765686, 5297.364316282052, 5332.840014799557, 5349.91975120373, 5376.301080859483, 5423.593230507713, 5330.466953304667, 5372.194170874371, 5398.64908780929, 5457.399686034533, 5494.2857428534335, 4489.889398898746, 4743.146233677945, 4750.311204875291, 4777.283407488887, 4779.259214821708, 4781.995780886018, 4793.065352256312, 4834.9033019339595, 4851.539103785135, 4862.246351815475, 4652.837150699709, 4709.552592503741, 4711.458182309044, 4770.308305295747, 4791.401074865642, 4784.114938736345, 4796.400449943757, 4808.134535783557, 4832.589229915427, 4861.246506791453, 4737.976310118427, 4778.331033655291, 4780.832670856538, 4798.160321943646, 4812.831550895702, 5253.3170687810725, 5257.7108259045735, 5370.785168593252, 5408.594355423359, 5432.70120143392, 5802.738876750556, 5824.417558244184, 5847.152162936393, 5861.238039054895, 5878.764849406019, 5774.740136693817, 5826.883462330729, 5829.09649004405, 5830.242068531106, 5838.795642152504, 5306.62853600252, 5383.946160538345, 5443.618946673774, 5448.237246785453, 5457.590680698924, 5924.822255332347, 6039.063945088518, 6061.242344706911, 6079.756809727562, 6080.331163572004, 5634.070378387602, 5659.688717120515, 5726.513246374022, 5746.741396637161, 5753.712314384264, 5694.886102278014, 5737.082066869364, 5743.54051675865, 5765.250517432707, 5795.768169273266, 5633.859153521113, 5714.0571805652435, 5717.056685646905, 5724.513416359656, 5734.913976290359, 5684.0, 5801.042827933428, 5832.270966129234, 5834.299884013945, 5846.152307915413, 4852.902941941142, 4853.587445067209, 4862.902741945141, 4863.197572400514, 4905.950940490549, 4055.8174882129783, 4121.814518346681, 4163.708540402143, 4172.040430700895, 4196.076863090116, 4864.756762161877, 4890.095332363524, 4976.154053810861, 4982.227754698028, 4983.0, 5930.525557955353, 5931.58478906481, 5940.0, 5966.194563733927, 5987.670678112659, 4964.081644895706, 4988.700677959334, 4990.932390102055, 4999.400071991385, 5005.998800239967, 5068.6451948363265, 5239.973800131052, 5252.317198764136, 5257.211418287287, 5274.129768588216, 5318.680879147263, 5335.199720042025, 5373.6238463308755, 5380.0, 5397.8380648580605, 5676.716164191691, 5678.943210568007, 5719.142128680731, 5720.513756330592, 5720.513756330759, 5322.175062865262, 5361.812336568201, 5363.463653634762, 5385.46145385474, 5385.892282154413, 5655.1517272409465, 5683.715814209356, 5684.005299072563, 5695.117256825199, 5696.914546281726, 5795.82612521625, 5796.304443466811, 5798.884022319615, 5801.129830525455, 5812.680302583399, 5560.916586251128, 5601.831945041656, 5678.517326027334, 5740.885182296247, 5770.769169233184, 5690.459406356389, 5698.287714035746, 5708.743106560298, 5713.742881570256, 5723.6851973141875, 5560.860978475571, 5589.329280486368, 5628.409017053151, 5643.661380317194, 5650.350209725934, 5572.4148964358155, 5592.7203639817035, 5643.915341269802, 5658.236138121301, 5667.659940403589, 5495.0, 5500.367457742411, 5585.916211256916, 5602.66384016944, 5632.971835140798], "value": 5255.267996080131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.07663730601, 715.2204097533689, 1048.6801525534713, 1071.3625392891227, 1133.2067552713092, 30519.54220686689, 33824.4926326105, 33902.0, 33983.15042123948, 34119.82940085296, 31646.208844778834, 31897.0, 32052.519212211835, 32066.519002214925, 32068.0, 6421.0, 6487.156669632953, 6576.539642225046, 6601.339866013384, 6610.8677826443445, 7033.0, 7074.82312942178, 7124.323189297009, 7142.25006374331, 7147.249538798429, 7099.0, 7111.146662400519, 7129.215786263507, 7171.677274522659, 7178.066851309322, 7113.435044290248, 7129.0, 7137.536060156125, 7144.142702875636, 7145.7141714331365, 6971.407430368425, 7017.719291228344, 7024.719011239545, 7038.416356319838, 7045.436365090781, 32443.837780810944, 32827.0, 33130.337393252, 33139.171520711934, 33141.6685833141, 3087.6294844618565, 3098.055093196574, 3102.612173478315, 3120.937581248385, 3135.0751528299206, 25221.495570088497, 25246.0, 25292.367690807692, 25387.61918571223, 25407.364815879566, 2713.0, 2743.43759529296, 2763.019128209497, 2766.39139389334, 2776.986115069412, 146491.0, 147256.0, 148225.0, 148495.0, 149063.0, 39880.0, 42411.57588424076, 42876.78561607172, 42958.35562466565, 43052.569474305485, 43700.56299437029, 43746.0, 43966.90082747893, 44198.55801442009, 44316.778416107714, 11341.376224307742, 11414.771704565863, 11465.197436179387, 11467.0, 11529.48117334722, 8834.160754728291, 8864.64541418349, 8890.86663700045, 8901.243394311556, 8911.15344042315, 13075.150115242479, 13196.802047969288, 13256.801147982787, 13324.400401981935, 13457.730845383037, 5282.471752824764, 5307.708076055854, 5350.785968561292, 5402.243685883979, 5409.377921538995, 875.4134729731095, 891.9063498332712, 928.8931772846074, 942.9198518125899, 959.2613687460756, 22405.96692595316, 22493.0, 22528.549429011327, 22586.548269034527, 22895.0, 987.3779518903045, 996.6511720897628, 998.0967224661692, 1011.9595216191417, 1019.7654539455966, 11011.0, 11589.072874170046, 11794.0, 11839.881601183877, 11931.940340298243, 175455.0, 176197.0, 176761.0, 176994.0, 177375.0, 43578.12843743107, 43739.34390984138, 43743.12513749771, 43747.56252437498, 43815.78092109583, 1183.9973207381909, 1232.7472868062025, 1237.6287113865803, 1239.578543295284, 1241.2242348531986, 20414.38756837297, 21383.144674212857, 22102.668459973436, 22118.557628847655, 22387.552248954606, 28995.565066523595, 29172.854135730035, 29248.26879328034, 29303.560446592892, 29325.26686832846, 147454.0, 147580.0, 147815.2609236947, 148003.2599836994, 148611.2569437189, 30815.383692326475, 30908.0, 31861.36277274488, 32685.836570816995, 32707.672923271413, 38260.426093609174, 38471.230575388894, 38491.037724056005, 38622.6137738619, 38632.42051369175, 27027.0, 29049.854750726958, 29101.0, 29702.554461683525, 30538.847305763327, 28970.27574310659, 29072.854635726686, 29246.853765731033, 29316.70683293225, 29923.850380747957, 32901.83549082239, 32963.175920602174, 32992.0, 33068.83465582657, 33103.83448082744, 27729.0, 27763.02829400961, 28625.856870715514, 28960.13119606415, 29336.0, 22689.659655105515, 22871.542569148856, 23237.3028809136, 23736.881315593313, 23896.0], "value": 14733.454828882299, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.3449687481279, 427.1435771278586, 428.59069588542945, 434.73263942675254, 439.8856297362687, 16624.750628740578, 17085.914570427147, 17669.057630472405, 17709.114544272798, 17880.195391207395, 18339.724904126448, 18573.53566160847, 19205.0, 19820.40538783839, 19830.206791728313, 5425.647332923367, 5502.752376143063, 5534.169874518814, 5558.055130627803, 5566.693831839248, 5599.944000559983, 5694.373618901917, 5696.515796157331, 5706.77172913083, 5726.62776919501, 5444.972775136119, 5472.425395333493, 5484.424135465779, 5492.972535137319, 5499.4225606311165, 5415.48552887475, 5492.615516913837, 5493.368262649807, 5501.0648189807425, 5533.972330138344, 4948.604111671058, 5113.156329205676, 5114.667546609458, 5119.488051194888, 5126.538611524943, 20490.282840100524, 20999.160033598637, 22334.0, 22415.551688966294, 22663.546729065325, 1593.2591345024503, 1601.991990040054, 1617.5066604685567, 1623.5048310265365, 1637.435084895709, 14788.40846366144, 14887.702245955128, 15361.385544578203, 15403.22983850803, 15570.29933652977, 2100.380387785607, 2140.77521860204, 2163.9567208655894, 2165.761766205716, 2193.616117179487, 88365.0, 91021.54489227578, 91729.54135229281, 91912.0, 92691.0, 11025.196307273978, 11315.0, 11367.545298188144, 11467.598634047936, 11572.36352000648, 15985.200739962955, 15985.280662369989, 16039.759403608956, 16044.0, 16046.27791749374, 7156.928430715626, 7315.926840731631, 7446.218147094477, 7507.809181098011, 7521.7743467696055, 6479.125318082093, 6485.67571621417, 6507.381798729113, 6706.932930670729, 6717.596944183365, 7104.502684812117, 7174.856502869913, 7222.383771075961, 7290.872548340157, 7338.608414884453, 2076.9376918692465, 2077.574097310048, 2091.550316681921, 2108.525581744126, 2261.8755968421565, 859.6647307550061, 890.1454603580506, 901.1889299630254, 905.3526728389234, 921.6451666108462, 16980.235889385007, 17261.72027314806, 17698.734518982226, 17725.822741772416, 18171.364002259856, 870.2907130688469, 875.4397185801092, 882.3602887906217, 895.7402353317595, 903.1826197291462, 9330.720078397659, 9379.859302110473, 9673.70978870635, 9716.125548700651, 9736.90656508854, 339068.0, 340935.0, 343198.0, 345853.0, 350686.42449330556, 77709.61145194237, 78342.0, 78471.2152878464, 80107.19892800998, 80767.0, 1027.275770581738, 1031.504877658728, 1047.2407504559285, 1053.2837670384213, 1058.169337070396, 14587.0, 15075.773863391838, 15112.09327440357, 15147.924260378628, 15472.303746331218, 36581.0, 36983.63016369802, 37356.62643373531, 37852.0, 38721.2255754889, 47630.52369476399, 47902.760486197345, 48076.75961620169, 48168.518314817804, 49330.50669493259, 8115.959420202861, 8151.918480815116, 8161.591920404075, 8213.383996200428, 8570.842936203782, 12552.309622970459, 12684.556040538537, 12695.55565555201, 13020.153690010118, 13086.476540938256, 10722.89277107219, 10954.397508137128, 11119.388433636228, 11311.7737645245, 11379.089672825989, 10413.843792343272, 10563.260571759904, 10564.894351056391, 10565.683029509128, 10641.627543035956, 10683.679489615324, 10899.346039237671, 11132.499037543168, 11306.49120789583, 11393.259438136494, 8126.187381261827, 8205.384596155433, 8206.753797386087, 8262.256396924306, 8374.65509657297, 11114.722131946766, 11580.594679186188, 11606.30362178272, 11677.007454366134, 12086.818697719365], "value": 8869.542759525508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.8014717645176, 1310.10912579446, 1311.0756916373957, 1316.0918965913513, 1321.828162338897, 9207.539623018847, 9441.103095205961, 9650.662226822064, 9661.951690241547, 10044.0, 9704.757381065478, 9841.114299713025, 9878.851817222747, 9900.405975641448, 9915.702528924126, 2225.098834971839, 2255.109231853425, 2261.819054475638, 2269.092363054775, 2273.3975496493445, 2183.355910006544, 2236.2173239366252, 2238.0488292475716, 2242.9887850560726, 2251.212075773474, 1987.7912819153998, 1999.8300144487737, 2026.503506640875, 2030.2691031228746, 2040.5000774810192, 1972.8224459798614, 1975.8320542753884, 1982.4250967219489, 1988.8309493693052, 1992.1832048860042, 1862.5995410986702, 1875.409246087478, 1923.7210604462414, 1943.9902800486047, 2141.5716856628583, 9778.07108324715, 9836.557354918974, 9844.36011659247, 9862.852057219148, 9874.111329980264, 5510.889782204334, 5724.856878578027, 5740.741666625012, 5751.597388182829, 5755.568332375088, 3297.8141133426448, 3333.1333853198103, 3356.412627790127, 3443.0531603808904, 3462.982685086584, 1036.19694736579, 1074.3929679730927, 1081.7403823082482, 1105.3975583307117, 1111.0889070961814, 13834.515791947233, 13845.376958036912, 13918.234497102554, 13952.093113947662, 13980.440782368692, 4550.522195169526, 4653.302004699322, 4849.030193961151, 4875.366202393666, 4934.111859865258, 9887.0, 9927.40435573868, 9928.404295742279, 9976.950115249523, 9997.200223982063, 5437.537809286255, 5483.561315094783, 5492.615516913777, 5497.312835895513, 5512.972435137799, 4840.443349014838, 4972.5276098770555, 5043.697378157322, 5134.666246693953, 5199.766010529535, 3763.303788799081, 3809.7523660961947, 3894.2406230784727, 3929.548101968253, 3936.2127574485216, 1074.699084256394, 1085.5766251162054, 1108.2630051016145, 1109.4341885638382, 1113.7661091170783, 725.3906718356606, 754.1628792040831, 760.0840986611121, 766.2835249042164, 767.6277005652254, 5656.547476201894, 5724.885502289931, 5795.275590551181, 5849.093390524476, 5864.44287792659, 844.8352571248671, 846.4498076250486, 871.0897112517434, 873.0352959979258, 877.2718643525858, 3922.764634121962, 4009.699272554512, 4064.0, 4086.346184610448, 4095.4266402703647, 12053.819192712117, 12625.0, 12779.0, 12804.231746095264, 12837.679058023437, 11891.821622675667, 12665.240085594894, 12681.653894029634, 12714.046446516548, 12731.61805145847, 7128.501004929709, 7329.486935914435, 7334.48658593904, 7342.559446433231, 7359.190489046201, 5949.910751338647, 6161.815145545641, 6251.6561589113035, 6280.313270255206, 6441.452476539546, 10750.46247687628, 11118.444077795915, 11233.775324493628, 11383.829242561535, 11472.598459053894, 11491.425428728362, 11500.884991149982, 11513.251638643462, 11613.593524226611, 11636.06911447099, 7857.489263197874, 8112.18878112184, 8184.468009579358, 8201.26188643025, 8204.876926845982, 9199.908000919904, 9260.768480788034, 9272.629094836131, 9285.117913798178, 9294.209992150472, 7908.920910790818, 7933.8413231736195, 8136.87794683092, 8177.836443271221, 8278.420510564203, 7841.098273698598, 7869.370450363843, 7877.330426913776, 7976.880346794686, 8092.150324215872, 7264.963675181591, 7349.816254593464, 7358.264173582599, 7373.9262607375385, 7390.076240469942, 4735.171345014677, 5218.452062533379, 5236.109861323508, 5331.626786124934, 5534.308211473566, 5480.753366098615, 5490.121580547093, 5517.779288828402, 5547.44525547442, 5647.237622920853], "value": 4654.523642306619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.6508756331233, 385.72227995842985, 386.7949986507151, 390.4358202397537, 396.7778044295195, 5481.588880833943, 5621.8475212581425, 5698.430156984305, 5702.429757024295, 5711.485966263041, 5377.462253774621, 5555.055640541108, 5561.360443548983, 5561.833145005646, 5596.944030559694, 4409.625181859546, 4424.402705634747, 4427.358033085201, 4431.88920276994, 4445.911081778362, 4055.290324193269, 4181.644560212386, 4222.451081359419, 4412.58797184901, 4452.820002699271, 4123.402106694542, 4124.731892426983, 4134.979325103385, 4138.33786594145, 4139.151473947833, 4151.107511884929, 4165.458490396244, 4171.499420069611, 4174.749515029092, 4193.287141186006, 3532.6643968823178, 3629.201575653352, 3652.068722475778, 3666.1934374437583, 3667.991302391837, 5435.402105768362, 5441.29263195782, 5454.563634909197, 5464.535514481234, 5492.450754924515, 4943.0, 4943.950560494385, 4960.801567937278, 4968.577670897978, 4983.700977941335, 5801.390853960358, 5892.733062391563, 5916.674582897939, 5938.287405511366, 5938.940610593882, 4112.321466957948, 4114.794260286973, 4118.629323360882, 4120.340745480738, 4121.361189015707, 6046.788362407295, 6230.937690623126, 6276.403741644536, 6291.779787707408, 6360.9045864312075, 4138.8551400700835, 4180.352045432963, 4184.267753143188, 4188.81150348235, 4195.370694395804, 4225.007123326016, 4233.5131459881895, 4234.216669916075, 4236.5763423658, 4250.53244143144, 4772.0, 4840.394950631171, 4885.193942999436, 4902.534259245366, 4904.253617973946, 5894.705264736746, 5908.172855800191, 5916.1421593868645, 5921.7631294747725, 5926.67403292823, 1425.950091746784, 1472.234438092186, 1472.49935022093, 1473.4327283995524, 1477.5788900163402, 939.9765005874908, 957.2581249531669, 976.5215044628223, 980.07872599756, 1006.808706345792, 5133.820316288987, 5137.974310128426, 5152.793888244429, 5156.716380599028, 5169.147090730063, 6143.0105646993825, 6146.0, 6157.6613286269685, 6159.4456498915315, 6159.84600384994, 4944.678595891256, 5084.1102807009365, 5091.701616087874, 5169.327987361619, 5190.55880250183, 3252.9837350813095, 3278.5246139310143, 3282.622498412665, 3290.901272961815, 3298.0376675877815, 5532.197831314517, 5667.489925906688, 5694.202811606378, 5713.5714821388565, 5753.913691294634, 6227.377262273736, 6278.537672225102, 6340.0, 6353.523485738496, 6365.936340636535, 5734.340550836624, 5737.971310143423, 5753.33836608787, 5758.424157584208, 5762.394948530427, 5975.25309336333, 6131.724072416663, 6196.318404975359, 6206.441420272197, 6212.409821066992, 5907.763689452374, 6061.484773794277, 6071.848203794941, 6077.56058327803, 6107.4197951194565, 5701.201831743642, 5754.273717884535, 5758.3090029196765, 5772.528005358607, 5788.623739456922, 4166.1251137261515, 4178.7283826551175, 4188.41362209297, 4200.306949353322, 4201.810918508613, 6068.9089663654195, 6178.135061091541, 6208.875822483616, 6210.503159747119, 6244.875102498016, 5945.840561090546, 5982.611130276518, 6001.0, 6005.90991135142, 6028.57799953999, 5858.5898987070495, 5938.851528711817, 5942.554308426799, 5956.374580668968, 5977.3424923257535, 5842.415758424124, 5905.793297234748, 5915.752014234563, 5940.732667030081, 5946.13781001761, 6045.304789949212, 6060.545459090674, 6077.665728384804, 6079.148919151234, 6081.361457047124, 5632.971835140798, 5796.710164491843, 5813.128030795415, 5833.854153646193, 5865.120231965239], "value": 4430.512359743197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.1655420760063, 775.78278082137, 776.5418403142148, 787.3307688464805, 791.9841603167937, 11913.821292680595, 12348.01215902728, 13686.726265474685, 14221.0, 14237.857621423796, 14723.411063557445, 14904.0, 15219.84780152198, 15232.619184520392, 15297.617559561017, 839.2949922065463, 861.3539845116163, 863.8704194370832, 869.9956500217522, 871.7820544863785, 912.885889263842, 915.1900567997304, 918.4948278446861, 918.5590916360151, 918.6463211663524, 956.6651671914843, 959.9952000239989, 966.7196513011219, 967.1344146988476, 969.743018100204, 946.9053094690545, 947.6920000999703, 947.7772723409993, 948.7912659214961, 951.1534734086669, 702.5047341624143, 706.6396137969673, 707.0949185043153, 707.3527722134241, 709.0888208651909, 15069.246537673182, 15174.848251517564, 15192.544223673198, 15380.538583842503, 15494.845051549453, 15247.0, 15437.768433473395, 15485.14831684257, 15618.609534761608, 15759.763603545956, 12475.438605262785, 12588.496460141583, 12670.873291267062, 12745.936270318682, 12895.29075900825, 2687.852168130752, 2702.797290203223, 2708.471847989643, 2709.2143278449225, 2718.877650505732, 65218.3478165217, 65924.3407565923, 66042.0, 66361.0, 67142.30717310547, 10251.58993640261, 10307.896921030844, 10501.842472362921, 10558.577656893793, 10632.202584806017, 17984.910075449538, 18022.3692170776, 18115.094245287684, 18157.09214539268, 18178.18198181085, 5956.136360227742, 6168.475679567197, 6485.124508191334, 6538.051982462612, 6539.215294164731, 2968.5992391027366, 3009.623797025372, 3037.9392412151633, 3038.255627371308, 3041.7718671099756, 3371.4942758585917, 3423.606285277225, 3428.502867084259, 3439.9656003439645, 3478.982605087009, 720.2545365546634, 722.37514549915, 726.0525014855664, 727.0838743183521, 729.9087614048244, 546.8496163554975, 597.6175247841385, 600.0848705723719, 604.3684349854412, 615.1326629452451, 9912.405255684538, 10014.949925250472, 10148.746281343025, 10418.374897506174, 10709.0, 594.8810237952426, 600.1747597054051, 609.2110716621985, 616.3959319866556, 623.9953674583916, 4572.634189264851, 4610.861674149781, 4792.412097467329, 4837.201861692852, 4991.450940396553, 61782.38217617856, 63296.683516582125, 63339.0, 64622.67688661621, 65369.673151633935, 54050.0, 55686.72156639191, 55866.44133558694, 56651.15023274654, 57129.0, 50524.74737626362, 51730.224046639334, 52697.47302526925, 53466.73266633642, 54325.72837135789, 9427.952860235655, 9709.6601618943, 9767.951160244153, 10146.797064058825, 10160.847587286344, 26587.081389942923, 26693.332666682712, 27012.72987270102, 27671.446571068867, 28036.85981570079, 32302.0, 32516.0, 32524.674753252166, 32555.0, 33213.50179747257, 12400.441980110736, 12548.556915954417, 12575.119741618364, 12712.491500340253, 12713.80929286043, 13377.598672039854, 13842.792358114435, 13937.651558711113, 13976.231307278198, 13978.790318145033, 12792.296423696785, 12812.295323757282, 12880.227186368847, 13009.609711708665, 13112.0, 12430.254184748945, 12449.0, 12759.808602870778, 12803.80794288105, 12947.158434701714, 12412.875871241533, 12424.192427492184, 12540.561080362144, 12562.748745024866, 12621.0, 8342.16578342161, 8398.286145677686, 8680.262177714965, 8730.730010197267, 8848.0, 10600.522976465923, 10712.839307410239, 10785.298955567863, 10900.07349375312, 10946.616868409568], "value": 6626.338885880691, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 124.0, 174.0, 128.0, 123.0, 124.0, 123.0, 149.0, 122.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 169.0, 168.0, 174.0, 167.0, 163.0, 164.0, 163.0, 164.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 101.0, 76.0, 74.0, 75.0, 77.0, 96.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 109.0, 85.0, 83.0, 84.0, 100.0, 84.0, 83.0, 104.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 149.0, 152.0, 151.0, 150.0, 152.0, 150.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 94.0, 95.0, 94.0, 96.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 55.0, 56.0, 55.0, 57.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 56.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 80.0, 82.0, 82.0, 81.0, 83.0, 80.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 138.0, 132.0, 131.0, 135.0, 130.0, 150.0, 184.0, 133.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 200.0, 190.0, 188.0, 190.0, 185.0, 196.0, 190.0, 188.0, 198.0], "value": 191.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 71.0, 74.0, 71.0, 70.0, 71.0, 69.0, 71.0], "value": 71.4, "unit": "score"}]}]} 14:58:08 INFO - Return code: 0 14:58:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:58:08 INFO - # TBPL SUCCESS # 14:58:08 INFO - Running post-action listener: _resource_record_post_action 14:58:08 INFO - [mozharness: 2017-05-05 21:58:08.980410Z] Finished run-tests step (success) 14:58:08 INFO - Running post-run listener: _resource_record_post_run 14:58:09 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 348827648; Read time: 16; Write time: 231192 14:58:09 INFO - TinderboxPrint: CPU usage
13.3% 14:58:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:58:09 INFO - TinderboxPrint: I/O write bytes / time
348,827,648 / 231,192 14:58:09 INFO - TinderboxPrint: CPU idle
8,316.3 (86.7%) 14:58:09 INFO - TinderboxPrint: CPU user
1,218.7 (12.7%) 14:58:09 INFO - TinderboxPrint: Swap in / out
0 / 0 14:58:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 96747520; Read time: 0; Write time: 96828 14:58:09 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252080128; Read time: 16; Write time: 134364 14:58:09 INFO - Running post-run listener: _upload_blobber_files 14:58:09 INFO - Blob upload gear active. 14:58:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:58:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:58:10 INFO - (blobuploader) - INFO - Open directory for files ... 14:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:10 INFO - (blobuploader) - INFO - Done attempting. 14:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:11 INFO - (blobuploader) - INFO - Done attempting. 14:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:58:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:14 INFO - (blobuploader) - INFO - Done attempting. 14:58:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:58:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:58:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:15 INFO - (blobuploader) - INFO - Done attempting. 14:58:15 INFO - (blobuploader) - INFO - Iteration through files over. 14:58:15 INFO - Return code: 0 14:58:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:58:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:58:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/264ca88235c45e4b1e26587226479156fee1a78953172956555cf2bdec765c46a7f9430d8fba409d5e1289031982554a929a393615fa03d3536080d85d3ea7b2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d339fea7bc1512075653bb671061b1651973b1cc6fca342d0d0b98ddf88ea29f5e1516509860a914dfbfe12290608c99908e215e80e5af6604de4af816afc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4b9e1816111917d37030c8e7b2aad4afb426b944c0bc29e81dac8578500aea292bc8b8be1272a2f64544fe99d85fb57e6098149609689018b7a32c670c6ba6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/381728917761fa56ea4199a60c444a743b0cbc7f086ee8f303228b03fcdd4ea34a5a1ba5b9423cffe94f8a3afe719bb56c167be25ec78ec5f393d2aa2cff433f"} 14:58:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:58:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:58:15 INFO - Contents: 14:58:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/264ca88235c45e4b1e26587226479156fee1a78953172956555cf2bdec765c46a7f9430d8fba409d5e1289031982554a929a393615fa03d3536080d85d3ea7b2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d339fea7bc1512075653bb671061b1651973b1cc6fca342d0d0b98ddf88ea29f5e1516509860a914dfbfe12290608c99908e215e80e5af6604de4af816afc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4b9e1816111917d37030c8e7b2aad4afb426b944c0bc29e81dac8578500aea292bc8b8be1272a2f64544fe99d85fb57e6098149609689018b7a32c670c6ba6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/381728917761fa56ea4199a60c444a743b0cbc7f086ee8f303228b03fcdd4ea34a5a1ba5b9423cffe94f8a3afe719bb56c167be25ec78ec5f393d2aa2cff433f"} 14:58:15 INFO - Running post-run listener: copy_logs_to_upload_dir 14:58:15 INFO - Copying logs to upload dir... 14:58:15 INFO - mkdir: /builds/slave/test/build/upload/logs 14:58:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.751752 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-05 14:58:15.620763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:15.624451) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/264ca88235c45e4b1e26587226479156fee1a78953172956555cf2bdec765c46a7f9430d8fba409d5e1289031982554a929a393615fa03d3536080d85d3ea7b2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d339fea7bc1512075653bb671061b1651973b1cc6fca342d0d0b98ddf88ea29f5e1516509860a914dfbfe12290608c99908e215e80e5af6604de4af816afc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4b9e1816111917d37030c8e7b2aad4afb426b944c0bc29e81dac8578500aea292bc8b8be1272a2f64544fe99d85fb57e6098149609689018b7a32c670c6ba6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/381728917761fa56ea4199a60c444a743b0cbc7f086ee8f303228b03fcdd4ea34a5a1ba5b9423cffe94f8a3afe719bb56c167be25ec78ec5f393d2aa2cff433f"} build_url:https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/264ca88235c45e4b1e26587226479156fee1a78953172956555cf2bdec765c46a7f9430d8fba409d5e1289031982554a929a393615fa03d3536080d85d3ea7b2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d339fea7bc1512075653bb671061b1651973b1cc6fca342d0d0b98ddf88ea29f5e1516509860a914dfbfe12290608c99908e215e80e5af6604de4af816afc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4b9e1816111917d37030c8e7b2aad4afb426b944c0bc29e81dac8578500aea292bc8b8be1272a2f64544fe99d85fb57e6098149609689018b7a32c670c6ba6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/381728917761fa56ea4199a60c444a743b0cbc7f086ee8f303228b03fcdd4ea34a5a1ba5b9423cffe94f8a3afe719bb56c167be25ec78ec5f393d2aa2cff433f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:15.654598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:15.654998) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1494019950.43500-869014151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:15.739728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 14:58:15.740236) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 14:58:15.740806) ========= ========= Total master_lag: 0.20 =========