builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1485790782.92 results: success (0) revision: b332a2a48c1bcea90276955b0a6ccd0afbb6f569 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:42.925199) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:42.925792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:42.926096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:42.944034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:42.944385) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-30 07:39:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-01-30 07:39:43 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198211 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:43.158729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:43.159308) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016961 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:43.209778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 07:39:43.210139) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b332a2a48c1bcea90276955b0a6ccd0afbb6f569 --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 b332a2a48c1bcea90276955b0a6ccd0afbb6f569 --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=edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-30 07:39:43,601 truncating revision to first 12 chars 2017-01-30 07:39:43,601 Setting DEBUG logging. 2017-01-30 07:39:43,601 attempt 1/10 2017-01-30 07:39:43,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b332a2a48c1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 07:39:44,708 unpacking tar archive at: mozilla-central-b332a2a48c1b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.480615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 07:39:44.704151) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:44.704566) ========= script_repo_revision: b332a2a48c1bcea90276955b0a6ccd0afbb6f569 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:44.705088) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:44.705387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 07:39:44.714841) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-30 07:39:44.715236) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:39:45 INFO - MultiFileLogger online at 20170130 07:39:45 in /builds/slave/test 07:39:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:39:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:39:45 INFO - {'append_to_log': False, 07:39:45 INFO - 'base_work_dir': '/builds/slave/test', 07:39:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:39:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:39:45 INFO - 'branch': 'Firefox-Non-PGO', 07:39:45 INFO - 'buildbot_json_path': 'buildprops.json', 07:39:45 INFO - 'config_files': ('talos/linux_config.py',), 07:39:45 INFO - 'default_actions': ('clobber', 07:39:45 INFO - 'read-buildbot-config', 07:39:45 INFO - 'download-and-extract', 07:39:45 INFO - 'populate-webroot', 07:39:45 INFO - 'create-virtualenv', 07:39:45 INFO - 'install', 07:39:45 INFO - 'run-tests'), 07:39:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:39:45 INFO - 'download_minidump_stackwalk': True, 07:39:45 INFO - 'download_symbols': 'ondemand', 07:39:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:39:45 INFO - 'tooltool.py': '/tools/tooltool.py', 07:39:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:39:45 INFO - '/tools/misc-python/virtualenv.py')}, 07:39:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:39:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:39:45 INFO - 'installer_path': 'installer.exe', 07:39:45 INFO - 'log_level': 'info', 07:39:45 INFO - 'log_name': 'talos', 07:39:45 INFO - 'log_to_console': True, 07:39:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:39:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:39:45 INFO - 'opt_config_files': (), 07:39:45 INFO - 'pip_index': False, 07:39:45 INFO - 'sps_profile': False, 07:39:45 INFO - 'sps_profile_interval': 0, 07:39:45 INFO - 'suite': 'dromaeojs', 07:39:45 INFO - 'system_bits': '32', 07:39:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:39:45 INFO - 'title': 'talos-linux64-ix-033', 07:39:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:39:45 INFO - 'use_talos_json': True, 07:39:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:39:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:39:45 INFO - 'work_dir': 'build'} 07:39:45 INFO - [mozharness: 2017-01-30 15:39:45.212423Z] Running clobber step. 07:39:45 INFO - Running pre-action listener: _resource_record_pre_action 07:39:45 INFO - Running main action method: clobber 07:39:45 INFO - rmtree: /builds/slave/test/build 07:39:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:39:46 INFO - Running post-action listener: _resource_record_post_action 07:39:46 INFO - [mozharness: 2017-01-30 15:39:46.198825Z] Finished clobber step (success) 07:39:46 INFO - [mozharness: 2017-01-30 15:39:46.198924Z] Running read-buildbot-config step. 07:39:46 INFO - Running pre-action listener: _resource_record_pre_action 07:39:46 INFO - Running main action method: read_buildbot_config 07:39:46 INFO - Using buildbot properties: 07:39:46 INFO - { 07:39:46 INFO - "project": "", 07:39:46 INFO - "product": "firefox", 07:39:46 INFO - "who": "cbook@mozilla.com", 07:39:46 INFO - "installer_path": "public/build/target.tar.bz2", 07:39:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:39:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:39:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:39:46 INFO - "stage_platform": "linux64", 07:39:46 INFO - "basedir": "/builds/slave/test", 07:39:46 INFO - "buildnumber": 947, 07:39:46 INFO - "platform": "ubuntu64_hw", 07:39:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:39:46 INFO - "slavebuilddir": "test", 07:39:46 INFO - "taskId": "Nk_Ac3eSRzOP58DwS6UO7g", 07:39:46 INFO - "branch": "mozilla-central", 07:39:46 INFO - "script_repo_revision": "production", 07:39:46 INFO - "revision": "b332a2a48c1bcea90276955b0a6ccd0afbb6f569", 07:39:46 INFO - "slavename": "talos-linux64-ix-033", 07:39:46 INFO - "repo_path": "mozilla-central" 07:39:46 INFO - } 07:39:46 INFO - Finding installer, test and symbols from parent task. 07:39:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nk_Ac3eSRzOP58DwS6UO7g'}, attempt #1 07:39:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nk_Ac3eSRzOP58DwS6UO7g'}, attempt #1 07:39:47 INFO - Task dependencies: fkGuYk-PT2uDNQV9b_RYAQ 07:39:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ'}, attempt #1 07:39:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.tar.bz2 07:39:47 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/test_packages.json 07:39:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.crashreporter-symbols.zip 07:39:47 INFO - Running post-action listener: _resource_record_post_action 07:39:47 INFO - [mozharness: 2017-01-30 15:39:47.581778Z] Finished read-buildbot-config step (success) 07:39:47 INFO - [mozharness: 2017-01-30 15:39:47.582004Z] Running download-and-extract step. 07:39:47 INFO - Running pre-action listener: _resource_record_pre_action 07:39:47 INFO - Running main action method: download_and_extract 07:39:47 INFO - mkdir: /builds/slave/test/build/tests 07:39: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')]} 07:39:47 INFO - trying https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.test_packages.json 07:39:47 INFO - Downloading https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:39:48 INFO - Downloaded 896 bytes. 07:39:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:39:48 INFO - Using the following test package requirements: 07:39:48 INFO - {u'common': [u'target.common.tests.zip'], 07:39:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:39:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:39:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:39:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:39:48 INFO - u'mozbase': [u'target.common.tests.zip'], 07:39:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:39:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:39:48 INFO - u'web-platform': [u'target.common.tests.zip', 07:39:48 INFO - u'target.web-platform.tests.zip'], 07:39:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:39:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:39:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.common.tests.zip 07:39:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:39:48 INFO - Fetch https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.common.tests.zip into memory 07:39:48 INFO - Expected file size: 20333255 07:39:48 INFO - Obtained file size: 20333255 07:39:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:39:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.common.tests.zip 07:39:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:39:53 INFO - Fetch https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.common.tests.zip into memory 07:39:53 INFO - Expected file size: 20333255 07:39:53 INFO - Obtained file size: 20333255 07:39:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.talos.tests.zip 07:39:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:39:58 INFO - Fetch https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.talos.tests.zip into memory 07:39:59 INFO - Expected file size: 14403454 07:39:59 INFO - Obtained file size: 14403454 07:39: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')]} 07:39:59 INFO - trying https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.tar.bz2 07:39:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:39:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:40:00 INFO - Downloaded 56177506 bytes. 07:40:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.tar.bz2 07:40:00 INFO - mkdir: /builds/slave/test/properties 07:40:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:40:00 INFO - Writing to file /builds/slave/test/properties/build_url 07:40:00 INFO - Contents: 07:40:00 INFO - build_url:https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.tar.bz2 07:40:00 INFO - Running post-action listener: _resource_record_post_action 07:40:00 INFO - Running post-action listener: set_extra_try_arguments 07:40:00 INFO - [mozharness: 2017-01-30 15:40:00.375260Z] Finished download-and-extract step (success) 07:40:00 INFO - [mozharness: 2017-01-30 15:40:00.375357Z] Running populate-webroot step. 07:40:00 INFO - Running pre-action listener: _resource_record_pre_action 07:40:00 INFO - Running main action method: populate_webroot 07:40:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:40:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:40:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:40:00 INFO - '--tppagecycles', 07:40:00 INFO - '7'], 07:40:00 INFO - 'tests': ['tsvgm']}}, 07:40:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:40:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:40:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:40:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:40:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:40:00 INFO - 'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:40:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:40:00 INFO - 'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['damp', 'tps']}, 07:40:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:40:00 INFO - 'tests': ['damp', 'tps']}, 07:40:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['dromaeo_dom']}, 07:40:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:40:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['basic_compositor_video']}, 07:40:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:40:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['a11yr', 07:40:00 INFO - 'ts_paint', 07:40:00 INFO - 'tpaint', 07:40:00 INFO - 'sessionrestore', 07:40:00 INFO - 'sessionrestore_no_auto_restore', 07:40:00 INFO - 'tabpaint']}, 07:40:00 INFO - 'other-e10s': {'tests': ['a11yr', 07:40:00 INFO - 'ts_paint', 07:40:00 INFO - 'tpaint', 07:40:00 INFO - 'sessionrestore', 07:40:00 INFO - 'sessionrestore_no_auto_restore', 07:40:00 INFO - 'tabpaint']}, 07:40:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:40:00 INFO - 'ts_paint', 07:40:00 INFO - 'tpaint', 07:40:00 INFO - 'sessionrestore', 07:40:00 INFO - 'sessionrestore_no_auto_restore', 07:40:00 INFO - 'tabpaint']}, 07:40:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:40:00 INFO - 'ts_paint', 07:40:00 INFO - 'tpaint', 07:40:00 INFO - 'sessionrestore', 07:40:00 INFO - 'sessionrestore_no_auto_restore', 07:40:00 INFO - 'tabpaint']}, 07:40:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['a11yr', 07:40:00 INFO - 'ts_paint', 07:40:00 INFO - 'tpaint', 07:40:00 INFO - 'sessionrestore', 07:40:00 INFO - 'sessionrestore_no_auto_restore', 07:40:00 INFO - 'tabpaint']}, 07:40:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['a11yr', 07:40:00 INFO - 'ts_paint', 07:40:00 INFO - 'tpaint', 07:40:00 INFO - 'sessionrestore', 07:40:00 INFO - 'sessionrestore_no_auto_restore', 07:40:00 INFO - 'tabpaint']}, 07:40:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['tsvgx', 07:40:00 INFO - 'tsvgr_opacity', 07:40:00 INFO - 'tart', 07:40:00 INFO - 'tscrollx', 07:40:00 INFO - 'cart', 07:40:00 INFO - 'tsvg_static']}, 07:40:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:40:00 INFO - 'tsvgr_opacity', 07:40:00 INFO - 'tart', 07:40:00 INFO - 'tscrollx', 07:40:00 INFO - 'cart', 07:40:00 INFO - 'tsvg_static']}, 07:40:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:40:00 INFO - 'talos_options': ['--disable-e10s'], 07:40:00 INFO - 'tests': ['tp5o']}, 07:40:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:40:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:40:00 INFO - 'talos_options': ['--disable-e10s', 07:40:00 INFO - '--xperf_path', 07:40:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:00 INFO - 'tests': ['tp5n']}, 07:40:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:40:00 INFO - 'talos_options': ['--xperf_path', 07:40:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:00 INFO - 'tests': ['tp5n']}}, 07:40:00 INFO - 'talos.zip': {'path': '', 07:40:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:40:00 INFO - Running post-action listener: _resource_record_post_action 07:40:00 INFO - [mozharness: 2017-01-30 15:40:00.388395Z] Finished populate-webroot step (success) 07:40:00 INFO - [mozharness: 2017-01-30 15:40:00.388489Z] Running create-virtualenv step. 07:40:00 INFO - Running pre-action listener: _resource_record_pre_action 07:40:00 INFO - Running main action method: create_virtualenv 07:40:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:40:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:40:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:40:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:40:00 INFO - Using real prefix '/usr' 07:40:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:40:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:40:02 INFO - Installing pip.................done. 07:40:02 INFO - Return code: 0 07:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:40:03 INFO - Reading from file tmpfile_stdout 07:40:03 INFO - Output received: 07:40:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:40:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:03 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 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:40:03 INFO - Using env: {'DISPLAY': ':0', 07:40:03 INFO - 'HOME': '/home/cltbld', 07:40:03 INFO - 'LANG': 'en_US.UTF-8', 07:40:03 INFO - 'LANGUAGE': 'en_US:en', 07:40:03 INFO - 'LOGNAME': 'cltbld', 07:40:03 INFO - 'MAIL': '/var/mail/cltbld', 07:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:03 INFO - 'MOZ_NO_REMOTE': '1', 07:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:03 INFO - 'NO_EM_RESTART': '1', 07:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:03 INFO - 'PWD': '/builds/slave/test', 07:40:03 INFO - 'SHELL': '/bin/bash', 07:40:03 INFO - 'SHLVL': '1', 07:40:03 INFO - 'TERM': 'linux', 07:40:03 INFO - 'TMOUT': '86400', 07:40:03 INFO - 'USER': 'cltbld', 07:40:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:03 INFO - '_': '/tools/buildbot/bin/python'} 07:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:40:03 INFO - Cleaning up... 07:40:03 INFO - Return code: 0 07:40:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:03 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 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:40:03 INFO - Using env: {'DISPLAY': ':0', 07:40:03 INFO - 'HOME': '/home/cltbld', 07:40:03 INFO - 'LANG': 'en_US.UTF-8', 07:40:03 INFO - 'LANGUAGE': 'en_US:en', 07:40:03 INFO - 'LOGNAME': 'cltbld', 07:40:03 INFO - 'MAIL': '/var/mail/cltbld', 07:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:03 INFO - 'MOZ_NO_REMOTE': '1', 07:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:03 INFO - 'NO_EM_RESTART': '1', 07:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:03 INFO - 'PWD': '/builds/slave/test', 07:40:03 INFO - 'SHELL': '/bin/bash', 07:40:03 INFO - 'SHLVL': '1', 07:40:03 INFO - 'TERM': 'linux', 07:40:03 INFO - 'TMOUT': '86400', 07:40:03 INFO - 'USER': 'cltbld', 07:40:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:03 INFO - '_': '/tools/buildbot/bin/python'} 07:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:03 INFO - Downloading/unpacking psutil>=3.1.1 07:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:40:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:05 INFO - Installing collected packages: psutil 07:40:05 INFO - Running setup.py install for psutil 07:40:05 INFO - building 'psutil._psutil_linux' extension 07:40:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:40:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:40:05 INFO - building 'psutil._psutil_posix' extension 07:40:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:40:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:40:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:06 INFO - Successfully installed psutil 07:40:06 INFO - Cleaning up... 07:40:06 INFO - Return code: 0 07:40:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:40: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')]} 07:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40: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')]} 07:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:40: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 mozsystemmonitor==0.3 07:40:06 INFO - Using env: {'DISPLAY': ':0', 07:40:06 INFO - 'HOME': '/home/cltbld', 07:40:06 INFO - 'LANG': 'en_US.UTF-8', 07:40:06 INFO - 'LANGUAGE': 'en_US:en', 07:40:06 INFO - 'LOGNAME': 'cltbld', 07:40:06 INFO - 'MAIL': '/var/mail/cltbld', 07:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:06 INFO - 'MOZ_NO_REMOTE': '1', 07:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:06 INFO - 'NO_EM_RESTART': '1', 07:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:06 INFO - 'PWD': '/builds/slave/test', 07:40:06 INFO - 'SHELL': '/bin/bash', 07:40:06 INFO - 'SHLVL': '1', 07:40:06 INFO - 'TERM': 'linux', 07:40:06 INFO - 'TMOUT': '86400', 07:40:06 INFO - 'USER': 'cltbld', 07:40:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:06 INFO - '_': '/tools/buildbot/bin/python'} 07:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:40:08 INFO - Installing collected packages: mozsystemmonitor 07:40:08 INFO - Running setup.py install for mozsystemmonitor 07:40:08 INFO - Successfully installed mozsystemmonitor 07:40:08 INFO - Cleaning up... 07:40:08 INFO - Return code: 0 07:40:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:08 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 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:40:08 INFO - Using env: {'DISPLAY': ':0', 07:40:08 INFO - 'HOME': '/home/cltbld', 07:40:08 INFO - 'LANG': 'en_US.UTF-8', 07:40:08 INFO - 'LANGUAGE': 'en_US:en', 07:40:08 INFO - 'LOGNAME': 'cltbld', 07:40:08 INFO - 'MAIL': '/var/mail/cltbld', 07:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:08 INFO - 'MOZ_NO_REMOTE': '1', 07:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:08 INFO - 'NO_EM_RESTART': '1', 07:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:08 INFO - 'PWD': '/builds/slave/test', 07:40:08 INFO - 'SHELL': '/bin/bash', 07:40:08 INFO - 'SHLVL': '1', 07:40:08 INFO - 'TERM': 'linux', 07:40:08 INFO - 'TMOUT': '86400', 07:40:08 INFO - 'USER': 'cltbld', 07:40:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:08 INFO - '_': '/tools/buildbot/bin/python'} 07:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:08 INFO - Downloading/unpacking jsonschema==2.5.1 07:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:40:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:40:11 INFO - warning: no files found matching '*.txt' 07:40:11 INFO - no previously-included directories found matching 'build' 07:40:11 INFO - no previously-included directories found matching 'dist' 07:40:11 INFO - no previously-included directories found matching '.git*' 07:40:11 INFO - Installing collected packages: jsonschema, functools32 07:40:11 INFO - Running setup.py install for functools32 07:40:11 INFO - warning: no files found matching '*.txt' 07:40:11 INFO - no previously-included directories found matching 'build' 07:40:11 INFO - no previously-included directories found matching 'dist' 07:40:11 INFO - no previously-included directories found matching '.git*' 07:40:11 INFO - Successfully installed jsonschema functools32 07:40:11 INFO - Cleaning up... 07:40:11 INFO - Return code: 0 07:40:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:40:11 INFO - Using env: {'DISPLAY': ':0', 07:40:11 INFO - 'HOME': '/home/cltbld', 07:40:11 INFO - 'LANG': 'en_US.UTF-8', 07:40:11 INFO - 'LANGUAGE': 'en_US:en', 07:40:11 INFO - 'LOGNAME': 'cltbld', 07:40:11 INFO - 'MAIL': '/var/mail/cltbld', 07:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:11 INFO - 'MOZ_NO_REMOTE': '1', 07:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:11 INFO - 'NO_EM_RESTART': '1', 07:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:11 INFO - 'PWD': '/builds/slave/test', 07:40:11 INFO - 'SHELL': '/bin/bash', 07:40:11 INFO - 'SHLVL': '1', 07:40:11 INFO - 'TERM': 'linux', 07:40:11 INFO - 'TMOUT': '86400', 07:40:11 INFO - 'USER': 'cltbld', 07:40:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:11 INFO - '_': '/tools/buildbot/bin/python'} 07:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:40:11 INFO - Cleaning up... 07:40:11 INFO - Return code: 0 07:40:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:40:11 INFO - Using env: {'DISPLAY': ':0', 07:40:11 INFO - 'HOME': '/home/cltbld', 07:40:11 INFO - 'LANG': 'en_US.UTF-8', 07:40:11 INFO - 'LANGUAGE': 'en_US:en', 07:40:11 INFO - 'LOGNAME': 'cltbld', 07:40:11 INFO - 'MAIL': '/var/mail/cltbld', 07:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:11 INFO - 'MOZ_NO_REMOTE': '1', 07:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:11 INFO - 'NO_EM_RESTART': '1', 07:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:11 INFO - 'PWD': '/builds/slave/test', 07:40:11 INFO - 'SHELL': '/bin/bash', 07:40:11 INFO - 'SHLVL': '1', 07:40:11 INFO - 'TERM': 'linux', 07:40:11 INFO - 'TMOUT': '86400', 07:40:11 INFO - 'USER': 'cltbld', 07:40:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:11 INFO - '_': '/tools/buildbot/bin/python'} 07:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:11 INFO - Downloading/unpacking blobuploader==1.2.4 07:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:13 INFO - Downloading blobuploader-1.2.4.tar.gz 07:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:40:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:40:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:14 INFO - Downloading docopt-0.6.1.tar.gz 07:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:40:14 INFO - Installing collected packages: blobuploader, requests, docopt 07:40:14 INFO - Running setup.py install for blobuploader 07:40:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:40:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:40:14 INFO - Running setup.py install for requests 07:40:15 INFO - Running setup.py install for docopt 07:40:15 INFO - Successfully installed blobuploader requests docopt 07:40:15 INFO - Cleaning up... 07:40:15 INFO - Return code: 0 07:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:15 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 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:40:15 INFO - Using env: {'DISPLAY': ':0', 07:40:15 INFO - 'HOME': '/home/cltbld', 07:40:15 INFO - 'LANG': 'en_US.UTF-8', 07:40:15 INFO - 'LANGUAGE': 'en_US:en', 07:40:15 INFO - 'LOGNAME': 'cltbld', 07:40:15 INFO - 'MAIL': '/var/mail/cltbld', 07:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:15 INFO - 'MOZ_NO_REMOTE': '1', 07:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:15 INFO - 'NO_EM_RESTART': '1', 07:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:15 INFO - 'PWD': '/builds/slave/test', 07:40:15 INFO - 'SHELL': '/bin/bash', 07:40:15 INFO - 'SHLVL': '1', 07:40:15 INFO - 'TERM': 'linux', 07:40:15 INFO - 'TMOUT': '86400', 07:40:15 INFO - 'USER': 'cltbld', 07:40:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:15 INFO - '_': '/tools/buildbot/bin/python'} 07:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:40:15 INFO - Running setup.py (path:/tmp/pip-znoxc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:40:15 INFO - Running setup.py (path:/tmp/pip-L8Uwpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:40:15 INFO - Running setup.py (path:/tmp/pip-2ixTPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:40:15 INFO - Running setup.py (path:/tmp/pip-fXfpPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:40:15 INFO - Running setup.py (path:/tmp/pip-X2yPjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:40:15 INFO - Running setup.py (path:/tmp/pip-tXIUNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:40:15 INFO - Running setup.py (path:/tmp/pip-cQNhmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:40:16 INFO - Running setup.py (path:/tmp/pip-u2L63O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:40:16 INFO - Running setup.py (path:/tmp/pip-I4mm0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:40:16 INFO - Running setup.py (path:/tmp/pip-z55kww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:40:16 INFO - Running setup.py (path:/tmp/pip-iofO7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:40:16 INFO - Running setup.py (path:/tmp/pip-g66EUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:40:16 INFO - Running setup.py (path:/tmp/pip-7JjsBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:40:16 INFO - Running setup.py (path:/tmp/pip-pVnAoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:16 INFO - Running setup.py (path:/tmp/pip-2_4CyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:40:16 INFO - Running setup.py (path:/tmp/pip-dIakOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:40:16 INFO - Running setup.py (path:/tmp/pip-DfrJvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:40:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:40:16 INFO - Running setup.py install for manifestparser 07:40:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:40:16 INFO - Running setup.py install for mozcrash 07:40:16 INFO - Running setup.py install for mozdebug 07:40:17 INFO - Running setup.py install for mozdevice 07:40:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Running setup.py install for mozfile 07:40:17 INFO - Running setup.py install for mozhttpd 07:40:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Running setup.py install for mozinfo 07:40:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Running setup.py install for mozInstall 07:40:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Running setup.py install for mozleak 07:40:17 INFO - Running setup.py install for mozlog 07:40:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Running setup.py install for moznetwork 07:40:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:40:17 INFO - Running setup.py install for mozprocess 07:40:17 INFO - Running setup.py install for mozprofile 07:40:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:40:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:40:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:40:18 INFO - Running setup.py install for mozrunner 07:40:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:40:18 INFO - Running setup.py install for mozscreenshot 07:40:18 INFO - Running setup.py install for moztest 07:40:18 INFO - Running setup.py install for mozversion 07:40:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:40:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:40:18 INFO - Cleaning up... 07:40:18 INFO - Return code: 0 07:40:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:18 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 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:40:18 INFO - Using env: {'DISPLAY': ':0', 07:40:18 INFO - 'HOME': '/home/cltbld', 07:40:18 INFO - 'LANG': 'en_US.UTF-8', 07:40:18 INFO - 'LANGUAGE': 'en_US:en', 07:40:18 INFO - 'LOGNAME': 'cltbld', 07:40:18 INFO - 'MAIL': '/var/mail/cltbld', 07:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:18 INFO - 'MOZ_NO_REMOTE': '1', 07:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:18 INFO - 'NO_EM_RESTART': '1', 07:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:18 INFO - 'PWD': '/builds/slave/test', 07:40:18 INFO - 'SHELL': '/bin/bash', 07:40:18 INFO - 'SHLVL': '1', 07:40:18 INFO - 'TERM': 'linux', 07:40:18 INFO - 'TMOUT': '86400', 07:40:18 INFO - 'USER': 'cltbld', 07:40:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:18 INFO - '_': '/tools/buildbot/bin/python'} 07:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:40:18 INFO - Running setup.py (path:/tmp/pip-rm1tTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:40:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:40:18 INFO - Running setup.py (path:/tmp/pip-PhtbeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:40:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:40:18 INFO - Running setup.py (path:/tmp/pip-zuHoMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:40:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:40:18 INFO - Running setup.py (path:/tmp/pip-ziTqCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:40:19 INFO - Running setup.py (path:/tmp/pip-2QaA5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:40:19 INFO - Running setup.py (path:/tmp/pip-zXedDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:40:19 INFO - Running setup.py (path:/tmp/pip-YB_Apr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:40:19 INFO - Running setup.py (path:/tmp/pip-8Nfk06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:40:19 INFO - Running setup.py (path:/tmp/pip-HG96Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:40:19 INFO - Running setup.py (path:/tmp/pip-Ht68pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:40:19 INFO - Running setup.py (path:/tmp/pip-Of_Ac1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:40:19 INFO - Running setup.py (path:/tmp/pip-yHNXQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:40:19 INFO - Running setup.py (path:/tmp/pip-Wbt7xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:40:19 INFO - Running setup.py (path:/tmp/pip-EHZYSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:19 INFO - Running setup.py (path:/tmp/pip-fk57O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:40:19 INFO - Running setup.py (path:/tmp/pip-OmFNbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:40:19 INFO - Running setup.py (path:/tmp/pip-_1FZl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:40:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:22 INFO - Downloading blessings-1.6.tar.gz 07:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:40:22 INFO - Installing collected packages: blessings 07:40:22 INFO - Running setup.py install for blessings 07:40:22 INFO - Successfully installed blessings 07:40:22 INFO - Cleaning up... 07:40:22 INFO - Return code: 0 07:40:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:40:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:40:22 INFO - Reading from file tmpfile_stdout 07:40:22 INFO - Current package versions: 07:40:22 INFO - argparse == 1.2.1 07:40:22 INFO - blessings == 1.6 07:40:22 INFO - blobuploader == 1.2.4 07:40:22 INFO - docopt == 0.6.1 07:40:22 INFO - functools32 == 3.2.3-2 07:40:22 INFO - jsonschema == 2.5.1 07:40:22 INFO - manifestparser == 1.1 07:40:22 INFO - mozInstall == 1.12 07:40:22 INFO - mozcrash == 1.0 07:40:22 INFO - mozdebug == 0.1 07:40:22 INFO - mozdevice == 0.49 07:40:22 INFO - mozfile == 1.2 07:40:22 INFO - mozhttpd == 0.7 07:40:22 INFO - mozinfo == 0.9 07:40:22 INFO - mozleak == 0.1 07:40:22 INFO - mozlog == 3.4 07:40:22 INFO - moznetwork == 0.27 07:40:22 INFO - mozprocess == 0.24 07:40:22 INFO - mozprofile == 0.28 07:40:22 INFO - mozrunner == 6.13 07:40:22 INFO - mozscreenshot == 0.1 07:40:22 INFO - mozsystemmonitor == 0.3 07:40:22 INFO - moztest == 0.8 07:40:22 INFO - mozversion == 1.4 07:40:22 INFO - psutil == 3.1.1 07:40:22 INFO - requests == 1.2.3 07:40:22 INFO - wsgiref == 0.1.2 07:40:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:22 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 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:40:22 INFO - Using env: {'DISPLAY': ':0', 07:40:22 INFO - 'HOME': '/home/cltbld', 07:40:22 INFO - 'LANG': 'en_US.UTF-8', 07:40:22 INFO - 'LANGUAGE': 'en_US:en', 07:40:22 INFO - 'LOGNAME': 'cltbld', 07:40:22 INFO - 'MAIL': '/var/mail/cltbld', 07:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:22 INFO - 'MOZ_NO_REMOTE': '1', 07:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:22 INFO - 'NO_EM_RESTART': '1', 07:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:22 INFO - 'PWD': '/builds/slave/test', 07:40:22 INFO - 'SHELL': '/bin/bash', 07:40:22 INFO - 'SHLVL': '1', 07:40:22 INFO - 'TERM': 'linux', 07:40:22 INFO - 'TMOUT': '86400', 07:40:22 INFO - 'USER': 'cltbld', 07:40:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:22 INFO - '_': '/tools/buildbot/bin/python'} 07:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:40:22 INFO - Cleaning up... 07:40:22 INFO - Return code: 0 07:40:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:40:22 INFO - Using env: {'DISPLAY': ':0', 07:40:22 INFO - 'HOME': '/home/cltbld', 07:40:22 INFO - 'LANG': 'en_US.UTF-8', 07:40:22 INFO - 'LANGUAGE': 'en_US:en', 07:40:22 INFO - 'LOGNAME': 'cltbld', 07:40:22 INFO - 'MAIL': '/var/mail/cltbld', 07:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:22 INFO - 'MOZ_NO_REMOTE': '1', 07:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:22 INFO - 'NO_EM_RESTART': '1', 07:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:22 INFO - 'PWD': '/builds/slave/test', 07:40:22 INFO - 'SHELL': '/bin/bash', 07:40:22 INFO - 'SHLVL': '1', 07:40:22 INFO - 'TERM': 'linux', 07:40:22 INFO - 'TMOUT': '86400', 07:40:22 INFO - 'USER': 'cltbld', 07:40:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:22 INFO - '_': '/tools/buildbot/bin/python'} 07:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:40:22 INFO - Cleaning up... 07:40:22 INFO - Return code: 0 07:40:22 INFO - Running post-action listener: _resource_record_post_action 07:40:22 INFO - Running post-action listener: _start_resource_monitoring 07:40:23 INFO - Starting resource monitoring. 07:40:23 INFO - [mozharness: 2017-01-30 15:40:23.005058Z] Finished create-virtualenv step (success) 07:40:23 INFO - [mozharness: 2017-01-30 15:40:23.005518Z] Running install step. 07:40:23 INFO - Running pre-action listener: _resource_record_pre_action 07:40:23 INFO - Running main action method: install 07:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:40:23 INFO - Reading from file tmpfile_stdout 07:40:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:40:23 INFO - Reading from file tmpfile_stdout 07:40:23 INFO - Output received: 07:40:23 INFO - Usage: mozinstall [options] installer 07:40:23 INFO - Options: 07:40:23 INFO - -h, --help show this help message and exit 07:40:23 INFO - -d DEST, --destination=DEST 07:40:23 INFO - Directory to install application into. [default: 07:40:23 INFO - "/builds/slave/test"] 07:40:23 INFO - --app=APP Application being installed. [default: firefox] 07:40:23 INFO - mkdir: /builds/slave/test/build/application 07:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:40:39 INFO - Reading from file tmpfile_stdout 07:40:39 INFO - Output received: 07:40:39 INFO - /builds/slave/test/build/application/firefox/firefox 07:40:39 INFO - Running post-action listener: _resource_record_post_action 07:40:39 INFO - [mozharness: 2017-01-30 15:40:39.545892Z] Finished install step (success) 07:40:39 INFO - [mozharness: 2017-01-30 15:40:39.546164Z] Running run-tests step. 07:40:39 INFO - Running pre-action listener: _resource_record_pre_action 07:40:39 INFO - Running main action method: run_tests 07:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:40:39 INFO - Python 2.7.3 07:40:39 INFO - Return code: 0 07:40:39 INFO - grabbing minidump binary from tooltool 07:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:39 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 0x2140850>, '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 0x20b56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:40:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:40:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:40:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:40:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:40:39 INFO - Return code: 0 07:40:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:40:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:40:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:40:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:40:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:40:39 INFO - Using env: {'DISPLAY': ':0', 07:40:39 INFO - 'HOME': '/home/cltbld', 07:40:39 INFO - 'LANG': 'en_US.UTF-8', 07:40:39 INFO - 'LANGUAGE': 'en_US:en', 07:40:39 INFO - 'LOGNAME': 'cltbld', 07:40:39 INFO - 'MAIL': '/var/mail/cltbld', 07:40:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:40:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:39 INFO - 'MOZ_NO_REMOTE': '1', 07:40:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:39 INFO - 'NO_EM_RESTART': '1', 07:40:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:39 INFO - 'PWD': '/builds/slave/test', 07:40:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:40:39 INFO - 'SHELL': '/bin/bash', 07:40:39 INFO - 'SHLVL': '1', 07:40:39 INFO - 'TERM': 'linux', 07:40:39 INFO - 'TMOUT': '86400', 07:40:39 INFO - 'USER': 'cltbld', 07:40:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768', 07:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:39 INFO - '_': '/tools/buildbot/bin/python'} 07:40:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:40:39 INFO - mozversion application_buildid: 20170130145805 07:40:39 INFO - mozversion application_changeset: b332a2a48c1bcea90276955b0a6ccd0afbb6f569 07:40:39 INFO - mozversion application_display_name: Nightly 07:40:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:40:39 INFO - mozversion application_name: Firefox 07:40:39 INFO - mozversion application_remotingname: firefox 07:40:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:40:39 INFO - mozversion application_vendor: Mozilla 07:40:39 INFO - mozversion application_version: 54.0a1 07:40:39 INFO - mozversion platform_buildid: 20170130145805 07:40:39 INFO - mozversion platform_changeset: b332a2a48c1bcea90276955b0a6ccd0afbb6f569 07:40:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:40:39 INFO - mozversion platform_version: 54.0a1 07:40:39 INFO - using testdate: 1485790839 07:40:39 INFO - actual date: 1485790839 07:40:39 INFO - starting webserver on 'localhost:36932' 07:40:39 INFO - SUITE-START | Running 2 tests 07:40:39 INFO - TEST-START | dromaeo_css 07:40:39 INFO - operating with platform_type : linux_ 07:40:39 INFO - Initialising browser for dromaeo_css test... 07:40:39 INFO - TEST-INFO | started process 9805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpraABvH/profile http://localhost:36932/getInfo.html) 07:40:43 INFO - PROCESS | 9805 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 07:40:44 INFO - PROCESS | 9805 | __metrics Screen width/height:1600/1200 07:40:44 INFO - PROCESS | 9805 | colorDepth:24 07:40:44 INFO - PROCESS | 9805 | Browser inner width/height: 1024/697 07:40:44 INFO - PROCESS | 9805 | __metrics 07:40:44 INFO - PROCESS | 9805 | 1485790844851 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 07:40:45 INFO - PROCESS | 9805 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:40:45 INFO - PROCESS | 9805 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:40:45 INFO - PROCESS | 9805 | console.error: PushService: 07:40:45 INFO - PROCESS | 9805 | stateChangeProcessEnqueue: Error transitioning state 07:40:45 INFO - PROCESS | 9805 | UnknownError 07:40:46 INFO - TEST-INFO | 9805: exit 0 07:40:46 INFO - Browser initialized. 07:40:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:40:46 INFO - TEST-INFO | started process 9887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpraABvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:40:58 INFO - PROCESS | 9887 | RSS: Main: 153489408 07:40:58 INFO - PROCESS | 9887 | 07:44:03 INFO - PROCESS | 9887 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36932/tests/dromaeo/cssquery-ext.html) 07:44:05 INFO - PROCESS | 9887 | RSS: Main: 282923008 07:44:05 INFO - PROCESS | 9887 | 07:45:47 INFO - PROCESS | 9887 | ************************* 07:45:47 INFO - PROCESS | 9887 | A coding exception was thrown and uncaught in a Task. 07:45:47 INFO - PROCESS | 9887 | 07:45:47 ERROR - PROCESS | 9887 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:45:47 INFO - PROCESS | 9887 | Full stack: 07:45:47 INFO - PROCESS | 9887 | ************************* 07:47:07 INFO - PROCESS | 9887 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-ext.html (next: http://localhost:36932/tests/dromaeo/cssquery-jquery.html) 07:47:08 INFO - PROCESS | 9887 | RSS: Main: 239009792 07:47:08 INFO - PROCESS | 9887 | 07:50:10 INFO - PROCESS | 9887 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36932/tests/dromaeo/cssquery-mootools.html) 07:50:11 INFO - PROCESS | 9887 | RSS: Main: 184795136 07:50:11 INFO - PROCESS | 9887 | 07:53:13 INFO - PROCESS | 9887 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36932/tests/dromaeo/cssquery-prototype.html) 07:53:14 INFO - PROCESS | 9887 | RSS: Main: 185929728 07:53:14 INFO - PROCESS | 9887 | 07:56:17 INFO - PROCESS | 9887 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36932/tests/dromaeo/cssquery-yui.html) 07:56:17 INFO - PROCESS | 9887 | RSS: Main: 187002880 07:56:17 INFO - PROCESS | 9887 | 07:59:20 INFO - PROCESS | 9887 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-yui.html (next: http://localhost:36932/tests/dromaeo/cssquery-dojo.html) 07:59:21 INFO - PROCESS | 9887 | RSS: Main: 279355392 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - PROCESS | 9887 | __start_tp_report 07:59:21 INFO - PROCESS | 9887 | _x_x_mozilla_page_load 07:59:21 INFO - PROCESS | 9887 | _x_x_mozilla_page_load_details 07:59:21 INFO - PROCESS | 9887 | |i|pagename|runs| 07:59:21 INFO - PROCESS | 9887 | |0;dojo.html;2473.035516148702;2544.284053766753;2559.334573011017;2563.102913980107;2570.9357266068346;4512.390827238321;4581.67928245023;4588.862334129977;4593.862184134473;4620.584147426731;4620.930686039712;4621.168189725848;4630.444346678395;4653.3717948077;4726.314684370765;4288.463942007249;4288.9785551072355;4298.677599180059;4320.56794320567;4385.122975404915;4398.230309695807;4423.181711383389;4423.86728398147;4444.799984000711;4446.444194475691;4216.072464057902;4256.2764330063965;4329.047609525899;4359.193549193377;4365.301551751721;4233.724807887477;4264.957350426487;4271.551487093841;4285.785710714452;4350.543192964725;4254.127903779718;4257.276263035261;4260.275753121977;4289.1636130954475;4303.31147016479;4609.446866376023;4617.2381557043045;4641.396618439581;4654.4647365553055;4691.366665500182;4982.526659967298;5018.7992480300745;5042.974785126051;5047.419546752134;5059.241113832918;4972.676776009584;4986.750662466862;5007.474215207387;5077.035363280965;5077.390713114413;4690.835820746258;4708.81164753406;4711.646626503026;4712.269598212282;4735.905281894343;5124.487551244845;5135.897282054413;5138.511841375063;5141.0232055909255;5182.119039763249;4853.708777473363;4891.633127515451;4892.951070489321;4928.112939670894;4931.9753401232765;4933.1613625683;4975.925361119586;4978.800847966041;5041.117804384218;5080.364954380702;4934.605231581465;4943.110240156806;4971.477994810565;4977.477364876636;4984.7258400788305;4982.501749824988;5051.116054690415;5055.51972562606;5098.490150984871;5099.719515426613;4213.810378532973;4222.662187025031;4255.042615411569;4258.233517966733;4299.269124248885;3554.680078792921;3580.6419358063986;3611.6930060944587;3640.9453858192146;3657;4342.522322544518;4346.500152482442;4371.409859668967;4374.868753937387;4384.846530371422;5084.949150508522;5088.211327244283;5088.262201980692;5089.185730283211;5136.974315128476;4231.915361692749;4264.424302719093;4280.978595107004;4350.869473915787;4355.259605867011;4486.753228572395;4497.257952437811;4521.231390663595;4553.043860789271;4556.157110934488;4699.177643912233;4701.059788042337;4701.929471057869;4722.480527141943;4793.736344501086;4891.1685013548495;4922.8769280768265;5021.07110184617;5038.748062596782;5058.367704036996;4696.38946936896;4733.810647574059;4740.19416699155;4759.809607615656;4786.880327991828;5005.674631148963;5009.524095210949;5012.248162775612;5013.24801279811;5059.46875578059;5062.443131255633;5064.72144032067;5070.442251352274;5078.796848126033;5119.846404607868;4751.667383283275;4847.5394837490385;4855.587275081516;4884.340614017205;4897.853064408074;4887.706737595756;4888.0468308679465;4896.290037944407;4930.186519224288;4935.851924442272;4678.321643361762;4715.6227501799085;4717.716936983792;4843.200871856105;4843.4430040545785;4888.2178851383605;4902.754862256802;4907.092187945242;4957.429895562056;4987.12725273083;4818.445878723992;4820.927686084641;4830.227163653799;4838.612910967044;4850.490698476609 07:59:21 INFO - PROCESS | 9887 | |1;ext.html;542.9429909859465;568.5167607533596;587.5241054745653;598.963792638735;601.1943995046637;29443.55834662479;39647.40528892069;41857.372139417894;42029;45366.546334536644;43492.3476147858;43749.12501749963;43785;43802.7809860951;43981.7800910995;7600.657970391318;7774.067111946574;7774.144844067148;7775.1447340792465;7778.8444231115345;7437.628118594076;7640.235976402343;10074.244431667617;10331.690049298495;10337.896621033806;10285.382877027365;10289.742756431075;10310.9484452578;10346.37921724699;10353.637622683207;10265.692029239135;10315.948420257851;10322.7419314517;10328.793424131476;10336.94831525845;10120.291579589431;10198.286119971604;10198.898011019943;10204.846927296096;10207.489625518694;39562.802185989174;39842.80078599617;39863.60136398628;39953.800230998946;39954.60045399567;3617.7648452850744;3687.520622319081;3703.370427027412;3703.6296370363016;3725.217704282104;28697.71302286992;29203.707962920525;29207.56188657172;29218.561721574195;29255;3422.8117453540044;3487.267673788482;3521.2781379817334;3695.224002959382;3709.3879509880835;233511;234705;234899;236083;236762;55205.72397138069;55476.72261638666;55573;55577.1663425049;55693.72153139208;57566;57989.710051449474;58200.4179958195;58223.417765821796;58257.70871145702;14488.565343039725;14938;15001.924990374979;15023.624409389853;15039.774403383957;10035.598576057022;11133.832992504957;11197.66407007791;11202.215844890943;11210.27133236337;14917;17468.82531174672;17651.117444127744;17836.286548538174;18266.26934922588;5920.851978700567;5925.170476133345;5991.820245392645;6127.5404344674325;6158.846028849314;765.0289490526494;781.4646966827742;785.654312102673;792.7899106736719;803.8665481670816;27397.589036164474;27933.580996285073;28446;28657.713422865505;28939.42121157565;882.8852249207562;957.9425234485814;959.3668179001826;969.3941286695815;977.936553871331;14811.629709257355;15105.3202605883;15245.923770381078;15334.003289786127;15503.689926201412;335589;339103;339912;340051;341988;52324.476755232725;52330.21504677433;52366.738166308925;52562.737186313825;52598.47401526012;1190.4108015798831;1219.5304807648943;1247.3015111537386;1254.3665448948223;1255.7237407770276;25841.353966150997;26822.731772682022;27018.864905675346;27118.864405677847;27354.45291094207;43314.35028474638;43864.780676096416;43924.99999999872;43954;44035.77982110069;271411;271455;271538;273367.96476194;273901;32266.677333226366;36003;36565.45151822778;36809.63190368062;36954.815225923696;34352;42072.38034695228;42724.5727542733;46768.53231467642;47260.7636961813;36140.63859361373;36670.89987300385;36692.81653591715;38496.422553661156;38827.2234555313;36581.63418365889;36877.63122368742;37295.62704372922;37323.253534929696;37869.81065094767;34920.82539587286;35959.460608090376;36240.63759362478;36458;36638.450423244205;30899.691003090582;33611.327773444886;33654.495182571794;33661.663383365856;33708.49437258394;22793.544129117658;23953.401164971016;24932.750672493043;25333.61999569971;25382.492350152523 07:59:21 INFO - PROCESS | 9887 | |2;jquery.html;379.01834249294325;379.7626483447845;386.5516001438332;399.18566125104786;407.7879502658616;17259.74110388345;18319.63360732788;18872.811271887276;19012.61974760504;19054.14256358464;17961.550961225978;18234.0882955852;18551.165197566108;18981;18996.525086872836;5051.166557518023;5122.436531981489;5317.308749862513;5328.573714102882;5329.360476742796;5085.313482679828;5231.163013917774;5236.057509648262;5238.030964271622;5244.947550524503;5210.270562121287;5214;5214.113600687892;5214.791408343662;5222.268882356473;5364.651297665659;5608.971955140219;5624.91562626561;5716.456936591017;5718.79984200551;5506.5870059745275;5590.91613625796;5597.692126933017;5604.1593760935775;5742.425757424266;13195.142315749541;13208.471661133639;13357.799633005512;13360.599182024554;13361.532346367927;2330.557194133109;2458.3362492127026;2464.134853939583;2467.3091534370405;2482.4290413205063;9228.676996305097;9822.116009559102;9823.263255255884;10473.47632618366;13091.803622945568;1706.6757316110024;1761.6388640328703;1770.0530216334328;1807.2138619700472;1811.6829554827852;78738.60630696866;81953;82024.76962845621;83270.16729832685;84002.57998709967;10840.186985976083;10840.373943908318;10921.726956825984;10972.725681858017;11149.665510034712;14704;15735.213239337987;15758.369665213493;15780.053196808229;15792.842071579367;5903.291605007341;5913.49735272498;6704.899426508607;7553.697852085965;7811.960940195263;6991.475639327071;7051.330123638246;7238.27617238272;7245.094363204599;7261.3101755333155;4575.336576196433;4687.109449204709;4698.119171803418;4831;4844.660873738804;1851.2039822876293;1955.5502234486148;1980.3167907072036;1988.413418041681;1997.5605366819277;742.669512067125;763.8701420758484;767.370755980091;775.3796962430033;793.5556088590408;17665.290289039447;18233.544161395806;18400.63198736018;18652.44042678722;18696.813031869508;748.2367984655621;761.9847603048019;767.9270469305407;779.3531368963746;786.8111653203305;9553.379030363143;10439.425831579336;10732.946335268274;10815.297005694605;11069.391183484986;462672;485176;486019;507971;521142;63908.36091639117;66143.66928165329;96473;98631.50684246533;102445.99857029291;894.5974311559825;1002.7142264454595;1006.5168719014914;1007.2244371833647;1009.3792317724547;16084.67830643404;16125.193740313172;16398.426055088014;17294.135293235035;17842.46472605824;39709;40816.591834082465;41876.16247674968;42329.57670423256;44211;53760;54615;55009.1748623779;55858.16212756731;56611.86776264534;5254.395744489432;6412.711427985659;6904.4131248844415;7854.057513098464;8244.958775206085;10977.451127443435;12174.452149653463;12299.200551964093;12652.746945061232;12676.619701408972;10441.843372349269;10564.260501764802;10812.56749730002;10985.505652245509;11055.834162487408;10651.147908167482;10769.892301076889;10772.946135269274;10855;10951.56193752241;10567.365958042543;10852.891471085188;10974.286671366335;11063.446827658423;11464.656060318204;7748.92251077482;7808.375329973702;7897.802554936173;8004.279614834692;8272.545010024265;10067.89253182164;10084.193264538966;10792.622258220925;11072.723181920517;11295.548178072784 07:59:21 INFO - PROCESS | 9887 | |3;mootools.html;1294.3851670456531;1302.5441095616536;1303.6414985878882;1308.4504508106595;1317.0912070671238;6975.790726278207;7402.740904068359;7404.1855395906405;7408.444366672501;7409.14794798597;6388.169537960071;6680.164979377578;6874.8968765468435;7164.677589508472;7165.605891675956;2117.6717608770628;2145.2169957965307;2149.9892500537476;2152.9354119376367;2153;2148.9140434382607;2175.3147758456116;2178.5098352870637;2180.269609680751;2191.0359441845617;1820.9635807283846;1883.406726881035;2071.5028393185676;2093.518490747129;2144.131626691185;2144.2923835134447;2147.8174355179826;2148.2803260907613;2149.817265532416;2152.6448136057534;2074.087401543316;2112.355731501891;2116.3439333806414;2128.563644452899;2137.78622137785;7354.191038985708;7413.036305280333;7419.146798118231;7421;7444.181140074587;4372.234858899712;4488.169688607618;4494.101179764028;4495.730256184606;4501.572350626685;2887.7978541502102;2893.2985084206694;2946.2634341414646;2946.6611339695783;3023.576699262105;1105.5025238642563;1136.6987748246638;1160.3502038858182;1178.393127539318;1201.3152503073252;9552.235821134293;9558.522073896278;9574.664886729;9585.712428627083;9586.904130958741;3730.515033045687;3890.902727431837;3956.4263181838473;3990.2418540477215;4151.813168407429;8466.830663386821;8469.237768600855;8498.830023399498;8505;8516.361272904556;4597.310403439444;4600.102979918884;4602.976985115053;4603.056373443436;4607.654425918069;3667.6882464990776;3812.2375524895133;3988.660963818108;4144.979275103605;4244.278472659656;3475.983929320988;3590.9461358079648;3663.6336366363153;3683.208110256308;3695.796731179757;1148.6324376199536;1184.1888306510068;1195.7847587434171;1209.2200530657676;1212.4543955220186;690.9689063992132;698.0924797762888;787.8463699578527;791.8376732769768;809.5426084262373;4844.660873738875;4944.431390390151;5032.924506132411;5034.597232221414;5113.488651134857;866.6143566113145;889.1686273334324;893.7586851550045;939.7321763297427;968.070652173921;3342.766006379579;3354.6477619849566;3427.725781937439;3495.353359628477;3593.4070878304788;8503.702370417006;8642.740717778477;8790.516521591373;8800;8808.559572021373;8734.694285700098;8856.955715221511;8857.557122143997;8867.423617464845;8890.288776897833;6449.871002580016;6765.797026089225;6892.862142757117;6898.241193468714;6899.931000689929;5030.748462576929;5058.595312374928;5242.108841496878;5304.628675992643;5479.3424789023975;7852.293293603603;7914.485558438683;7990.320822730133;8089.757307280791;8130.796730081795;7591.4685971981435;7747.109082455364;7812.140664526783;7836.294733473786;8038.678452862054;5816.73824677882;6018.488428483628;6205.596636218631;6370.96814515943;6375.521835862236;6708.295628959084;6967.407770339578;6984.3364880336285;7137.678804453708;7151.2133665297815;6299.96850015747;6365.077063825812;6396.744130234739;6628.801135965929;6640.833979150367;6309.558330916791;6318.62088274705;6333.714982825692;6348.873022539431;6354.205724284465;5297.152455607084;5364.597655175956;5377.919331209957;5381.300430943952;5384.5423139032055;4279;4284.078923031563;4324.610785029363;4379.277419225919;4452.287633978548;4404.823807047682;4423.668224883211;4503.662225333048;4554.316852472156;4592.632589392773 07:59:21 INFO - PROCESS | 9887 | |4;prototype.html;357.23195130469486;361.84983231958734;369.9870504532342;370.3444902522534;379.546442001808;4641.419822522184;4660.254359302512;4686.671932964685;4714.269288260317;4717.3867397238355;4472.3515090311885;4632.281996290572;4632.629389648829;4655.766221951178;4687.953120468795;3302.6036875574964;3699.8890033299044;3754.6433088856515;3808.8857334280015;3820.9426858597144;3825.0683404880497;3825.387937929932;3825.5791862895057;3831.885043448687;3837.846486140551;3813.6652171739947;3823.483829682999;3823.961760382402;3825.2540754552874;3834.94247586285;3666.7249956253386;3700.962990370089;3757;3794.4877441545314;3822.732408731376;3390.135515443546;3407.6081250656;3426.3147370525994;3427.8971630850865;3445.3798316303055;4558.361829343895;4565.52062033485;4598.839040633595;4607.884802879955;4609.216433206329;3993.560708322082;4337.587929146726;4348.152110338485;4349.69552131351;4353.346997950302;4887.975560122212;4937.086638971802;4939.58013568847;4944.728039957837;4951.232558953368;3602.369585322558;3607.2424790793966;3608.0516521078584;3610.584782749991;3634.945475817865;4942.975285123552;5040.168372218543;5069.77186026626;5183.896322073575;5221.39953905302;3576.2847430514003;3578.284343131332;3589.425691889285;3603.783673041061;3613.9819300903328;3650;3655.634436556323;3657.9451308230396;3661.212839239576;3668.4313931340685;4159.752074377675;4163.354680024601;4174.373843923436;4201.68487363449;4207.936880946788;4728.17256980034;4900.848300649344;4926.137925863031;4934.679245849008;4936.679115857458;1226.1600803449664;1240.765438388791;1242.2981015726086;1249.6563445052502;1265.9746805063846;810.3274282345639;858.2704701004096;863.5164307987421;873.886394768676;879.8636211387245;4124.876253712393;4194.077302993336;4214.356401003611;4219.451471308772;4219.578042195756;4902.558769710743;4931.3835770528685;4936.038376973859;4958.181899986534;5012.924806127911;4206.936895946563;4219.535851056381;4223.128272774543;4227.112306415625;4262.381954616563;2460.458699086198;2611.7779988701172;2620.2794231586468;2623.108143231272;2623.5671114266315;4605.447346318463;4631.62946964242;4632.444106707217;4633.351330813689;4648.465426475931;5061.468545802712;5062.924056139161;5070.6957582545165;5073.315102461194;5080.26336181259;4305.354196870495;4551.658625603093;4605.930911036337;4607.447106347193;4616.976915115403;4910.729909854849;4915.18899381598;4923.581495572773;4923.606111510999;4930.556249937523;4851.80592776285;4861;4864.92702609454;4875.366202393808;4890.413150421972;4442.577955094261;4595.862124136282;4619.145458090264;4622.306654001926;4627.699199552018;3547.481288285346;3554.7689400188906;3561.074120728681;3569.839357228983;3569.8929032129076;4939.703617782944;4948.901021979468;4963.855180923969;4969.229769385751;4992.775325110451;4653.557911998355;4780.784864681028;4783.4408591403435;4785.856424307276;4831.323614693875;4759.833405830779;4764.356811830358;4767.33257343979;4770.379850619397;4788.832390866303;4717.127331443694;4744.620430365631;4747.311639812277;4750.881227969328;4759.262314341283;4577.009001084539;4843.539863712942;4847.345608342828;4957.132501812241;4994.725290108933;4851.967520299812;4868.342773725643;4870.683405578626;4874.293227481924;4878.707277563358 07:59:21 INFO - PROCESS | 9887 | |5;yui.html;666.8332916770808;684.2131548718976;727.8689835829549;750.4634186556611;761.7600455856407;12655;13667.93166034171;13680.863191368084;13698.315084245798;13829.308534573269;13034;13189.142705724122;13206.141600795965;13217.735645287088;13261.93369033156;638.3616383616384;654.6399480285847;770.1259070954451;779.154617240295;794.0947320055142;793.2939683681499;801.0147518552184;802.6508468816055;802.8193656427316;803.2730379006979;848.8090179709546;849.0321034021221;849.7026040885702;849.7408290471403;849.9575021248913;680.7549282258383;699.1994166679175;831.8710599857031;847.2374862623626;849.8810166576684;613.8158552434252;617.527591392585;618.7463140112533;618.7679620142446;618.8824123416537;13195.538156164585;13216.735665286737;13225.537106201333;13236.602901912958;13299.335033248395;13026.86973130266;13070.281134537596;13171.20972741629;13216.474516817863;13232.470701171942;11934.880651193464;11963.700907477296;11974.281543107354;12245.816312755316;12313.507459701601;4036.8183431745642;4039.575844536311;4166.687498437599;4219.493660760729;4299.591538803808;65306.67346663236;65325;65336;65351.346486535476;65485.67257163731;9858.95070524657;9962;10307.690769276935;10485.421498087211;10542.894571054192;17797.555061123574;18739.437816865517;18749.062546872603;19188.232470701296;19763.505912352306;6459.483241340681;6611.140551728245;6650.9667451662435;6696.698648560827;6880.552764070319;3332.583427071616;3405.846736896796;3416.9145771355916;3438.054535002894;3490.406630872707;3019.1999120233154;3058.464768665519;3071.6314042315066;3087.505999040143;3108;524.7087866234276;527.0776141751934;527.543674721371;534.1507003863875;538.4480907070206;621.4593303825701;636.5830381100386;642.2742301199614;642.331974746268;652.6769249221666;9164.266858651292;9446.244300455946;9547.52262386878;9613.951930240304;9787.755306117404;598.1924402057275;614.173936056004;625.5746092657037;634.1850721822436;637.4581605635173;4308.526062133163;4485.349624304523;4529.750863702462;4549;4549.6360291176625;50899.49100509022;51609.483905160465;66089.66955165194;67459;67460.66269668621;56870.71564642233;58158;59024.7048764762;59189.112163317586;60252.39747602556;52508;54023.45976540184;54570.45429545654;54675.72662136664;55078.44921550733;8678.262347700516;8882;8951.373403861668;9016.459012459274;9119.5440227987;36917.26165476622;37470.625293747806;38104;38499.80750096231;38890.2221955565;45083.77458112819;45870.31194532018;46007;46664.53335466602;47811.521884780705;10023.097921187129;10261.2304077196;10278.023587759151;10471.738206544593;10518.78962420732;11158.218924675195;12586.622401327975;12875.613731588068;13120.475180992653;13389;12126.636200913987;12478.875211248134;12485.812712809497;12602.054845886778;13070.934645326712;12050.660737928176;12494.500219991462;12497.937510312753;12668.176568523017;13076.673083172996;12113.636590902288;12301.630951071482;12571.811422828481;12660.430280637578;13040.347982601023;10263.281570290008;10311.484425778832;10313.071823535918;10869.565217391215;11002.669919902415;9875.40747555149;10336.276460647683;10386.844197336895;10416.270861039655;10431.739206519898 07:59:21 INFO - PROCESS | 9887 | __end_tp_report 07:59:21 INFO - PROCESS | 9887 | __start_cc_report 07:59:21 INFO - PROCESS | 9887 | _x_x_mozilla_cycle_collect,1317 07:59:21 INFO - PROCESS | 9887 | __end_cc_report 07:59:21 INFO - PROCESS | 9887 | __startTimestamp1485791961072__endTimestamp 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - PROCESS | 9887 | ------- Summary: start ------- 07:59:21 INFO - PROCESS | 9887 | Number of tests: 6 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - PROCESS | 9887 | [#0] dojo.html Cycles:165 Average:4630.84 Median:4733.81 stddev:504.98 (10.7%) stddev-sans-first:477.32 07:59:21 INFO - PROCESS | 9887 | Values: 2473.0 2544.3 2559.3 2563.1 2570.9 4512.4 4581.7 4588.9 4593.9 4620.6 4620.9 4621.2 4630.4 4653.4 4726.3 4288.5 4289.0 4298.7 4320.6 4385.1 4398.2 4423.2 4423.9 4444.8 4446.4 4216.1 4256.3 4329.0 4359.2 4365.3 4233.7 4265.0 4271.6 4285.8 4350.5 4254.1 4257.3 4260.3 4289.2 4303.3 4609.4 4617.2 4641.4 4654.5 4691.4 4982.5 5018.8 5043.0 5047.4 5059.2 4972.7 4986.8 5007.5 5077.0 5077.4 4690.8 4708.8 4711.6 4712.3 4735.9 5124.5 5135.9 5138.5 5141.0 5182.1 4853.7 4891.6 4893.0 4928.1 4932.0 4933.2 4975.9 4978.8 5041.1 5080.4 4934.6 4943.1 4971.5 4977.5 4984.7 4982.5 5051.1 5055.5 5098.5 5099.7 4213.8 4222.7 4255.0 4258.2 4299.3 3554.7 3580.6 3611.7 3640.9 3657.0 4342.5 4346.5 4371.4 4374.9 4384.8 5084.9 5088.2 5088.3 5089.2 5137.0 4231.9 4264.4 4281.0 4350.9 4355.3 4486.8 4497.3 4521.2 4553.0 4556.2 4699.2 4701.1 4701.9 4722.5 4793.7 4891.2 4922.9 5021.1 5038.7 5058.4 4696.4 4733.8 4740.2 4759.8 4786.9 5005.7 5009.5 5012.2 5013.2 5059.5 5062.4 5064.7 5070.4 5078.8 5119.8 4751.7 4847.5 4855.6 4884.3 4897.9 4887.7 4888.0 4896.3 4930.2 4935.9 4678.3 4715.6 4717.7 4843.2 4843.4 4888.2 4902.8 4907.1 4957.4 4987.1 4818.4 4820.9 4830.2 4838.6 4850.5 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - PROCESS | 9887 | [#1] ext.html Cycles:180 Average:45375.71 Median:35981.23 stddev:74631.05 (207.4%) stddev-sans-first:74764.49 07:59:21 INFO - PROCESS | 9887 | Values: 542.9 568.5 587.5 599.0 601.2 29443.6 39647.4 41857.4 42029.0 45366.5 43492.3 43749.1 43785.0 43802.8 43981.8 7600.7 7774.1 7774.1 7775.1 7778.8 7437.6 7640.2 10074.2 10331.7 10337.9 10285.4 10289.7 10310.9 10346.4 10353.6 10265.7 10315.9 10322.7 10328.8 10336.9 10120.3 10198.3 10198.9 10204.8 10207.5 39562.8 39842.8 39863.6 39953.8 39954.6 3617.8 3687.5 3703.4 3703.6 3725.2 28697.7 29203.7 29207.6 29218.6 29255.0 3422.8 3487.3 3521.3 3695.2 3709.4 233511.0 234705.0 234899.0 236083.0 236762.0 55205.7 55476.7 55573.0 55577.2 55693.7 57566.0 57989.7 58200.4 58223.4 58257.7 14488.6 14938.0 15001.9 15023.6 15039.8 10035.6 11133.8 11197.7 11202.2 11210.3 14917.0 17468.8 17651.1 17836.3 18266.3 5920.9 5925.2 5991.8 6127.5 6158.8 765.0 781.5 785.7 792.8 803.9 27397.6 27933.6 28446.0 28657.7 28939.4 882.9 957.9 959.4 969.4 977.9 14811.6 15105.3 15245.9 15334.0 15503.7 335589.0 339103.0 339912.0 340051.0 341988.0 52324.5 52330.2 52366.7 52562.7 52598.5 1190.4 1219.5 1247.3 1254.4 1255.7 25841.4 26822.7 27018.9 27118.9 27354.5 43314.4 43864.8 43925.0 43954.0 44035.8 271411.0 271455.0 271538.0 273368.0 273901.0 32266.7 36003.0 36565.5 36809.6 36954.8 34352.0 42072.4 42724.6 46768.5 47260.8 36140.6 36670.9 36692.8 38496.4 38827.2 36581.6 36877.6 37295.6 37323.3 37869.8 34920.8 35959.5 36240.6 36458.0 36638.5 30899.7 33611.3 33654.5 33661.7 33708.5 22793.5 23953.4 24932.8 25333.6 25382.5 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - PROCESS | 9887 | [#2] jquery.html Cycles:180 Average:28190.84 Median:403.49 stddev:81302.52 (20150.0%) stddev-sans-first:81503.77 07:59:21 INFO - PROCESS | 9887 | Values: 379.0 379.8 386.6 399.2 407.8 17259.7 18319.6 18872.8 19012.6 19054.1 17961.6 18234.1 18551.2 18981.0 18996.5 5051.2 5122.4 5317.3 5328.6 5329.4 5085.3 5231.2 5236.1 5238.0 5244.9 5210.3 5214.0 5214.1 5214.8 5222.3 5364.7 5609.0 5624.9 5716.5 5718.8 5506.6 5590.9 5597.7 5604.2 5742.4 13195.1 13208.5 13357.8 13360.6 13361.5 2330.6 2458.3 2464.1 2467.3 2482.4 9228.7 9822.1 9823.3 10473.5 13091.8 1706.7 1761.6 1770.1 1807.2 1811.7 78738.6 81953.0 82024.8 83270.2 84002.6 10840.2 10840.4 10921.7 10972.7 11149.7 14704.0 15735.2 15758.4 15780.1 15792.8 5903.3 5913.5 6704.9 7553.7 7812.0 6991.5 7051.3 7238.3 7245.1 7261.3 4575.3 4687.1 4698.1 4831.0 4844.7 1851.2 1955.6 1980.3 1988.4 1997.6 742.7 763.9 767.4 775.4 793.6 17665.3 18233.5 18400.6 18652.4 18696.8 748.2 762.0 767.9 779.4 786.8 9553.4 10439.4 10732.9 10815.3 11069.4 462672.0 485176.0 486019.0 507971.0 521142.0 63908.4 66143.7 96473.0 98631.5 102446.0 894.6 1002.7 1006.5 1007.2 1009.4 16084.7 16125.2 16398.4 17294.1 17842.5 39709.0 40816.6 41876.2 42329.6 44211.0 53760.0 54615.0 55009.2 55858.2 56611.9 5254.4 6412.7 6904.4 7854.1 8245.0 10977.5 12174.5 12299.2 12652.7 12676.6 10441.8 10564.3 10812.6 10985.5 11055.8 10651.1 10769.9 10772.9 10855.0 10951.6 10567.4 10852.9 10974.3 11063.4 11464.7 7748.9 7808.4 7897.8 8004.3 8272.5 10067.9 10084.2 10792.6 11072.7 11295.5 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - PROCESS | 9887 | [#3] mootools.html Cycles:180 Average:4806.66 Median:5086.04 stddev:2566.83 (50.5%) stddev-sans-first:2560.46 07:59:21 INFO - PROCESS | 9887 | Values: 1294.4 1302.5 1303.6 1308.5 1317.1 6975.8 7402.7 7404.2 7408.4 7409.1 6388.2 6680.2 6874.9 7164.7 7165.6 2117.7 2145.2 2150.0 2152.9 2153.0 2148.9 2175.3 2178.5 2180.3 2191.0 1821.0 1883.4 2071.5 2093.5 2144.1 2144.3 2147.8 2148.3 2149.8 2152.6 2074.1 2112.4 2116.3 2128.6 2137.8 7354.2 7413.0 7419.1 7421.0 7444.2 4372.2 4488.2 4494.1 4495.7 4501.6 2887.8 2893.3 2946.3 2946.7 3023.6 1105.5 1136.7 1160.4 1178.4 1201.3 9552.2 9558.5 9574.7 9585.7 9586.9 3730.5 3890.9 3956.4 3990.2 4151.8 8466.8 8469.2 8498.8 8505.0 8516.4 4597.3 4600.1 4603.0 4603.1 4607.7 3667.7 3812.2 3988.7 4145.0 4244.3 3476.0 3590.9 3663.6 3683.2 3695.8 1148.6 1184.2 1195.8 1209.2 1212.5 691.0 698.1 787.8 791.8 809.5 4844.7 4944.4 5032.9 5034.6 5113.5 866.6 889.2 893.8 939.7 968.1 3342.8 3354.6 3427.7 3495.4 3593.4 8503.7 8642.7 8790.5 8800.0 8808.6 8734.7 8857.0 8857.6 8867.4 8890.3 6449.9 6765.8 6892.9 6898.2 6899.9 5030.7 5058.6 5242.1 5304.6 5479.3 7852.3 7914.5 7990.3 8089.8 8130.8 7591.5 7747.1 7812.1 7836.3 8038.7 5816.7 6018.5 6205.6 6371.0 6375.5 6708.3 6967.4 6984.3 7137.7 7151.2 6300.0 6365.1 6396.7 6628.8 6640.8 6309.6 6318.6 6333.7 6348.9 6354.2 5297.2 5364.6 5377.9 5381.3 5384.5 4279.0 4284.1 4324.6 4379.3 4452.3 4404.8 4423.7 4503.7 4554.3 4592.6 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - PROCESS | 9887 | [#4] prototype.html Cycles:180 Average:4060.32 Median:4606.69 stddev:1144.43 (24.8%) stddev-sans-first:1113.38 07:59:21 INFO - PROCESS | 9887 | Values: 357.2 361.8 370.0 370.3 379.5 4641.4 4660.3 4686.7 4714.3 4717.4 4472.4 4632.3 4632.6 4655.8 4688.0 3302.6 3699.9 3754.6 3808.9 3820.9 3825.1 3825.4 3825.6 3831.9 3837.8 3813.7 3823.5 3824.0 3825.3 3834.9 3666.7 3701.0 3757.0 3794.5 3822.7 3390.1 3407.6 3426.3 3427.9 3445.4 4558.4 4565.5 4598.8 4607.9 4609.2 3993.6 4337.6 4348.2 4349.7 4353.3 4888.0 4937.1 4939.6 4944.7 4951.2 3602.4 3607.2 3608.1 3610.6 3634.9 4943.0 5040.2 5069.8 5183.9 5221.4 3576.3 3578.3 3589.4 3603.8 3614.0 3650.0 3655.6 3657.9 3661.2 3668.4 4159.8 4163.4 4174.4 4201.7 4207.9 4728.2 4900.8 4926.1 4934.7 4936.7 1226.2 1240.8 1242.3 1249.7 1266.0 810.3 858.3 863.5 873.9 879.9 4124.9 4194.1 4214.4 4219.5 4219.6 4902.6 4931.4 4936.0 4958.2 5012.9 4206.9 4219.5 4223.1 4227.1 4262.4 2460.5 2611.8 2620.3 2623.1 2623.6 4605.4 4631.6 4632.4 4633.4 4648.5 5061.5 5062.9 5070.7 5073.3 5080.3 4305.4 4551.7 4605.9 4607.4 4617.0 4910.7 4915.2 4923.6 4923.6 4930.6 4851.8 4861.0 4864.9 4875.4 4890.4 4442.6 4595.9 4619.1 4622.3 4627.7 3547.5 3554.8 3561.1 3569.8 3569.9 4939.7 4948.9 4963.9 4969.2 4992.8 4653.6 4780.8 4783.4 4785.9 4831.3 4759.8 4764.4 4767.3 4770.4 4788.8 4717.1 4744.6 4747.3 4750.9 4759.3 4577.0 4843.5 4847.3 4957.1 4994.7 4852.0 4868.3 4870.7 4874.3 4878.7 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - PROCESS | 9887 | [#5] yui.html Cycles:180 Average:15149.06 Median:4539.38 stddev:18511.78 (407.8%) stddev-sans-first:18531.76 07:59:21 INFO - PROCESS | 9887 | Values: 666.8 684.2 727.9 750.5 761.8 12655.0 13667.9 13680.9 13698.3 13829.3 13034.0 13189.1 13206.1 13217.7 13261.9 638.4 654.6 770.1 779.2 794.1 793.3 801.0 802.7 802.8 803.3 848.8 849.0 849.7 849.7 850.0 680.8 699.2 831.9 847.2 849.9 613.8 617.5 618.7 618.8 618.9 13195.5 13216.7 13225.5 13236.6 13299.3 13026.9 13070.3 13171.2 13216.5 13232.5 11934.9 11963.7 11974.3 12245.8 12313.5 4036.8 4039.6 4166.7 4219.5 4299.6 65306.7 65325.0 65336.0 65351.3 65485.7 9859.0 9962.0 10307.7 10485.4 10542.9 17797.6 18739.4 18749.1 19188.2 19763.5 6459.5 6611.1 6651.0 6696.7 6880.6 3332.6 3405.8 3416.9 3438.1 3490.4 3019.2 3058.5 3071.6 3087.5 3108.0 524.7 527.1 527.5 534.2 538.4 621.5 636.6 642.3 642.3 652.7 9164.3 9446.2 9547.5 9614.0 9787.8 598.2 614.2 625.6 634.2 637.5 4308.5 4485.3 4529.8 4549.0 4549.6 50899.5 51609.5 66089.7 67459.0 67460.7 56870.7 58158.0 59024.7 59189.1 60252.4 52508.0 54023.5 54570.5 54675.7 55078.4 8678.3 8882.0 8951.4 9016.5 9119.5 36917.3 37470.6 38104.0 38499.8 38890.2 45083.8 45870.3 46007.0 46664.5 47811.5 10023.1 10261.2 10278.0 10471.7 10518.8 11158.2 12586.6 12875.6 13120.5 13389.0 12126.6 12478.9 12485.8 12602.1 13070.9 12050.7 12494.5 12497.9 12668.2 13076.7 12113.6 12301.6 12571.8 12660.4 13040.3 10263.3 10311.5 10313.1 10869.6 11002.7 9875.4 10336.3 10386.8 10416.3 10431.7 07:59:21 INFO - PROCESS | 9887 | -------- Summary: end -------- 07:59:21 INFO - PROCESS | 9887 | 07:59:21 INFO - TEST-INFO | 9887: exit 0 07:59:21 INFO - TEST-OK | dromaeo_css | took 1122117ms 07:59:21 INFO - TEST-START | kraken 07:59:21 INFO - operating with platform_type : linux_ 07:59:21 INFO - Initialising browser for kraken test... 07:59:21 INFO - TEST-INFO | started process 10188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJrQxS/profile http://localhost:36932/getInfo.html) 07:59:25 INFO - PROCESS | 10188 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 07:59:26 INFO - PROCESS | 10188 | __metrics Screen width/height:1600/1200 07:59:26 INFO - PROCESS | 10188 | colorDepth:24 07:59:26 INFO - PROCESS | 10188 | Browser inner width/height: 1024/697 07:59:26 INFO - PROCESS | 10188 | __metrics 07:59:26 INFO - PROCESS | 10188 | 1485791966635 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 07:59:26 INFO - PROCESS | 10188 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:59:26 INFO - PROCESS | 10188 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:59:27 INFO - PROCESS | 10188 | console.error: PushService: 07:59:27 INFO - PROCESS | 10188 | stateChangeProcessEnqueue: Error transitioning state 07:59:27 INFO - PROCESS | 10188 | UnknownError 07:59:28 INFO - TEST-INFO | 10188: exit 0 07:59:28 INFO - Browser initialized. 07:59:28 INFO - Running cycle 1/1 for kraken test... 07:59:28 INFO - TEST-INFO | started process 10270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJrQxS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:40 INFO - PROCESS | 10270 | RSS: Main: 153464832 07:59:40 INFO - PROCESS | 10270 | 07:59:42 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36932/tests/kraken/driver.html?testName=audio-beat-detection) 07:59:43 INFO - PROCESS | 10270 | RSS: Main: 207900672 07:59:43 INFO - PROCESS | 10270 | 07:59:46 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36932/tests/kraken/driver.html?testName=audio-dft) 07:59:47 INFO - PROCESS | 10270 | RSS: Main: 186892288 07:59:47 INFO - PROCESS | 10270 | 07:59:50 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36932/tests/kraken/driver.html?testName=audio-fft) 07:59:50 INFO - PROCESS | 10270 | RSS: Main: 269737984 07:59:50 INFO - PROCESS | 10270 | 07:59:53 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36932/tests/kraken/driver.html?testName=audio-oscillator) 07:59:53 INFO - PROCESS | 10270 | RSS: Main: 181198848 07:59:53 INFO - PROCESS | 10270 | 07:59:55 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:59:56 INFO - PROCESS | 10270 | RSS: Main: 183869440 07:59:56 INFO - PROCESS | 10270 | 07:59:59 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36932/tests/kraken/driver.html?testName=imaging-darkroom) 08:00:00 INFO - PROCESS | 10270 | RSS: Main: 223739904 08:00:00 INFO - PROCESS | 10270 | 08:00:03 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36932/tests/kraken/driver.html?testName=imaging-desaturate) 08:00:04 INFO - PROCESS | 10270 | RSS: Main: 217456640 08:00:04 INFO - PROCESS | 10270 | 08:00:07 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36932/tests/kraken/driver.html?testName=json-parse-financial) 08:00:07 INFO - PROCESS | 10270 | RSS: Main: 218472448 08:00:07 INFO - PROCESS | 10270 | 08:00:09 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:00:10 INFO - PROCESS | 10270 | RSS: Main: 182140928 08:00:10 INFO - PROCESS | 10270 | 08:00:12 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:00:12 INFO - PROCESS | 10270 | RSS: Main: 190529536 08:00:12 INFO - PROCESS | 10270 | 08:00:14 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:00:15 INFO - PROCESS | 10270 | RSS: Main: 198782976 08:00:15 INFO - PROCESS | 10270 | 08:00:18 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:00:19 INFO - PROCESS | 10270 | RSS: Main: 208392192 08:00:19 INFO - PROCESS | 10270 | 08:00:22 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:00:22 INFO - PROCESS | 10270 | RSS: Main: 204038144 08:00:22 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36932/tests/kraken/driver.html?testName=ai-astar) 08:00:24 INFO - PROCESS | 10270 | RSS: Main: 255049728 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | __start_tp_report 08:00:24 INFO - PROCESS | 10270 | _x_x_mozilla_page_load 08:00:24 INFO - PROCESS | 10270 | _x_x_mozilla_page_load_details 08:00:24 INFO - PROCESS | 10270 | |i|pagename|runs| 08:00:24 INFO - PROCESS | 10270 | |0;ai-astar;115;116;115;116;115;116;115;117;115;115 08:00:24 INFO - PROCESS | 10270 | |1;audio-beat-detection;154;125;125;161;126;125;127;124;158;124 08:00:24 INFO - PROCESS | 10270 | |2;audio-dft;162;162;162;164;163;161;162;161;163;160 08:00:24 INFO - PROCESS | 10270 | |3;audio-fft;76;77;76;107;76;77;77;75;103;76 08:00:24 INFO - PROCESS | 10270 | |4;audio-oscillator;84;83;113;84;83;84;109;83;83;109 08:00:24 INFO - PROCESS | 10270 | |5;imaging-gaussian-blur;118;117;117;117;117;118;118;117;117;117 08:00:24 INFO - PROCESS | 10270 | |6;imaging-darkroom;148;149;148;148;148;149;152;148;149;149 08:00:24 INFO - PROCESS | 10270 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;96;95 08:00:24 INFO - PROCESS | 10270 | |8;json-parse-financial;60;61;60;61;60;60;60;60;61;59 08:00:24 INFO - PROCESS | 10270 | |9;json-stringify-tinderbox;68;70;66;67;67;67;67;67;68;68 08:00:24 INFO - PROCESS | 10270 | |10;stanford-crypto-aes;100;94;86;85;94;85;94;86;85;90 08:00:24 INFO - PROCESS | 10270 | |11;stanford-crypto-ccm;133;132;134;135;141;144;139;135;183;140 08:00:24 INFO - PROCESS | 10270 | |12;stanford-crypto-pbkdf2;178;174;185;177;175;176;176;174;175;175 08:00:24 INFO - PROCESS | 10270 | |13;stanford-crypto-sha256-iterative;66;66;70;68;69;67;67;67;67;66 08:00:24 INFO - PROCESS | 10270 | __end_tp_report 08:00:24 INFO - PROCESS | 10270 | __start_cc_report 08:00:24 INFO - PROCESS | 10270 | _x_x_mozilla_cycle_collect,1817 08:00:24 INFO - PROCESS | 10270 | __end_cc_report 08:00:24 INFO - PROCESS | 10270 | __startTimestamp1485792024694__endTimestamp 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | ------- Summary: start ------- 08:00:24 INFO - PROCESS | 10270 | Number of tests: 14 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 08:00:24 INFO - PROCESS | 10270 | Values: 115.0 116.0 115.0 116.0 115.0 116.0 115.0 117.0 115.0 115.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:126.50 stddev:15.82 (12.5%) stddev-sans-first:15.20 08:00:24 INFO - PROCESS | 10270 | Values: 154.0 125.0 125.0 161.0 126.0 125.0 127.0 124.0 158.0 124.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 08:00:24 INFO - PROCESS | 10270 | Values: 162.0 162.0 162.0 164.0 163.0 161.0 162.0 161.0 163.0 160.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.17 (16.0%) stddev-sans-first:12.72 08:00:24 INFO - PROCESS | 10270 | Values: 76.0 77.0 76.0 107.0 76.0 77.0 77.0 75.0 103.0 76.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:13.05 (15.7%) stddev-sans-first:13.56 08:00:24 INFO - PROCESS | 10270 | Values: 84.0 83.0 113.0 84.0 83.0 84.0 109.0 83.0 83.0 109.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:00:24 INFO - PROCESS | 10270 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 08:00:24 INFO - PROCESS | 10270 | Values: 148.0 149.0 148.0 148.0 148.0 149.0 152.0 148.0 149.0 149.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:00:24 INFO - PROCESS | 10270 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 08:00:24 INFO - PROCESS | 10270 | Values: 60.0 61.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 59.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 08:00:24 INFO - PROCESS | 10270 | Values: 68.0 70.0 66.0 67.0 67.0 67.0 67.0 67.0 68.0 68.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:88.00 stddev:5.32 (6.0%) stddev-sans-first:4.21 08:00:24 INFO - PROCESS | 10270 | Values: 100.0 94.0 86.0 85.0 94.0 85.0 94.0 86.0 85.0 90.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:139.50 stddev:15.06 (10.8%) stddev-sans-first:15.65 08:00:24 INFO - PROCESS | 10270 | Values: 133.0 132.0 134.0 135.0 141.0 144.0 139.0 135.0 183.0 140.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:176.00 stddev:3.24 (1.8%) stddev-sans-first:3.39 08:00:24 INFO - PROCESS | 10270 | Values: 178.0 174.0 185.0 177.0 175.0 176.0 176.0 174.0 175.0 175.0 08:00:24 INFO - PROCESS | 10270 | 08:00:24 INFO - PROCESS | 10270 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.33 08:00:24 INFO - PROCESS | 10270 | Values: 66.0 66.0 70.0 68.0 69.0 67.0 67.0 67.0 67.0 66.0 08:00:24 INFO - PROCESS | 10270 | -------- Summary: end -------- 08:00:24 INFO - PROCESS | 10270 | 08:00:25 INFO - TEST-INFO | 10270: exit 0 08:00:26 INFO - TEST-OK | kraken | took 64072ms 08:00:26 INFO - SUITE-END | took 1186s 08:00:26 INFO - Completed test suite (00:19:46) 08:00:26 INFO - javascript benchmark 08:00:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6391.173337666757, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2473.035516148702, 2544.284053766753, 2559.334573011017, 2563.102913980107, 2570.9357266068346, 4512.390827238321, 4581.67928245023, 4588.862334129977, 4593.862184134473, 4620.584147426731, 4620.930686039712, 4621.168189725848, 4630.444346678395, 4653.3717948077, 4726.314684370765, 4288.463942007249, 4288.9785551072355, 4298.677599180059, 4320.56794320567, 4385.122975404915, 4398.230309695807, 4423.181711383389, 4423.86728398147, 4444.799984000711, 4446.444194475691, 4216.072464057902, 4256.2764330063965, 4329.047609525899, 4359.193549193377, 4365.301551751721, 4233.724807887477, 4264.957350426487, 4271.551487093841, 4285.785710714452, 4350.543192964725, 4254.127903779718, 4257.276263035261, 4260.275753121977, 4289.1636130954475, 4303.31147016479, 4609.446866376023, 4617.2381557043045, 4641.396618439581, 4654.4647365553055, 4691.366665500182, 4982.526659967298, 5018.7992480300745, 5042.974785126051, 5047.419546752134, 5059.241113832918, 4972.676776009584, 4986.750662466862, 5007.474215207387, 5077.035363280965, 5077.390713114413, 4690.835820746258, 4708.81164753406, 4711.646626503026, 4712.269598212282, 4735.905281894343, 5124.487551244845, 5135.897282054413, 5138.511841375063, 5141.0232055909255, 5182.119039763249, 4853.708777473363, 4891.633127515451, 4892.951070489321, 4928.112939670894, 4931.9753401232765, 4933.1613625683, 4975.925361119586, 4978.800847966041, 5041.117804384218, 5080.364954380702, 4934.605231581465, 4943.110240156806, 4971.477994810565, 4977.477364876636, 4984.7258400788305, 4982.501749824988, 5051.116054690415, 5055.51972562606, 5098.490150984871, 5099.719515426613, 4213.810378532973, 4222.662187025031, 4255.042615411569, 4258.233517966733, 4299.269124248885, 3554.680078792921, 3580.6419358063986, 3611.6930060944587, 3640.9453858192146, 3657.0, 4342.522322544518, 4346.500152482442, 4371.409859668967, 4374.868753937387, 4384.846530371422, 5084.949150508522, 5088.211327244283, 5088.262201980692, 5089.185730283211, 5136.974315128476, 4231.915361692749, 4264.424302719093, 4280.978595107004, 4350.869473915787, 4355.259605867011, 4486.753228572395, 4497.257952437811, 4521.231390663595, 4553.043860789271, 4556.157110934488, 4699.177643912233, 4701.059788042337, 4701.929471057869, 4722.480527141943, 4793.736344501086, 4891.1685013548495, 4922.8769280768265, 5021.07110184617, 5038.748062596782, 5058.367704036996, 4696.38946936896, 4733.810647574059, 4740.19416699155, 4759.809607615656, 4786.880327991828, 5005.674631148963, 5009.524095210949, 5012.248162775612, 5013.24801279811, 5059.46875578059, 5062.443131255633, 5064.72144032067, 5070.442251352274, 5078.796848126033, 5119.846404607868, 4751.667383283275, 4847.5394837490385, 4855.587275081516, 4884.340614017205, 4897.853064408074, 4887.706737595756, 4888.0468308679465, 4896.290037944407, 4930.186519224288, 4935.851924442272, 4678.321643361762, 4715.6227501799085, 4717.716936983792, 4843.200871856105, 4843.4430040545785, 4888.2178851383605, 4902.754862256802, 4907.092187945242, 4957.429895562056, 4987.12725273083, 4818.445878723992, 4820.927686084641, 4830.227163653799, 4838.612910967044, 4850.490698476609], "value": 4596.775026829612, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.9429909859465, 568.5167607533596, 587.5241054745653, 598.963792638735, 601.1943995046637, 29443.55834662479, 39647.40528892069, 41857.372139417894, 42029.0, 45366.546334536644, 43492.3476147858, 43749.12501749963, 43785.0, 43802.7809860951, 43981.7800910995, 7600.657970391318, 7774.067111946574, 7774.144844067148, 7775.1447340792465, 7778.8444231115345, 7437.628118594076, 7640.235976402343, 10074.244431667617, 10331.690049298495, 10337.896621033806, 10285.382877027365, 10289.742756431075, 10310.9484452578, 10346.37921724699, 10353.637622683207, 10265.692029239135, 10315.948420257851, 10322.7419314517, 10328.793424131476, 10336.94831525845, 10120.291579589431, 10198.286119971604, 10198.898011019943, 10204.846927296096, 10207.489625518694, 39562.802185989174, 39842.80078599617, 39863.60136398628, 39953.800230998946, 39954.60045399567, 3617.7648452850744, 3687.520622319081, 3703.370427027412, 3703.6296370363016, 3725.217704282104, 28697.71302286992, 29203.707962920525, 29207.56188657172, 29218.561721574195, 29255.0, 3422.8117453540044, 3487.267673788482, 3521.2781379817334, 3695.224002959382, 3709.3879509880835, 233511.0, 234705.0, 234899.0, 236083.0, 236762.0, 55205.72397138069, 55476.72261638666, 55573.0, 55577.1663425049, 55693.72153139208, 57566.0, 57989.710051449474, 58200.4179958195, 58223.417765821796, 58257.70871145702, 14488.565343039725, 14938.0, 15001.924990374979, 15023.624409389853, 15039.774403383957, 10035.598576057022, 11133.832992504957, 11197.66407007791, 11202.215844890943, 11210.27133236337, 14917.0, 17468.82531174672, 17651.117444127744, 17836.286548538174, 18266.26934922588, 5920.851978700567, 5925.170476133345, 5991.820245392645, 6127.5404344674325, 6158.846028849314, 765.0289490526494, 781.4646966827742, 785.654312102673, 792.7899106736719, 803.8665481670816, 27397.589036164474, 27933.580996285073, 28446.0, 28657.713422865505, 28939.42121157565, 882.8852249207562, 957.9425234485814, 959.3668179001826, 969.3941286695815, 977.936553871331, 14811.629709257355, 15105.3202605883, 15245.923770381078, 15334.003289786127, 15503.689926201412, 335589.0, 339103.0, 339912.0, 340051.0, 341988.0, 52324.476755232725, 52330.21504677433, 52366.738166308925, 52562.737186313825, 52598.47401526012, 1190.4108015798831, 1219.5304807648943, 1247.3015111537386, 1254.3665448948223, 1255.7237407770276, 25841.353966150997, 26822.731772682022, 27018.864905675346, 27118.864405677847, 27354.45291094207, 43314.35028474638, 43864.780676096416, 43924.99999999872, 43954.0, 44035.77982110069, 271411.0, 271455.0, 271538.0, 273367.96476194, 273901.0, 32266.677333226366, 36003.0, 36565.45151822778, 36809.63190368062, 36954.815225923696, 34352.0, 42072.38034695228, 42724.5727542733, 46768.53231467642, 47260.7636961813, 36140.63859361373, 36670.89987300385, 36692.81653591715, 38496.422553661156, 38827.2234555313, 36581.63418365889, 36877.63122368742, 37295.62704372922, 37323.253534929696, 37869.81065094767, 34920.82539587286, 35959.460608090376, 36240.63759362478, 36458.0, 36638.450423244205, 30899.691003090582, 33611.327773444886, 33654.495182571794, 33661.663383365856, 33708.49437258394, 22793.544129117658, 23953.401164971016, 24932.750672493043, 25333.61999569971, 25382.492350152523], "value": 18158.349856313478, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.01834249294325, 379.7626483447845, 386.5516001438332, 399.18566125104786, 407.7879502658616, 17259.74110388345, 18319.63360732788, 18872.811271887276, 19012.61974760504, 19054.14256358464, 17961.550961225978, 18234.0882955852, 18551.165197566108, 18981.0, 18996.525086872836, 5051.166557518023, 5122.436531981489, 5317.308749862513, 5328.573714102882, 5329.360476742796, 5085.313482679828, 5231.163013917774, 5236.057509648262, 5238.030964271622, 5244.947550524503, 5210.270562121287, 5214.0, 5214.113600687892, 5214.791408343662, 5222.268882356473, 5364.651297665659, 5608.971955140219, 5624.91562626561, 5716.456936591017, 5718.79984200551, 5506.5870059745275, 5590.91613625796, 5597.692126933017, 5604.1593760935775, 5742.425757424266, 13195.142315749541, 13208.471661133639, 13357.799633005512, 13360.599182024554, 13361.532346367927, 2330.557194133109, 2458.3362492127026, 2464.134853939583, 2467.3091534370405, 2482.4290413205063, 9228.676996305097, 9822.116009559102, 9823.263255255884, 10473.47632618366, 13091.803622945568, 1706.6757316110024, 1761.6388640328703, 1770.0530216334328, 1807.2138619700472, 1811.6829554827852, 78738.60630696866, 81953.0, 82024.76962845621, 83270.16729832685, 84002.57998709967, 10840.186985976083, 10840.373943908318, 10921.726956825984, 10972.725681858017, 11149.665510034712, 14704.0, 15735.213239337987, 15758.369665213493, 15780.053196808229, 15792.842071579367, 5903.291605007341, 5913.49735272498, 6704.899426508607, 7553.697852085965, 7811.960940195263, 6991.475639327071, 7051.330123638246, 7238.27617238272, 7245.094363204599, 7261.3101755333155, 4575.336576196433, 4687.109449204709, 4698.119171803418, 4831.0, 4844.660873738804, 1851.2039822876293, 1955.5502234486148, 1980.3167907072036, 1988.413418041681, 1997.5605366819277, 742.669512067125, 763.8701420758484, 767.370755980091, 775.3796962430033, 793.5556088590408, 17665.290289039447, 18233.544161395806, 18400.63198736018, 18652.44042678722, 18696.813031869508, 748.2367984655621, 761.9847603048019, 767.9270469305407, 779.3531368963746, 786.8111653203305, 9553.379030363143, 10439.425831579336, 10732.946335268274, 10815.297005694605, 11069.391183484986, 462672.0, 485176.0, 486019.0, 507971.0, 521142.0, 63908.36091639117, 66143.66928165329, 96473.0, 98631.50684246533, 102445.99857029291, 894.5974311559825, 1002.7142264454595, 1006.5168719014914, 1007.2244371833647, 1009.3792317724547, 16084.67830643404, 16125.193740313172, 16398.426055088014, 17294.135293235035, 17842.46472605824, 39709.0, 40816.591834082465, 41876.16247674968, 42329.57670423256, 44211.0, 53760.0, 54615.0, 55009.1748623779, 55858.16212756731, 56611.86776264534, 5254.395744489432, 6412.711427985659, 6904.4131248844415, 7854.057513098464, 8244.958775206085, 10977.451127443435, 12174.452149653463, 12299.200551964093, 12652.746945061232, 12676.619701408972, 10441.843372349269, 10564.260501764802, 10812.56749730002, 10985.505652245509, 11055.834162487408, 10651.147908167482, 10769.892301076889, 10772.946135269274, 10855.0, 10951.56193752241, 10567.365958042543, 10852.891471085188, 10974.286671366335, 11063.446827658423, 11464.656060318204, 7748.92251077482, 7808.375329973702, 7897.802554936173, 8004.279614834692, 8272.545010024265, 10067.89253182164, 10084.193264538966, 10792.622258220925, 11072.723181920517, 11295.548178072784], "value": 8564.76889716288, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.3851670456531, 1302.5441095616536, 1303.6414985878882, 1308.4504508106595, 1317.0912070671238, 6975.790726278207, 7402.740904068359, 7404.1855395906405, 7408.444366672501, 7409.14794798597, 6388.169537960071, 6680.164979377578, 6874.8968765468435, 7164.677589508472, 7165.605891675956, 2117.6717608770628, 2145.2169957965307, 2149.9892500537476, 2152.9354119376367, 2153.0, 2148.9140434382607, 2175.3147758456116, 2178.5098352870637, 2180.269609680751, 2191.0359441845617, 1820.9635807283846, 1883.406726881035, 2071.5028393185676, 2093.518490747129, 2144.131626691185, 2144.2923835134447, 2147.8174355179826, 2148.2803260907613, 2149.817265532416, 2152.6448136057534, 2074.087401543316, 2112.355731501891, 2116.3439333806414, 2128.563644452899, 2137.78622137785, 7354.191038985708, 7413.036305280333, 7419.146798118231, 7421.0, 7444.181140074587, 4372.234858899712, 4488.169688607618, 4494.101179764028, 4495.730256184606, 4501.572350626685, 2887.7978541502102, 2893.2985084206694, 2946.2634341414646, 2946.6611339695783, 3023.576699262105, 1105.5025238642563, 1136.6987748246638, 1160.3502038858182, 1178.393127539318, 1201.3152503073252, 9552.235821134293, 9558.522073896278, 9574.664886729, 9585.712428627083, 9586.904130958741, 3730.515033045687, 3890.902727431837, 3956.4263181838473, 3990.2418540477215, 4151.813168407429, 8466.830663386821, 8469.237768600855, 8498.830023399498, 8505.0, 8516.361272904556, 4597.310403439444, 4600.102979918884, 4602.976985115053, 4603.056373443436, 4607.654425918069, 3667.6882464990776, 3812.2375524895133, 3988.660963818108, 4144.979275103605, 4244.278472659656, 3475.983929320988, 3590.9461358079648, 3663.6336366363153, 3683.208110256308, 3695.796731179757, 1148.6324376199536, 1184.1888306510068, 1195.7847587434171, 1209.2200530657676, 1212.4543955220186, 690.9689063992132, 698.0924797762888, 787.8463699578527, 791.8376732769768, 809.5426084262373, 4844.660873738875, 4944.431390390151, 5032.924506132411, 5034.597232221414, 5113.488651134857, 866.6143566113145, 889.1686273334324, 893.7586851550045, 939.7321763297427, 968.070652173921, 3342.766006379579, 3354.6477619849566, 3427.725781937439, 3495.353359628477, 3593.4070878304788, 8503.702370417006, 8642.740717778477, 8790.516521591373, 8800.0, 8808.559572021373, 8734.694285700098, 8856.955715221511, 8857.557122143997, 8867.423617464845, 8890.288776897833, 6449.871002580016, 6765.797026089225, 6892.862142757117, 6898.241193468714, 6899.931000689929, 5030.748462576929, 5058.595312374928, 5242.108841496878, 5304.628675992643, 5479.3424789023975, 7852.293293603603, 7914.485558438683, 7990.320822730133, 8089.757307280791, 8130.796730081795, 7591.4685971981435, 7747.109082455364, 7812.140664526783, 7836.294733473786, 8038.678452862054, 5816.73824677882, 6018.488428483628, 6205.596636218631, 6370.96814515943, 6375.521835862236, 6708.295628959084, 6967.407770339578, 6984.3364880336285, 7137.678804453708, 7151.2133665297815, 6299.96850015747, 6365.077063825812, 6396.744130234739, 6628.801135965929, 6640.833979150367, 6309.558330916791, 6318.62088274705, 6333.714982825692, 6348.873022539431, 6354.205724284465, 5297.152455607084, 5364.597655175956, 5377.919331209957, 5381.300430943952, 5384.5423139032055, 4279.0, 4284.078923031563, 4324.610785029363, 4379.277419225919, 4452.287633978548, 4404.823807047682, 4423.668224883211, 4503.662225333048, 4554.316852472156, 4592.632589392773], "value": 3947.9176651210432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.23195130469486, 361.84983231958734, 369.9870504532342, 370.3444902522534, 379.546442001808, 4641.419822522184, 4660.254359302512, 4686.671932964685, 4714.269288260317, 4717.3867397238355, 4472.3515090311885, 4632.281996290572, 4632.629389648829, 4655.766221951178, 4687.953120468795, 3302.6036875574964, 3699.8890033299044, 3754.6433088856515, 3808.8857334280015, 3820.9426858597144, 3825.0683404880497, 3825.387937929932, 3825.5791862895057, 3831.885043448687, 3837.846486140551, 3813.6652171739947, 3823.483829682999, 3823.961760382402, 3825.2540754552874, 3834.94247586285, 3666.7249956253386, 3700.962990370089, 3757.0, 3794.4877441545314, 3822.732408731376, 3390.135515443546, 3407.6081250656, 3426.3147370525994, 3427.8971630850865, 3445.3798316303055, 4558.361829343895, 4565.52062033485, 4598.839040633595, 4607.884802879955, 4609.216433206329, 3993.560708322082, 4337.587929146726, 4348.152110338485, 4349.69552131351, 4353.346997950302, 4887.975560122212, 4937.086638971802, 4939.58013568847, 4944.728039957837, 4951.232558953368, 3602.369585322558, 3607.2424790793966, 3608.0516521078584, 3610.584782749991, 3634.945475817865, 4942.975285123552, 5040.168372218543, 5069.77186026626, 5183.896322073575, 5221.39953905302, 3576.2847430514003, 3578.284343131332, 3589.425691889285, 3603.783673041061, 3613.9819300903328, 3650.0, 3655.634436556323, 3657.9451308230396, 3661.212839239576, 3668.4313931340685, 4159.752074377675, 4163.354680024601, 4174.373843923436, 4201.68487363449, 4207.936880946788, 4728.17256980034, 4900.848300649344, 4926.137925863031, 4934.679245849008, 4936.679115857458, 1226.1600803449664, 1240.765438388791, 1242.2981015726086, 1249.6563445052502, 1265.9746805063846, 810.3274282345639, 858.2704701004096, 863.5164307987421, 873.886394768676, 879.8636211387245, 4124.876253712393, 4194.077302993336, 4214.356401003611, 4219.451471308772, 4219.578042195756, 4902.558769710743, 4931.3835770528685, 4936.038376973859, 4958.181899986534, 5012.924806127911, 4206.936895946563, 4219.535851056381, 4223.128272774543, 4227.112306415625, 4262.381954616563, 2460.458699086198, 2611.7779988701172, 2620.2794231586468, 2623.108143231272, 2623.5671114266315, 4605.447346318463, 4631.62946964242, 4632.444106707217, 4633.351330813689, 4648.465426475931, 5061.468545802712, 5062.924056139161, 5070.6957582545165, 5073.315102461194, 5080.26336181259, 4305.354196870495, 4551.658625603093, 4605.930911036337, 4607.447106347193, 4616.976915115403, 4910.729909854849, 4915.18899381598, 4923.581495572773, 4923.606111510999, 4930.556249937523, 4851.80592776285, 4861.0, 4864.92702609454, 4875.366202393808, 4890.413150421972, 4442.577955094261, 4595.862124136282, 4619.145458090264, 4622.306654001926, 4627.699199552018, 3547.481288285346, 3554.7689400188906, 3561.074120728681, 3569.839357228983, 3569.8929032129076, 4939.703617782944, 4948.901021979468, 4963.855180923969, 4969.229769385751, 4992.775325110451, 4653.557911998355, 4780.784864681028, 4783.4408591403435, 4785.856424307276, 4831.323614693875, 4759.833405830779, 4764.356811830358, 4767.33257343979, 4770.379850619397, 4788.832390866303, 4717.127331443694, 4744.620430365631, 4747.311639812277, 4750.881227969328, 4759.262314341283, 4577.009001084539, 4843.539863712942, 4847.345608342828, 4957.132501812241, 4994.725290108933, 4851.967520299812, 4868.342773725643, 4870.683405578626, 4874.293227481924, 4878.707277563358], "value": 3716.559628401573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.8332916770808, 684.2131548718976, 727.8689835829549, 750.4634186556611, 761.7600455856407, 12655.0, 13667.93166034171, 13680.863191368084, 13698.315084245798, 13829.308534573269, 13034.0, 13189.142705724122, 13206.141600795965, 13217.735645287088, 13261.93369033156, 638.3616383616384, 654.6399480285847, 770.1259070954451, 779.154617240295, 794.0947320055142, 793.2939683681499, 801.0147518552184, 802.6508468816055, 802.8193656427316, 803.2730379006979, 848.8090179709546, 849.0321034021221, 849.7026040885702, 849.7408290471403, 849.9575021248913, 680.7549282258383, 699.1994166679175, 831.8710599857031, 847.2374862623626, 849.8810166576684, 613.8158552434252, 617.527591392585, 618.7463140112533, 618.7679620142446, 618.8824123416537, 13195.538156164585, 13216.735665286737, 13225.537106201333, 13236.602901912958, 13299.335033248395, 13026.86973130266, 13070.281134537596, 13171.20972741629, 13216.474516817863, 13232.470701171942, 11934.880651193464, 11963.700907477296, 11974.281543107354, 12245.816312755316, 12313.507459701601, 4036.8183431745642, 4039.575844536311, 4166.687498437599, 4219.493660760729, 4299.591538803808, 65306.67346663236, 65325.0, 65336.0, 65351.346486535476, 65485.67257163731, 9858.95070524657, 9962.0, 10307.690769276935, 10485.421498087211, 10542.894571054192, 17797.555061123574, 18739.437816865517, 18749.062546872603, 19188.232470701296, 19763.505912352306, 6459.483241340681, 6611.140551728245, 6650.9667451662435, 6696.698648560827, 6880.552764070319, 3332.583427071616, 3405.846736896796, 3416.9145771355916, 3438.054535002894, 3490.406630872707, 3019.1999120233154, 3058.464768665519, 3071.6314042315066, 3087.505999040143, 3108.0, 524.7087866234276, 527.0776141751934, 527.543674721371, 534.1507003863875, 538.4480907070206, 621.4593303825701, 636.5830381100386, 642.2742301199614, 642.331974746268, 652.6769249221666, 9164.266858651292, 9446.244300455946, 9547.52262386878, 9613.951930240304, 9787.755306117404, 598.1924402057275, 614.173936056004, 625.5746092657037, 634.1850721822436, 637.4581605635173, 4308.526062133163, 4485.349624304523, 4529.750863702462, 4549.0, 4549.6360291176625, 50899.49100509022, 51609.483905160465, 66089.66955165194, 67459.0, 67460.66269668621, 56870.71564642233, 58158.0, 59024.7048764762, 59189.112163317586, 60252.39747602556, 52508.0, 54023.45976540184, 54570.45429545654, 54675.72662136664, 55078.44921550733, 8678.262347700516, 8882.0, 8951.373403861668, 9016.459012459274, 9119.5440227987, 36917.26165476622, 37470.625293747806, 38104.0, 38499.80750096231, 38890.2221955565, 45083.77458112819, 45870.31194532018, 46007.0, 46664.53335466602, 47811.521884780705, 10023.097921187129, 10261.2304077196, 10278.023587759151, 10471.738206544593, 10518.78962420732, 11158.218924675195, 12586.622401327975, 12875.613731588068, 13120.475180992653, 13389.0, 12126.636200913987, 12478.875211248134, 12485.812712809497, 12602.054845886778, 13070.934645326712, 12050.660737928176, 12494.500219991462, 12497.937510312753, 12668.176568523017, 13076.673083172996, 12113.636590902288, 12301.630951071482, 12571.811422828481, 12660.430280637578, 13040.347982601023, 10263.281570290008, 10311.484425778832, 10313.071823535918, 10869.565217391215, 11002.669919902415, 9875.40747555149, 10336.276460647683, 10386.844197336895, 10416.270861039655, 10431.739206519898], "value": 6496.418968488064, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 116.0, 115.0, 116.0, 115.0, 117.0, 115.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 125.0, 161.0, 126.0, 125.0, 127.0, 124.0, 158.0, 124.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 164.0, 163.0, 161.0, 162.0, 161.0, 163.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 107.0, 76.0, 77.0, 77.0, 75.0, 103.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 113.0, 84.0, 83.0, 84.0, 109.0, 83.0, 83.0, 109.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 152.0, 148.0, 149.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 59.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 86.0, 85.0, 94.0, 85.0, 94.0, 86.0, 85.0, 90.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 134.0, 135.0, 141.0, 144.0, 139.0, 135.0, 183.0, 140.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 174.0, 185.0, 177.0, 175.0, 176.0, 176.0, 174.0, 175.0, 175.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 70.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 67.3, "unit": "score"}]}]} 08:00:26 INFO - Return code: 0 08:00:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:00:26 ERROR - # TBPL SUCCESS # 08:00:26 INFO - Running post-action listener: _resource_record_post_action 08:00:26 INFO - [mozharness: 2017-01-30 16:00:26.493049Z] Finished run-tests step (success) 08:00:26 INFO - Running post-run listener: _resource_record_post_run 08:00:26 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397754368; Read time: 12; Write time: 287536 08:00:26 INFO - TinderboxPrint: CPU usage
13.1% 08:00:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:00:26 INFO - TinderboxPrint: I/O write bytes / time
397,754,368 / 287,536 08:00:26 INFO - TinderboxPrint: CPU idle
8,342.3 (86.9%) 08:00:26 INFO - TinderboxPrint: CPU user
1,215.9 (12.7%) 08:00:26 INFO - TinderboxPrint: Swap in / out
0 / 0 08:00:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100077568; Read time: 0; Write time: 107224 08:00:26 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 297676800; Read time: 0; Write time: 180312 08:00:27 INFO - Running post-run listener: _upload_blobber_files 08:00:27 INFO - Blob upload gear active. 08:00:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:00:27 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 08:00:27 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'] 08:00:27 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 08:00:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:00:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:00:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:00:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:00:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:00:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:00:28 INFO - (blobuploader) - INFO - Done attempting. 08:00:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:00:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:00:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:00:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:00:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:00:31 INFO - (blobuploader) - INFO - Done attempting. 08:00:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:00:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:00:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:00:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:00:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:00:32 INFO - (blobuploader) - INFO - Done attempting. 08:00:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:00:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:00:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:00:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:00:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:00:33 INFO - (blobuploader) - INFO - Done attempting. 08:00:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:00:33 INFO - Return code: 0 08:00:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:00:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:00:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/062732328081acddb94f34fe54a785dee094c3ef6a401ef211cd0128e65f3d1651958031d277c89aaf8c01ab29282af290a13b4b853c6faf25447d12992c3b19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a74ced95229a73f2143edddaf2dcfebfc091097279ff5fe548766b8a422654917863c56d1e751509f17250ec5d5ef71fb6e714c065bd897c5543ae4a755972f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c844f21f0a1f765aaa9063c51e104bf5b61baa58c09881cd50402884559fa9d51655b94940849086e0a066c2e84e0d70ed6dfd36e67746a2478f77961fc8756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a746ce06c637ea26e50abc274d5e3172c6c5881e58df5424f2fb1b64e202bf4d93631cbf6c888a757954c72966f86dedb376337a03b2f8f826f7c979cfd3dd2a"} 08:00:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:00:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:00:33 INFO - Contents: 08:00:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/062732328081acddb94f34fe54a785dee094c3ef6a401ef211cd0128e65f3d1651958031d277c89aaf8c01ab29282af290a13b4b853c6faf25447d12992c3b19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a74ced95229a73f2143edddaf2dcfebfc091097279ff5fe548766b8a422654917863c56d1e751509f17250ec5d5ef71fb6e714c065bd897c5543ae4a755972f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c844f21f0a1f765aaa9063c51e104bf5b61baa58c09881cd50402884559fa9d51655b94940849086e0a066c2e84e0d70ed6dfd36e67746a2478f77961fc8756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a746ce06c637ea26e50abc274d5e3172c6c5881e58df5424f2fb1b64e202bf4d93631cbf6c888a757954c72966f86dedb376337a03b2f8f826f7c979cfd3dd2a"} 08:00:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:00:33 INFO - Copying logs to upload dir... 08:00:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:00:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.179258 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-30 08:00:32.916344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 08:00:32.919987) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/062732328081acddb94f34fe54a785dee094c3ef6a401ef211cd0128e65f3d1651958031d277c89aaf8c01ab29282af290a13b4b853c6faf25447d12992c3b19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a74ced95229a73f2143edddaf2dcfebfc091097279ff5fe548766b8a422654917863c56d1e751509f17250ec5d5ef71fb6e714c065bd897c5543ae4a755972f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c844f21f0a1f765aaa9063c51e104bf5b61baa58c09881cd50402884559fa9d51655b94940849086e0a066c2e84e0d70ed6dfd36e67746a2478f77961fc8756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a746ce06c637ea26e50abc274d5e3172c6c5881e58df5424f2fb1b64e202bf4d93631cbf6c888a757954c72966f86dedb376337a03b2f8f826f7c979cfd3dd2a"} build_url:https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/fkGuYk-PT2uDNQV9b_RYAQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/062732328081acddb94f34fe54a785dee094c3ef6a401ef211cd0128e65f3d1651958031d277c89aaf8c01ab29282af290a13b4b853c6faf25447d12992c3b19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a74ced95229a73f2143edddaf2dcfebfc091097279ff5fe548766b8a422654917863c56d1e751509f17250ec5d5ef71fb6e714c065bd897c5543ae4a755972f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c844f21f0a1f765aaa9063c51e104bf5b61baa58c09881cd50402884559fa9d51655b94940849086e0a066c2e84e0d70ed6dfd36e67746a2478f77961fc8756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a746ce06c637ea26e50abc274d5e3172c6c5881e58df5424f2fb1b64e202bf4d93631cbf6c888a757954c72966f86dedb376337a03b2f8f826f7c979cfd3dd2a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 08:00:32.944507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 08:00:32.944839) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1485790782.233015-1355839768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 08:00:33.029810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 08:00:33.030158) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 08:00:33.030458) ========= ========= Total master_lag: 0.18 =========