builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-002 starttime: 1504807569.47 results: success (0) revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.473367) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.473826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.474099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.491438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.491710) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 11:06:10-- 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% 34.6M=0s 2017-09-07 11:06:10 (34.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115752 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.627074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.627399) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014036 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.676483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:09.676813) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c96d611ebd67fc219d22bcb476a72412c76f6c7 --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 3c96d611ebd67fc219d22bcb476a72412c76f6c7 --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=a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 11:06:10,317 truncating revision to first 12 chars 2017-09-07 11:06:10,317 Setting DEBUG logging. 2017-09-07 11:06:10,317 attempt 1/10 2017-09-07 11:06:10,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c96d611ebd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 11:06:10,731 unpacking tar archive at: mozilla-central-3c96d611ebd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:10.411933) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:10.412262) ========= script_repo_revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:10.412674) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:10.412941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 11:06:10.426333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2017-09-07 11:06:10.426647) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:11 INFO - MultiFileLogger online at 20170907 11:06:11 in /builds/slave/test 11:06:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:06:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:11 INFO - {'append_to_log': False, 11:06:11 INFO - 'base_work_dir': '/builds/slave/test', 11:06:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:06:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:11 INFO - 'branch': 'Firefox-Non-PGO', 11:06:11 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:11 INFO - 'code_coverage': False, 11:06:11 INFO - 'config_files': ('talos/linux_config.py',), 11:06:11 INFO - 'default_actions': ('clobber', 11:06:11 INFO - 'read-buildbot-config', 11:06:11 INFO - 'download-and-extract', 11:06:11 INFO - 'populate-webroot', 11:06:11 INFO - 'create-virtualenv', 11:06:11 INFO - 'install', 11:06:11 INFO - 'setup-mitmproxy', 11:06:11 INFO - 'run-tests'), 11:06:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:11 INFO - 'disable_ccov_upload': False, 11:06:11 INFO - 'disable_stylo': False, 11:06:11 INFO - 'download_minidump_stackwalk': True, 11:06:11 INFO - 'download_symbols': 'ondemand', 11:06:11 INFO - 'enable_stylo': False, 11:06:11 INFO - 'enable_webrender': False, 11:06:11 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:06:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:11 INFO - 'gecko_profile': False, 11:06:11 INFO - 'gecko_profile_interval': 0, 11:06:11 INFO - 'installer_path': 'installer.exe', 11:06:11 INFO - 'log_level': 'info', 11:06:11 INFO - 'log_name': 'talos', 11:06:11 INFO - 'log_to_console': True, 11:06:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:11 INFO - 'opt_config_files': (), 11:06:11 INFO - 'pip_index': False, 11:06:11 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:06:11 INFO - 'system_bits': '32', 11:06:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:11 INFO - 'title': 'talos-linux64-ix-002', 11:06:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:11 INFO - 'use_talos_json': True, 11:06:11 INFO - 'verify': 'False', 11:06:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:11 INFO - 'work_dir': 'build'} 11:06:11 INFO - [mozharness: 2017-09-07 18:06:11.207139Z] Running clobber step. 11:06:11 INFO - Running pre-action listener: _resource_record_pre_action 11:06:11 INFO - Running main action method: clobber 11:06:11 INFO - rmtree: /builds/slave/test/build 11:06:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:12 INFO - Running post-action listener: _resource_record_post_action 11:06:12 INFO - [mozharness: 2017-09-07 18:06:12.846105Z] Finished clobber step (success) 11:06:12 INFO - [mozharness: 2017-09-07 18:06:12.846203Z] Running read-buildbot-config step. 11:06:12 INFO - Running pre-action listener: _resource_record_pre_action 11:06:12 INFO - Running main action method: read_buildbot_config 11:06:12 INFO - Using buildbot properties: 11:06:12 INFO - { 11:06:12 INFO - "project": "", 11:06:12 INFO - "product": "firefox", 11:06:12 INFO - "who": "ffxbld@noreply.mozilla.org", 11:06:12 INFO - "installer_path": "public/build/target.tar.bz2", 11:06:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:06:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:06:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:06:12 INFO - "stage_platform": "linux64", 11:06:12 INFO - "basedir": "/builds/slave/test", 11:06:12 INFO - "buildnumber": 1, 11:06:12 INFO - "platform": "ubuntu64_hw", 11:06:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:06:12 INFO - "slavebuilddir": "test", 11:06:12 INFO - "taskId": "JkXOBzPFRTupTAQmZJxtfA", 11:06:12 INFO - "branch": "mozilla-central", 11:06:12 INFO - "script_repo_revision": "production", 11:06:12 INFO - "revision": "3c96d611ebd67fc219d22bcb476a72412c76f6c7", 11:06:12 INFO - "slavename": "talos-linux64-ix-002", 11:06:12 INFO - "repo_path": "mozilla-central" 11:06:12 INFO - } 11:06:12 INFO - Finding installer, test and symbols from parent task. 11:06:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkXOBzPFRTupTAQmZJxtfA'}, attempt #1 11:06:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkXOBzPFRTupTAQmZJxtfA'}, attempt #1 11:06:13 INFO - Task dependencies: ErCwGB7lSTS6L7N4qpQiKw 11:06:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw'}, attempt #1 11:06:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 11:06:14 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json 11:06:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip 11:06:14 INFO - Running post-action listener: _resource_record_post_action 11:06:14 INFO - [mozharness: 2017-09-07 18:06:14.432304Z] Finished read-buildbot-config step (success) 11:06:14 INFO - [mozharness: 2017-09-07 18:06:14.432520Z] Running download-and-extract step. 11:06:14 INFO - Running pre-action listener: _resource_record_pre_action 11:06:14 INFO - Running main action method: download_and_extract 11:06:14 INFO - mkdir: /builds/slave/test/build/tests 11:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:14 INFO - trying https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json 11:06:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:06:14 INFO - Downloaded 989 bytes. 11:06:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:06:14 INFO - Using the following test package requirements: 11:06:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:06:14 INFO - u'common': [u'target.common.tests.zip'], 11:06:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:06:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:06:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:06:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:06:14 INFO - u'mozbase': [u'target.common.tests.zip'], 11:06:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:06:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:06:14 INFO - u'web-platform': [u'target.common.tests.zip', 11:06:14 INFO - u'target.web-platform.tests.tar.gz'], 11:06:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:06:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:06:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip 11:06:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:06:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip into memory 11:06:16 INFO - Content-Length response header: 55021210 11:06:16 INFO - Bytes received: 55021210 11:06:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:06:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip 11:06:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:06:27 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip into memory 11:06:28 INFO - Content-Length response header: 55021210 11:06:28 INFO - Bytes received: 55021210 11:06:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip 11:06:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:06:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip into memory 11:06:40 INFO - Content-Length response header: 14496665 11:06:40 INFO - Bytes received: 14496665 11:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:41 INFO - trying https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 11:06:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:06:42 INFO - Downloaded 62754681 bytes. 11:06:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 11:06:42 INFO - mkdir: /builds/slave/test/properties 11:06:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:42 INFO - Contents: 11:06:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 11:06:42 INFO - Running post-action listener: _resource_record_post_action 11:06:42 INFO - Running post-action listener: find_tests_for_verification 11:06:42 INFO - Running post-action listener: set_extra_try_arguments 11:06:42 INFO - [mozharness: 2017-09-07 18:06:42.214392Z] Finished download-and-extract step (success) 11:06:42 INFO - [mozharness: 2017-09-07 18:06:42.214489Z] Running populate-webroot step. 11:06:42 INFO - Running pre-action listener: _resource_record_pre_action 11:06:42 INFO - Running main action method: populate_webroot 11:06:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['tresize', 11:06:42 INFO - 'tcanvasmark']}, 11:06:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['dromaeo_css', 11:06:42 INFO - 'kraken']}, 11:06:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'tests': ['damp', 'tps']}, 11:06:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['damp', 'tps']}, 11:06:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['dromaeo_dom']}, 11:06:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:06:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['basic_compositor_video', 11:06:42 INFO - 'glvideo']}, 11:06:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:06:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['ts_paint_webext', 11:06:42 INFO - 'tp5o_webext']}, 11:06:42 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:42 INFO - 'ts_paint', 11:06:42 INFO - 'tpaint', 11:06:42 INFO - 'sessionrestore', 11:06:42 INFO - 'sessionrestore_many_windows', 11:06:42 INFO - 'sessionrestore_no_auto_restore', 11:06:42 INFO - 'tabpaint']}, 11:06:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['a11yr', 11:06:42 INFO - 'ts_paint', 11:06:42 INFO - 'tpaint', 11:06:42 INFO - 'sessionrestore', 11:06:42 INFO - 'sessionrestore_many_windows', 11:06:42 INFO - 'sessionrestore_no_auto_restore', 11:06:42 INFO - 'tabpaint']}, 11:06:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:06:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:06:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['bloom_basic_singleton']}, 11:06:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['bloom_basic']}, 11:06:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:42 INFO - 'tsvgr_opacity', 11:06:42 INFO - 'tart', 11:06:42 INFO - 'tscrollx', 11:06:42 INFO - 'tsvg_static']}, 11:06:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['tsvgx', 11:06:42 INFO - 'tsvgr_opacity', 11:06:42 INFO - 'tart', 11:06:42 INFO - 'tscrollx', 11:06:42 INFO - 'tsvg_static']}, 11:06:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:06:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'talos_options': ['--disable-stylo'], 11:06:42 INFO - 'tests': ['tp5o']}, 11:06:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:42 INFO - 'talos_options': ['--mitmproxy', 11:06:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:42 INFO - '--firstNonBlankPaint'], 11:06:42 INFO - 'tests': ['tp6_google', 11:06:42 INFO - 'tp6_youtube', 11:06:42 INFO - 'tp6_amazon', 11:06:42 INFO - 'tp6_facebook']}, 11:06:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:42 INFO - 'talos_options': ['--disable-stylo', 11:06:42 INFO - '--mitmproxy', 11:06:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:42 INFO - '--firstNonBlankPaint'], 11:06:42 INFO - 'tests': ['tp6_google', 11:06:42 INFO - 'tp6_youtube', 11:06:42 INFO - 'tp6_amazon', 11:06:42 INFO - 'tp6_facebook']}, 11:06:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:42 INFO - 'talos_options': ['--stylo-threads=1', 11:06:42 INFO - '--mitmproxy', 11:06:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:42 INFO - '--firstNonBlankPaint'], 11:06:42 INFO - 'tests': ['tp6_google', 11:06:42 INFO - 'tp6_youtube', 11:06:42 INFO - 'tp6_amazon', 11:06:42 INFO - 'tp6_facebook']}, 11:06:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'talos_options': ['--xperf_path', 11:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:42 INFO - 'tests': ['tp5n']}, 11:06:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:42 INFO - 'talos_options': ['--disable-stylo', 11:06:42 INFO - '--xperf_path', 11:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:42 INFO - 'tests': ['tp5n']}}} 11:06:42 INFO - Running post-action listener: _resource_record_post_action 11:06:42 INFO - [mozharness: 2017-09-07 18:06:42.229465Z] Finished populate-webroot step (success) 11:06:42 INFO - [mozharness: 2017-09-07 18:06:42.229554Z] Running create-virtualenv step. 11:06:42 INFO - Running pre-action listener: _resource_record_pre_action 11:06:42 INFO - Running main action method: create_virtualenv 11:06:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:06:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:06:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:06:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:43 INFO - Installing pip...............done. 11:06:43 INFO - Return code: 0 11:06:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:06:43 INFO - Reading from file tmpfile_stdout 11:06:43 INFO - Output received: 11:06:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:06:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:43 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:06:43 INFO - Using env: {'DISPLAY': ':0', 11:06:43 INFO - 'HOME': '/home/cltbld', 11:06:43 INFO - 'LANG': 'en_US.UTF-8', 11:06:43 INFO - 'LANGUAGE': 'en_US:en', 11:06:43 INFO - 'LOGNAME': 'cltbld', 11:06:43 INFO - 'MAIL': '/var/mail/cltbld', 11:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:43 INFO - 'MOZ_NO_REMOTE': '1', 11:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:43 INFO - 'NO_EM_RESTART': '1', 11:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:43 INFO - 'PWD': '/builds/slave/test', 11:06:43 INFO - 'SHELL': '/bin/bash', 11:06:43 INFO - 'SHLVL': '1', 11:06:43 INFO - 'TERM': 'linux', 11:06:43 INFO - 'TMOUT': '86400', 11:06:43 INFO - 'USER': 'cltbld', 11:06:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:43 INFO - '_': '/tools/buildbot/bin/python'} 11:06:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:06:44 INFO - Downloading/unpacking pip>=1.5 11:06:44 INFO - Running setup.py egg_info for package pip 11:06:44 INFO - warning: no files found matching 'pip/cacert.pem' 11:06:44 INFO - warning: no files found matching '*.html' under directory 'docs' 11:06:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:06:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:06:44 INFO - Installing collected packages: pip 11:06:44 INFO - Found existing installation: pip 1.1 11:06:44 INFO - Uninstalling pip: 11:06:44 INFO - Successfully uninstalled pip 11:06:44 INFO - Running setup.py install for pip 11:06:44 INFO - warning: no files found matching 'pip/cacert.pem' 11:06:44 INFO - warning: no files found matching '*.html' under directory 'docs' 11:06:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:06:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:06:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:06:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:06:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:06:44 INFO - Successfully installed pip 11:06:44 INFO - Cleaning up... 11:06:44 INFO - Return code: 0 11:06:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:44 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:06:44 INFO - Using env: {'DISPLAY': ':0', 11:06:44 INFO - 'HOME': '/home/cltbld', 11:06:44 INFO - 'LANG': 'en_US.UTF-8', 11:06:44 INFO - 'LANGUAGE': 'en_US:en', 11:06:44 INFO - 'LOGNAME': 'cltbld', 11:06:44 INFO - 'MAIL': '/var/mail/cltbld', 11:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:44 INFO - 'MOZ_NO_REMOTE': '1', 11:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:44 INFO - 'NO_EM_RESTART': '1', 11:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:44 INFO - 'PWD': '/builds/slave/test', 11:06:44 INFO - 'SHELL': '/bin/bash', 11:06:44 INFO - 'SHLVL': '1', 11:06:44 INFO - 'TERM': 'linux', 11:06:44 INFO - 'TMOUT': '86400', 11:06:44 INFO - 'USER': 'cltbld', 11:06:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:44 INFO - '_': '/tools/buildbot/bin/python'} 11:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:44 INFO - Downloading/unpacking psutil>=3.1.1 11:06:44 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 11:06:44 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 11:06:44 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 11:06:44 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 11:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:45 INFO - Installing collected packages: psutil 11:06:45 INFO - Running setup.py install for psutil 11:06:45 INFO - building 'psutil._psutil_linux' extension 11:06:45 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 11:06:46 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 11:06:46 INFO - building 'psutil._psutil_posix' extension 11:06:46 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 11:06:46 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 11:06:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:46 INFO - Successfully installed psutil 11:06:46 INFO - Cleaning up... 11:06:46 INFO - Return code: 0 11:06:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:46 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:06:46 INFO - Using env: {'DISPLAY': ':0', 11:06:46 INFO - 'HOME': '/home/cltbld', 11:06:46 INFO - 'LANG': 'en_US.UTF-8', 11:06:46 INFO - 'LANGUAGE': 'en_US:en', 11:06:46 INFO - 'LOGNAME': 'cltbld', 11:06:46 INFO - 'MAIL': '/var/mail/cltbld', 11:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:46 INFO - 'MOZ_NO_REMOTE': '1', 11:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:46 INFO - 'NO_EM_RESTART': '1', 11:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:46 INFO - 'PWD': '/builds/slave/test', 11:06:46 INFO - 'SHELL': '/bin/bash', 11:06:46 INFO - 'SHLVL': '1', 11:06:46 INFO - 'TERM': 'linux', 11:06:46 INFO - 'TMOUT': '86400', 11:06:46 INFO - 'USER': 'cltbld', 11:06:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:46 INFO - '_': '/tools/buildbot/bin/python'} 11:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:46 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 11:06:46 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 11:06:46 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 11:06:46 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 11:06:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:47 INFO - Installing collected packages: mozsystemmonitor 11:06:47 INFO - Running setup.py install for mozsystemmonitor 11:06:47 INFO - Successfully installed mozsystemmonitor 11:06:47 INFO - Cleaning up... 11:06:47 INFO - Return code: 0 11:06:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:47 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:06:47 INFO - Using env: {'DISPLAY': ':0', 11:06:47 INFO - 'HOME': '/home/cltbld', 11:06:47 INFO - 'LANG': 'en_US.UTF-8', 11:06:47 INFO - 'LANGUAGE': 'en_US:en', 11:06:47 INFO - 'LOGNAME': 'cltbld', 11:06:47 INFO - 'MAIL': '/var/mail/cltbld', 11:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:47 INFO - 'MOZ_NO_REMOTE': '1', 11:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:47 INFO - 'NO_EM_RESTART': '1', 11:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:47 INFO - 'PWD': '/builds/slave/test', 11:06:47 INFO - 'SHELL': '/bin/bash', 11:06:47 INFO - 'SHLVL': '1', 11:06:47 INFO - 'TERM': 'linux', 11:06:47 INFO - 'TMOUT': '86400', 11:06:47 INFO - 'USER': 'cltbld', 11:06:47 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:47 INFO - '_': '/tools/buildbot/bin/python'} 11:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:48 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:48 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 11:06:48 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 11:06:48 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 11:06:48 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 11:06:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06:49 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 11:06:49 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 11:06:49 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 11:06:49 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 11:06:49 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:49 INFO - warning: no files found matching '*.txt' 11:06:49 INFO - no previously-included directories found matching 'build' 11:06:49 INFO - no previously-included directories found matching 'dist' 11:06:49 INFO - no previously-included directories found matching '.git*' 11:06:49 INFO - Installing collected packages: jsonschema, functools32 11:06:49 INFO - Running setup.py install for functools32 11:06:49 INFO - warning: no files found matching '*.txt' 11:06:49 INFO - no previously-included directories found matching 'build' 11:06:49 INFO - no previously-included directories found matching 'dist' 11:06:49 INFO - no previously-included directories found matching '.git*' 11:06:49 INFO - Successfully installed jsonschema functools32 11:06:49 INFO - Cleaning up... 11:06:49 INFO - Return code: 0 11:06:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:49 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:06:49 INFO - Using env: {'DISPLAY': ':0', 11:06:49 INFO - 'HOME': '/home/cltbld', 11:06:49 INFO - 'LANG': 'en_US.UTF-8', 11:06:49 INFO - 'LANGUAGE': 'en_US:en', 11:06:49 INFO - 'LOGNAME': 'cltbld', 11:06:49 INFO - 'MAIL': '/var/mail/cltbld', 11:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:49 INFO - 'MOZ_NO_REMOTE': '1', 11:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:49 INFO - 'NO_EM_RESTART': '1', 11:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:49 INFO - 'PWD': '/builds/slave/test', 11:06:49 INFO - 'SHELL': '/bin/bash', 11:06:49 INFO - 'SHLVL': '1', 11:06:49 INFO - 'TERM': 'linux', 11:06:49 INFO - 'TMOUT': '86400', 11:06:49 INFO - 'USER': 'cltbld', 11:06:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:49 INFO - '_': '/tools/buildbot/bin/python'} 11:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:49 INFO - Cleaning up... 11:06:49 INFO - Return code: 0 11:06:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:49 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:06:49 INFO - Using env: {'DISPLAY': ':0', 11:06:49 INFO - 'HOME': '/home/cltbld', 11:06:49 INFO - 'LANG': 'en_US.UTF-8', 11:06:49 INFO - 'LANGUAGE': 'en_US:en', 11:06:49 INFO - 'LOGNAME': 'cltbld', 11:06:49 INFO - 'MAIL': '/var/mail/cltbld', 11:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:49 INFO - 'MOZ_NO_REMOTE': '1', 11:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:49 INFO - 'NO_EM_RESTART': '1', 11:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:49 INFO - 'PWD': '/builds/slave/test', 11:06:49 INFO - 'SHELL': '/bin/bash', 11:06:49 INFO - 'SHLVL': '1', 11:06:49 INFO - 'TERM': 'linux', 11:06:49 INFO - 'TMOUT': '86400', 11:06:49 INFO - 'USER': 'cltbld', 11:06:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:49 INFO - '_': '/tools/buildbot/bin/python'} 11:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:50 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 11:06:50 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 11:06:50 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 11:06:50 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 11:06:51 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:51 INFO - Downloading docopt-0.6.1.tar.gz 11:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:51 INFO - Running setup.py install for blobuploader 11:06:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:51 INFO - Running setup.py install for requests 11:06:52 INFO - Running setup.py install for docopt 11:06:52 INFO - Successfully installed blobuploader requests docopt 11:06:52 INFO - Cleaning up... 11:06:52 INFO - Return code: 0 11:06:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:52 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:52 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:06:52 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:52 INFO - Using env: {'DISPLAY': ':0', 11:06:52 INFO - 'HOME': '/home/cltbld', 11:06:52 INFO - 'LANG': 'en_US.UTF-8', 11:06:52 INFO - 'LANGUAGE': 'en_US:en', 11:06:52 INFO - 'LOGNAME': 'cltbld', 11:06:52 INFO - 'MAIL': '/var/mail/cltbld', 11:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:52 INFO - 'MOZ_NO_REMOTE': '1', 11:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:52 INFO - 'NO_EM_RESTART': '1', 11:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:52 INFO - 'PWD': '/builds/slave/test', 11:06:52 INFO - 'SHELL': '/bin/bash', 11:06:52 INFO - 'SHLVL': '1', 11:06:52 INFO - 'TERM': 'linux', 11:06:52 INFO - 'TMOUT': '86400', 11:06:52 INFO - 'USER': 'cltbld', 11:06:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:52 INFO - '_': '/tools/buildbot/bin/python'} 11:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:52 INFO - Running setup.py (path:/tmp/pip-nSgl9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:52 INFO - Running setup.py (path:/tmp/pip-4xW1_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:52 INFO - Running setup.py (path:/tmp/pip-qwLMJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:52 INFO - Running setup.py (path:/tmp/pip-rV6M0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:52 INFO - Running setup.py (path:/tmp/pip-6Qd6MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:52 INFO - Running setup.py (path:/tmp/pip-WMeLmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:52 INFO - Running setup.py (path:/tmp/pip-CXXkhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:53 INFO - Running setup.py (path:/tmp/pip-VVhmBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:53 INFO - Running setup.py (path:/tmp/pip-k6qsca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:53 INFO - Running setup.py (path:/tmp/pip-ClgZ33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:53 INFO - Running setup.py (path:/tmp/pip-Qil53R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:53 INFO - Running setup.py (path:/tmp/pip-8apvgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:53 INFO - Running setup.py (path:/tmp/pip-h9WvkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:53 INFO - Running setup.py (path:/tmp/pip-zMzWBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:53 INFO - Running setup.py (path:/tmp/pip-ktwRFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:53 INFO - Running setup.py (path:/tmp/pip-eq1QNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:53 INFO - Running setup.py (path:/tmp/pip-YQqd0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:53 INFO - Running setup.py install for manifestparser 11:06:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:53 INFO - Running setup.py install for mozcrash 11:06:53 INFO - Running setup.py install for mozdebug 11:06:54 INFO - Running setup.py install for mozdevice 11:06:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Running setup.py install for mozfile 11:06:54 INFO - Running setup.py install for mozhttpd 11:06:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Running setup.py install for mozinfo 11:06:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Running setup.py install for mozInstall 11:06:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Running setup.py install for mozleak 11:06:54 INFO - Running setup.py install for mozlog 11:06:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Running setup.py install for moznetwork 11:06:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:54 INFO - Running setup.py install for mozprocess 11:06:54 INFO - Running setup.py install for mozprofile 11:06:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:55 INFO - Running setup.py install for mozrunner 11:06:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:55 INFO - Running setup.py install for mozscreenshot 11:06:55 INFO - Running setup.py install for moztest 11:06:55 INFO - Running setup.py install for mozversion 11:06:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:55 INFO - Cleaning up... 11:06:55 INFO - Return code: 0 11:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:55 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:55 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:06:55 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:55 INFO - Using env: {'DISPLAY': ':0', 11:06:55 INFO - 'HOME': '/home/cltbld', 11:06:55 INFO - 'LANG': 'en_US.UTF-8', 11:06:55 INFO - 'LANGUAGE': 'en_US:en', 11:06:55 INFO - 'LOGNAME': 'cltbld', 11:06:55 INFO - 'MAIL': '/var/mail/cltbld', 11:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:55 INFO - 'MOZ_NO_REMOTE': '1', 11:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:55 INFO - 'NO_EM_RESTART': '1', 11:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:55 INFO - 'PWD': '/builds/slave/test', 11:06:55 INFO - 'SHELL': '/bin/bash', 11:06:55 INFO - 'SHLVL': '1', 11:06:55 INFO - 'TERM': 'linux', 11:06:55 INFO - 'TMOUT': '86400', 11:06:55 INFO - 'USER': 'cltbld', 11:06:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:55 INFO - '_': '/tools/buildbot/bin/python'} 11:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:55 INFO - Running setup.py (path:/tmp/pip-d2oFew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:55 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)) 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:55 INFO - Running setup.py (path:/tmp/pip-iBmnoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:55 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)) 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:55 INFO - Running setup.py (path:/tmp/pip-y7dRbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:55 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)) 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:55 INFO - Running setup.py (path:/tmp/pip-UL_1z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:56 INFO - Running setup.py (path:/tmp/pip-7ykBG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:56 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:56 INFO - Running setup.py (path:/tmp/pip-u1nYoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:56 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:56 INFO - Running setup.py (path:/tmp/pip-rN3JSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:56 INFO - Running setup.py (path:/tmp/pip-O_aQBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:56 INFO - Running setup.py (path:/tmp/pip-YdZDce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:56 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:56 INFO - Running setup.py (path:/tmp/pip-5V27hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:56 INFO - Running setup.py (path:/tmp/pip-Or3BaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:56 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:56 INFO - Running setup.py (path:/tmp/pip-DMneMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:56 INFO - Running setup.py (path:/tmp/pip-ly46pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:56 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:56 INFO - Running setup.py (path:/tmp/pip-gLrxOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:56 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:56 INFO - Running setup.py (path:/tmp/pip-hvoun6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:56 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:56 INFO - Running setup.py (path:/tmp/pip-DkokQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:56 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)) 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:56 INFO - Running setup.py (path:/tmp/pip-0b_HNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:56 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)) 11:06:56 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)) 11:06:56 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)) 11:06:56 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)) 11:06:56 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:56 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:06:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:58 INFO - Downloading blessings-1.6.tar.gz 11:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:58 INFO - Installing collected packages: blessings 11:06:58 INFO - Running setup.py install for blessings 11:06:58 INFO - Successfully installed blessings 11:06:58 INFO - Cleaning up... 11:06:58 INFO - Return code: 0 11:06:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:58 INFO - Reading from file tmpfile_stdout 11:06:58 INFO - Current package versions: 11:06:58 INFO - argparse == 1.2.1 11:06:58 INFO - blessings == 1.6 11:06:58 INFO - blobuploader == 1.2.4 11:06:58 INFO - docopt == 0.6.1 11:06:58 INFO - functools32 == 3.2.3-2 11:06:58 INFO - jsonschema == 2.5.1 11:06:58 INFO - manifestparser == 1.1 11:06:58 INFO - mozInstall == 1.13 11:06:58 INFO - mozcrash == 1.0 11:06:58 INFO - mozdebug == 0.1 11:06:58 INFO - mozdevice == 0.51 11:06:58 INFO - mozfile == 1.2 11:06:58 INFO - mozhttpd == 0.7 11:06:58 INFO - mozinfo == 0.10 11:06:58 INFO - mozleak == 0.1 11:06:58 INFO - mozlog == 3.5 11:06:58 INFO - moznetwork == 0.27 11:06:58 INFO - mozprocess == 0.25 11:06:58 INFO - mozprofile == 0.28 11:06:58 INFO - mozrunner == 6.13 11:06:58 INFO - mozscreenshot == 0.1 11:06:58 INFO - mozsystemmonitor == 0.3 11:06:58 INFO - moztest == 0.8 11:06:58 INFO - mozversion == 1.4 11:06:58 INFO - psutil == 3.1.1 11:06:58 INFO - requests == 1.2.3 11:06:58 INFO - wsgiref == 0.1.2 11:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:58 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:06:58 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:06:58 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:58 INFO - Using env: {'DISPLAY': ':0', 11:06:58 INFO - 'HOME': '/home/cltbld', 11:06:58 INFO - 'LANG': 'en_US.UTF-8', 11:06:58 INFO - 'LANGUAGE': 'en_US:en', 11:06:58 INFO - 'LOGNAME': 'cltbld', 11:06:58 INFO - 'MAIL': '/var/mail/cltbld', 11:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:58 INFO - 'MOZ_NO_REMOTE': '1', 11:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:58 INFO - 'NO_EM_RESTART': '1', 11:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:58 INFO - 'PWD': '/builds/slave/test', 11:06:58 INFO - 'SHELL': '/bin/bash', 11:06:58 INFO - 'SHLVL': '1', 11:06:58 INFO - 'TERM': 'linux', 11:06:58 INFO - 'TMOUT': '86400', 11:06:58 INFO - 'USER': 'cltbld', 11:06:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:58 INFO - '_': '/tools/buildbot/bin/python'} 11:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:58 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)) 11:06:58 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)) 11:06:58 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)) 11:06:58 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)) 11:06:58 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)) 11:06:58 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)) 11:06:58 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)) 11:06:58 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)) 11:06:58 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)) 11:06:58 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:59 INFO - HTTP error 403 while getting http://pypi.pvt.build.mozilla.org/pub/simplejson-3.3.0.tar.gz (from http://pypi.pvt.build.mozilla.org/pub/) 11:06:59 INFO - Cleaning up... 11:06:59 INFO - Exception: 11:06:59 ERROR - Traceback (most recent call last): 11:06:59 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip/basecommand.py", line 122, in main 11:06:59 INFO - status = self.run(options, args) 11:06:59 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip/commands/install.py", line 278, in run 11:06:59 INFO - requirement_set.prepare_files(finder, force_root_egg_info=self.bundle, bundle=self.bundle) 11:06:59 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip/req.py", line 1197, in prepare_files 11:06:59 INFO - do_download, 11:06:59 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip/req.py", line 1375, in unpack_url 11:06:59 INFO - self.session, 11:06:59 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip/download.py", line 547, in unpack_http_url 11:06:59 INFO - resp.raise_for_status() 11:06:59 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip/_vendor/requests/models.py", line 773, in raise_for_status 11:06:59 INFO - raise HTTPError(http_error_msg, response=self) 11:06:59 INFO - HTTPError: 403 Client Error: Forbidden 11:06:59 INFO - Storing debug log for failure in /home/cltbld/.pip/pip.log 11:06:59 WARNING - Return code: 2 11:06:59 INFO - retry: Failed, sleeping 60 seconds before retrying 11:07:59 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 #2 11:07:59 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:07:59 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:07:59 INFO - Using env: {'DISPLAY': ':0', 11:07:59 INFO - 'HOME': '/home/cltbld', 11:07:59 INFO - 'LANG': 'en_US.UTF-8', 11:07:59 INFO - 'LANGUAGE': 'en_US:en', 11:07:59 INFO - 'LOGNAME': 'cltbld', 11:07:59 INFO - 'MAIL': '/var/mail/cltbld', 11:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:59 INFO - 'MOZ_NO_REMOTE': '1', 11:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:59 INFO - 'NO_EM_RESTART': '1', 11:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:59 INFO - 'PWD': '/builds/slave/test', 11:07:59 INFO - 'SHELL': '/bin/bash', 11:07:59 INFO - 'SHLVL': '1', 11:07:59 INFO - 'TERM': 'linux', 11:07:59 INFO - 'TMOUT': '86400', 11:07:59 INFO - 'USER': 'cltbld', 11:07:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:59 INFO - '_': '/tools/buildbot/bin/python'} 11:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:00 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)) 11:08:00 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)) 11:08:00 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)) 11:08:00 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)) 11:08:00 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)) 11:08:00 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)) 11:08:00 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)) 11:08:00 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)) 11:08:00 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)) 11:08:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:08:01 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)) 11:08:01 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)) 11:08:01 INFO - Installing collected packages: simplejson 11:08:01 INFO - Running setup.py install for simplejson 11:08:01 INFO - building 'simplejson._speedups' extension 11:08:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:08:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:08:02 INFO - Successfully installed simplejson 11:08:02 INFO - Cleaning up... 11:08:02 INFO - Return code: 0 11:08:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:02 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/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 0x1e761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', '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 11:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:08:02 INFO - Using env: {'DISPLAY': ':0', 11:08:02 INFO - 'HOME': '/home/cltbld', 11:08:02 INFO - 'LANG': 'en_US.UTF-8', 11:08:02 INFO - 'LANGUAGE': 'en_US:en', 11:08:02 INFO - 'LOGNAME': 'cltbld', 11:08:02 INFO - 'MAIL': '/var/mail/cltbld', 11:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:02 INFO - 'MOZ_NO_REMOTE': '1', 11:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:02 INFO - 'NO_EM_RESTART': '1', 11:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:02 INFO - 'PWD': '/builds/slave/test', 11:08:02 INFO - 'SHELL': '/bin/bash', 11:08:02 INFO - 'SHLVL': '1', 11:08:02 INFO - 'TERM': 'linux', 11:08:02 INFO - 'TMOUT': '86400', 11:08:02 INFO - 'USER': 'cltbld', 11:08:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:02 INFO - '_': '/tools/buildbot/bin/python'} 11:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:08:02 INFO - Cleaning up... 11:08:02 INFO - Return code: 0 11:08:02 INFO - Running post-action listener: _resource_record_post_action 11:08:02 INFO - Running post-action listener: _start_resource_monitoring 11:08:02 INFO - Starting resource monitoring. 11:08:02 INFO - [mozharness: 2017-09-07 18:08:02.590875Z] Finished create-virtualenv step (success) 11:08:02 INFO - [mozharness: 2017-09-07 18:08:02.591403Z] Running install step. 11:08:02 INFO - Running pre-action listener: _resource_record_pre_action 11:08:02 INFO - Running main action method: install 11:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:02 INFO - Reading from file tmpfile_stdout 11:08:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:08:02 INFO - Reading from file tmpfile_stdout 11:08:02 INFO - Output received: 11:08:02 INFO - Usage: mozinstall [options] installer 11:08:02 INFO - Options: 11:08:02 INFO - -h, --help show this help message and exit 11:08:02 INFO - -d DEST, --destination=DEST 11:08:02 INFO - Directory to install application into. [default: 11:08:02 INFO - "/builds/slave/test"] 11:08:02 INFO - --app=APP Application being installed. [default: firefox] 11:08:02 INFO - mkdir: /builds/slave/test/build/application 11:08:02 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'] 11:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:08:19 INFO - Reading from file tmpfile_stdout 11:08:19 INFO - Output received: 11:08:19 INFO - /builds/slave/test/build/application/firefox/firefox 11:08:19 INFO - Running post-action listener: _resource_record_post_action 11:08:19 INFO - [mozharness: 2017-09-07 18:08:19.428930Z] Finished install step (success) 11:08:19 INFO - [mozharness: 2017-09-07 18:08:19.429180Z] Running setup-mitmproxy step. 11:08:19 INFO - Running pre-action listener: _resource_record_pre_action 11:08:19 INFO - Running main action method: setup_mitmproxy 11:08:19 INFO - Skipping: mitmproxy is not required 11:08:19 INFO - Running post-action listener: _resource_record_post_action 11:08:19 INFO - [mozharness: 2017-09-07 18:08:19.430375Z] Finished setup-mitmproxy step (success) 11:08:19 INFO - [mozharness: 2017-09-07 18:08:19.430595Z] Running run-tests step. 11:08:19 INFO - Running pre-action listener: _resource_record_pre_action 11:08:19 INFO - Running pre-action listener: _set_gcov_prefix 11:08:19 INFO - Running main action method: run_tests 11:08:19 WARNING - Try message not found. 11:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:08:19 INFO - Python 2.7.3 11:08:19 INFO - Return code: 0 11:08:19 INFO - grabbing minidump binary from tooltool 11:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:08:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x21e6090>, '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 0x21e6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:08:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:08:19 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:08:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:08:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:19 INFO - Return code: 0 11:08:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:08:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:08:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:08:19 INFO - ENV: RUST_BACKTRACE is now full 11:08:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:08:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:08:19 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:08:19 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:08:19 INFO - Using env: {'DISPLAY': ':0', 11:08:19 INFO - 'HOME': '/home/cltbld', 11:08:19 INFO - 'LANG': 'en_US.UTF-8', 11:08:19 INFO - 'LANGUAGE': 'en_US:en', 11:08:19 INFO - 'LOGNAME': 'cltbld', 11:08:19 INFO - 'MAIL': '/var/mail/cltbld', 11:08:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:19 INFO - 'MOZ_NO_REMOTE': '1', 11:08:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:19 INFO - 'NO_EM_RESTART': '1', 11:08:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:19 INFO - 'PWD': '/builds/slave/test', 11:08:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:19 INFO - 'RUST_BACKTRACE': 'full', 11:08:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:08:19 INFO - 'SHELL': '/bin/bash', 11:08:19 INFO - 'SHLVL': '1', 11:08:19 INFO - 'TERM': 'linux', 11:08:19 INFO - 'TMOUT': '86400', 11:08:19 INFO - 'USER': 'cltbld', 11:08:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:19 INFO - '_': '/tools/buildbot/bin/python'} 11:08:19 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:08:19 INFO - mozversion application_buildid: 20170907171306 11:08:19 INFO - mozversion application_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 11:08:19 INFO - mozversion application_display_name: Nightly 11:08:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:19 INFO - mozversion application_name: Firefox 11:08:19 INFO - mozversion application_remotingname: firefox 11:08:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:08:19 INFO - mozversion application_vendor: Mozilla 11:08:19 INFO - mozversion application_version: 57.0a1 11:08:19 INFO - mozversion platform_buildid: 20170907171306 11:08:19 INFO - mozversion platform_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 11:08:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:08:19 INFO - mozversion platform_version: 57.0a1 11:08:19 INFO - using testdate: 1504807699 11:08:19 INFO - actual date: 1504807699 11:08:19 INFO - starting webserver on 'localhost:39430' 11:08:19 INFO - SUITE-START | Running 2 tests 11:08:19 INFO - TEST-START | dromaeo_css 11:08:19 INFO - Initialising browser for dromaeo_css test... 11:08:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39430/getInfo.html -profile /tmp/tmpyqDqaY/profile 11:08:19 INFO - TEST-INFO | started process 23139 (/builds/slave/test/build/application/firefox/firefox http://localhost:39430/getInfo.html) 11:08:25 INFO - TEST-INFO | 23139: exit 0 11:08:25 INFO - Browser initialized. 11:08:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:25 INFO - Using env: {'DISPLAY': ':0', 11:08:25 INFO - 'HOME': '/home/cltbld', 11:08:25 INFO - 'JSGC_DISABLE_POISONING': '1', 11:08:25 INFO - 'LANG': 'en_US.UTF-8', 11:08:25 INFO - 'LANGUAGE': 'en_US:en', 11:08:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:08:25 INFO - 'LOGNAME': 'cltbld', 11:08:25 INFO - 'MAIL': '/var/mail/cltbld', 11:08:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:25 INFO - 'MOZ_CRASHREPORTER': '1', 11:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:08:25 INFO - 'MOZ_NO_REMOTE': '1', 11:08:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:25 INFO - 'NO_EM_RESTART': '1', 11:08:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:25 INFO - 'PWD': '/builds/slave/test', 11:08:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:25 INFO - 'RUST_BACKTRACE': 'full', 11:08:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:08:25 INFO - 'SHELL': '/bin/bash', 11:08:25 INFO - 'SHLVL': '1', 11:08:25 INFO - 'STYLO_FORCE_DISABLED': '1', 11:08:25 INFO - 'TERM': 'linux', 11:08:25 INFO - 'TMOUT': '86400', 11:08:25 INFO - 'USER': 'cltbld', 11:08:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:25 INFO - '_': '/tools/buildbot/bin/python'} 11:08:25 INFO - TEST-INFO | started process 23335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyqDqaY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:26 INFO - PID 23335 | 11:08:26 INFO - PID 23335 | (/builds/slave/test/build/application/firefox/firefox:23386): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:08:26 INFO - PID 23335 | 11:08:36 INFO - PID 23335 | RSS: Main: 169664512 11:08:36 INFO - PID 23335 | 11:11:33 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39430/tests/dromaeo/cssquery-ext.html) 11:11:35 INFO - PID 23335 | RSS: Main: 172068864 11:11:35 INFO - PID 23335 | 11:14:37 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-ext.html (next: http://localhost:39430/tests/dromaeo/cssquery-jquery.html) 11:14:38 INFO - PID 23335 | RSS: Main: 168312832 11:14:38 INFO - PID 23335 | 11:17:40 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39430/tests/dromaeo/cssquery-mootools.html) 11:17:40 INFO - PID 23335 | RSS: Main: 170389504 11:17:40 INFO - PID 23335 | 11:20:42 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39430/tests/dromaeo/cssquery-prototype.html) 11:20:42 INFO - PID 23335 | RSS: Main: 169639936 11:20:42 INFO - PID 23335 | 11:23:46 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39430/tests/dromaeo/cssquery-yui.html) 11:23:46 INFO - PID 23335 | RSS: Main: 168738816 11:23:46 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-yui.html (next: http://localhost:39430/tests/dromaeo/cssquery-dojo.html) 11:26:48 INFO - PID 23335 | RSS: Main: 173576192 11:26:48 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | __start_tp_report 11:26:48 INFO - PID 23335 | _x_x_mozilla_page_load 11:26:48 INFO - PID 23335 | _x_x_mozilla_page_load_details 11:26:48 INFO - PID 23335 | |i|pagename|runs| 11:26:48 INFO - PID 23335 | |0;dojo.html;3251.496018117192;3280.4915238138096;3300.9339813203737;3312.4865645824875;3320.020593924792;6263.467605253548;6360.045993101031;6406.167198264219;6441.6457094859825;6487.383698548642;6347.365263473662;6401.295857455676;6532;6545.672716364174;6568.474522038237;5831.650100993933;5910;5913;5950.137230101633;6002.729877155517;5842.357340692521;5959.433853783884;5993.041113421853;6014.609050411731;6022.518198544106;5708.97145514274;5776.913346299809;5854.20968169296;5923.999999999978;5929.28848538176;5771.134329850514;5862.237909071793;5888.116782482619;5916.911246331309;5936.792212272593;5821.854453638693;5869.85325366865;5889.265155759612;5893;5968.253968253968;6356.936430635681;6384.808455746335;6402.583832050948;6492;6523;6881.690323935435;6929.480288978347;6937.202221744514;6945.548539344926;6946.0622815920215;6876.656167191671;6882.8967565486555;6928.826779330507;6976.755813546552;6993.89509157363;6199;6287.779927702509;6295.244570651551;6299.023651334051;6299.716512756937;6912.688928998207;6917.169939607279;6945.965270173718;6948.861022779516;6952;6620.867582648417;6641.501887358468;6707.966460167668;6731.49513786468;6821.590704557742;6903.378695917391;6956.200036995709;6984.895226571605;6988.021676965229;6992.16094068715;6853.143357080365;6864.279250678607;6921.757738479129;6928.307169283032;6942.271061538567;6627.138471998705;6757.425618822357;6841.486888483284;6852.074969879102;6918.0314755934205;5439.129739241703;5445.727713614304;5457.808976685797;5482.80810171642;5489.066858634042;4719.5044520325555;4809.807607695723;4835.564799168092;4860.635452341088;4862.319275301461;5803.390643982321;5977.731002104916;5980.880382392328;6051.334353221142;6052.061930400795;6746.763863264762;6888.862222755617;6931.930680693229;6937.479689023344;6938.895916561256;5939.227900372924;5966.134910438049;5976.8804623908145;5976.970115149484;5995.130706047598;5886.764529418775;5900.616459930091;5923.052311630205;5976.312724036791;5983.970080149658;6451.741930322734;6565.704543295563;6622.1722284714415;6641.867162656817;6710.83222919431;6963.965180174168;6979.616121113388;6982.6159561222585;6984.057152284377;7003.264657211123;6589.967050164719;6713.563618364986;6763.425108865801;6776.356246156607;6784.457243420613;6753.898691519533;6769.864602708017;6782.69477873487;6855.348741869514;6858.965705171442;6707.530472867048;6822.249552549315;6845.178578570603;6908.2400935896;6982.860342793218;6692.1969363674725;6717.227518835396;6729.259781424137;6734.9326506734305;6744.325567443413;6480.222373315044;6570.8357291068105;6579.4736421087155;6689.09697190873;6794.9320506796275;6423.582467139621;6427.228732552124;6431.678416079084;6439.259485159267;6441.903371449338;6466.06242094903;6505.674716264073;6535.248446428722;6551.541392102507;6551.672416379257;6316.178896743394;6326.557141000086;6492.837679058061;6560.147180866456;6565.934340656532 11:26:48 INFO - PID 23335 | |1;ext.html;845.049319515545;868.2359523619216;876.6274333408304;877.7454538183923;877.8814859993906;38893.61106388935;39609.405858912105;39640.40539391904;42590.57409425905;42830;38611.61388386115;39039;39070.60929390705;39112.413313800316;39222.41166382506;7019.964900175518;7109.146902371723;7124.323189297034;7159.140903091637;7625.199354067799;7670.501417407851;7790.571518566477;7794.103678077008;7794.922050779504;7795.688172473095;7779.377649788032;7869.921300787005;7875.527468351888;7875.8424831503335;7878.212178782104;7784.844303113934;7812.921870781276;7825.0218722659665;7825.413094017971;7826.334761545247;7728.111267204287;7793.2596403341595;7793.649285782153;7797.649105790253;7798.532088074677;38133;38253.617463825285;38298.80850595729;38368.42447363292;38475.23049539021;3572.0891172751044;3598.784072955631;3604.3692353838237;3611.3860643690637;3614.4036234021355;31449.37101257985;31466;31504.842475787475;31530.211744706336;31596.210094747585;5090.592752579785;5292;5304.071787437221;5322.121849894763;5333.040052790496;187680;188991;189928;190139.04930475398;190371;41141;47477.525224748;48051.27923081157;48094.27858582124;48111.75944120327;43784.562154378684;50882.98234035299;52103.739481303106;52144.21783673248;52191.73904130455;16181.271842767104;16473.505794826175;16478.83521164797;16484;16485.17574121289;13364.198148111145;13439.529616463376;13469.663258418423;13475.797863032063;13492.730145397038;14310.141391516334;14352.784708229385;14401.135931844123;14486.420543178156;14590;5694.177863083773;5705.258316418839;5717.714114294268;5727;5767.134929760569;1021.1728499915092;1021.4228960637216;1021.99489002556;1023.5752162852333;1030.9793804123876;22920.541589168457;22963.425914352276;22977.885110574676;23345.41636459068;23526.529469410514;1075.5697720911542;1079.1205167788228;1093.327603523843;1119.361963680694;1130.4743294368159;12356.505739770488;12375.071869609816;12400.379981000913;12455.094607355784;12505.3747312634;239455;241998;242697;242775;243630;52194.73902630538;52620;52682.73658631682;52735.20897186545;52831.735841320544;1444.4727674398978;1461.495783954534;1463.5170393770031;1464.2898194375719;1466.1862666220136;21989.450263743536;22402.439939001655;22475.325740227818;22682.773172268066;22719.88640056789;37620.247595048495;37711.62288377081;37751.43372849355;37914.24171516499;37924.43113353247;208598;209869;214985;220314;220362;32731.34537309193;33105.83447082749;33186.17034574058;36839.263214735016;37623.81188094042;45723.54276457193;46200.76899615615;46263.53736462727;46318.76840615775;46491.30263046124;33106.17234569059;33390.33219335551;33452;33554.664453356134;33655.495167573;32764.836175818968;32781.672183277864;33293.667063329056;33369;33690.66309336973;37347.62652373441;37407.81296093502;37794.62205377911;37892.24215515619;37996;32365.676343236268;32496;33078.33843323072;34070.82964585161;34113;24628.50742985166;24687;24858.378540536632;25481.745182547937;25587.488250235263 11:26:48 INFO - PID 23335 | |2;jquery.html;555.613848375379;562.5415286541465;569.8404446754909;570.9314882214135;588.2411688921292;22101.778982210173;22920.197793077245;22950.770492295072;22960.196393126243;22969.655455168187;23317.41706457335;24455.75544244557;24476.14333498328;24830;24928.12751553696;6279.372062793707;6434.034894765776;6438.645874476925;6444.645544495051;6452.387023232785;6194.194754681885;6362.872742545146;6429.807105786834;6454.096426500294;6457.83855403614;6409.903851442232;6420.325865784095;6420.4542613877875;6421.7752378666755;6423.164988551482;6414.4227019568;6416.230052393696;6416.871662566746;6420.357964203589;6423.293437721847;5735.627184233053;5941.732622031976;5949.405059494059;5968.7612495500125;5976.8505787355225;28083.438331233465;28602.427951440855;28785.136445906657;28787.71212287871;28791.136265912057;2063.4531849060013;2085.238887805955;2088.8015638514316;2090.143041353038;2090.95818083639;18690.06549672511;19270;19373;19543.315983940636;19555.80444195554;2382.642603609455;2415.1909110448023;2425.78167964884;2439.524292762912;2457.447074408262;120200;126855;141313;149236;149535.25232373876;14458.934107573405;14626.561203163923;14680.04579702316;14782.408703651949;14801.703965920622;22625.321240362486;22681.88659056694;22683.20608778685;22719.432014199778;22721.431964201027;10123.240756943258;10251.692449226535;10287.537060832281;10325.432101234353;10345.586176553004;9608.711738647851;9631.614735410645;9643.517824108767;9669.468179250209;9764;8685.956570217108;8865.556722163867;8882.15619516145;8896.532072208012;9025.45847249154;2659.5212861684695;2674.946501069968;2715.6469658944607;2784.0951690700604;2813.521701310782;951.9762005949907;961.3222678011984;977.1352353167356;980.7597138700921;996.0935548650693;18850.86894786317;19189.808101918803;19258.80741192598;19440.416787496397;19610.411687649394;1036.1658864613908;1036.5439206749006;1041.193075366597;1045.8692663417073;1049.4018409506507;10441.947790261152;12355.38223088842;13421.597352079454;13486;13587.728245435233;515275;525482;526812;531146;536299;124632.75367246392;124958;125357;125995;127166;1230.329470438613;1233.5250928392634;1255.993720031394;1265.3862876504888;1265.6645988812973;20087.39737807868;20095.899520502306;20477.488062798548;20532.486687832923;20621.79378206259;59505.10742338782;59782;60582.39417605768;61085.69457152686;61869;70011.29988700252;77104;80431.19568804237;81870.18129818626;81967;14067.577972660836;14503.419863205354;14650.681438670144;14657.853421466076;14669.559913202622;22766.886165569067;22834.200802971816;22880.313590592308;22939.311820645406;22953.770462295164;16680.582985425463;16931.407400740914;16936.40722574704;18308.816911830712;18470.81529184691;16281.59296017609;16827.158642067603;16943.576410589834;17004.234809433357;17032.744508832624;18534.907325463286;18556.536086597942;18585.81414185841;18877.71683424722;18951.810481895005;14136.50522231717;14262.286885655883;14268.14391136535;14303.713925721218;14304.713905722036;17451.47645570635;17690.557736056187;18227.726584100983;18345.81654183441;18373.173207205975 11:26:48 INFO - PID 23335 | |3;mootools.html;1368.8357397112345;1396.183232808807;1418.4113592858957;1418.6666133458637;1424.9216293103875;15223.847761522382;15908.681826363494;15917.761233581505;15927.124008179546;15928.840711592895;15437.922810385933;15563.455279065234;15577.922110389432;15584.454544090959;15596.922015389908;2443.5479436304295;2476.529459402717;2477.0463371601973;2478.529079474903;2478.962815557768;2727.1273192578383;2797.482465743844;2809.9438011239763;2812.774978001755;2813.6482939632547;2680;2733.9726602733917;2749.340158361999;2749.4913441013377;2752.9724702753015;2673.25148958292;2708.526007948601;2710.7695845853127;2712.199901029201;2716.3209197700576;2626.7241939596256;2639.828411153269;2653.283613424365;2676.7055623881356;2720.3335182880123;15293.923530382388;15457.304421300956;15460.92269538645;15461.690766184725;15476.303566339542;7866.921330786676;8218.671253149867;8226.629801658939;8267.875981860278;8519.105493923173;5460.672359658433;5654.802081927154;5681.034224181858;5686.5735069869925;5717.799877004285;1858.2009735813594;1893.129160586132;1893.2332405375844;1926.6724656808235;1929.7105434184984;27053.594196087073;27339.589906151425;27399.86300068507;27424.45151096987;27442.725572744417;6771.72913083481;6803.693833777492;6938.791836244921;6977.302269772982;6977.372036516636;17348.39280625172;17361.652766944844;17370.21834017472;17382.21780019902;17407.3037078518;7916.7229146980735;8043.638036288381;8054.516728996279;8059.153788852203;8063.838723225503;7269.127704675473;7437.628118594049;7512.060992375953;7520.511166774142;7533.849323013509;5219.217117432339;5416.674999500043;5440;5447.918281225785;5477.643953143033;1579.5261421573712;1583.9841601584067;1588.769628403875;1593.8087429508532;1609.9195040248176;916.6883259691737;936.840737074699;942.8915674697498;945.8817647793888;947.677789551542;7944.563049032358;7960.243776841191;8006.599670016476;8034.517928924283;8085.231902969209;722.2596838240845;723.2947875821137;724.5362967700676;727.5634619228421;733.4975541753915;5906.173135760997;6048.909266361008;6170.50635949123;6299.905501417391;6344.587601805868;22407;22433.439164020703;22727.204547840745;22823.429414264778;23008.424789380064;21621.67567486489;21641;21775.12899484003;22243;22537;11466.598669046543;11886.643400698165;11890.88109118915;11914.821277680841;11919.463624136935;8538.359623028173;8994.730158095006;9164.129407706258;9279.86080208811;9320.580573874327;18912;19148.904255478632;19260.8073919259;19580.804191957897;19693.113809878876;19177.328793492718;19199.52001199981;19662.90168549148;19816.504587385432;20043.498912527302;12361.320127393079;12583.930365918999;12678.746425071631;12699.682507937376;12748.298843563693;13178.011649126162;14076.507322243673;14235.35940882642;14303.284835758379;14470.348834302693;11577.247478913843;11640.94179529097;11739.471723772622;11863.466144023712;12004;10649.680509584725;10790.67627971162;10845.837312440477;10979.780404391708;11077.169212308949;10260.281780275309;10286;10305.896941030494;10381.896181038093;10433.426161561187;7574.128975167926;7660.808479787827;7667.11828139771;7675.884861727191;7766.844663106819;7800.960995194988;7876.291133797986;7879.409044321814;7973.72091976778;7993.440459167802 11:26:48 INFO - PID 23335 | |4;prototype.html;505.05541985772805;519.6907839835296;524.2005940940066;530.9840704778857;532.2138604405934;6410.391012853783;6413.839654008652;6447.709853056612;6460;6503.284638689752;6243.532769799093;6266.279377871546;6267.874642507147;6331.936680633193;6344.429001389874;5200.463684694406;5211.817586384477;5227.79088836447;5262.184361423985;5279.445658205891;4955.504449555052;5082.390113186404;5204.375474943012;5221.973890130544;5301.363836339626;4982.950170498285;5010.273510340999;5021.573166280852;5089.236614507835;5106.131957567204;4988.501149884983;5004.724740139291;5010.774515146827;5060.44335123138;5089.51649593288;4397;4488.7531185784765;4527;4547.977260113711;4549.454065512126;6180.2892667343385;6191.1332413461705;6225.439710426083;6251.593646412968;6256.120226223553;5700.429957004267;5711.457411545896;5718.456746609066;5757.415307152098;5824.359320474744;6580.473562115019;6618.536702430832;6631.303713110102;6673.860048755157;6702.765403210913;4909.21452567591;4922.852314430573;4960.851174464772;4978.800847966077;4980.950190498085;6708.396244337984;6784.72861085556;6853.314668533107;6869.931300686929;6881.827954301132;4981.42713587942;5027.924581131286;5062.93678327548;5078.212877003996;5082.551472830226;5077.339945807022;5089.3638295213095;5108.157154069537;5115.309433226541;5141.5886729061585;5763.135529670499;5802.071668533014;5812.302523697099;5815.185873977646;5864.882702346014;6599.274079851212;6677.899831502531;6702;6731;6744.5278830482375;1757.613325068483;1761.383515769496;1774.6184570317444;1794.2912549542857;1799.4151900632085;1170.7541416302672;1211.9333436660893;1244.4026867103842;1251.8998480121568;1254.0907841814794;5732.914006289909;5759.992001399738;5760.942390576124;5891.528677705774;5900.409959004065;6786.966065169741;6798.898016529756;6803.115594972622;6899.379055884994;6935.965320173468;5895.086261629454;5895.911561326584;5936.881262374728;5945.435183657545;5979.5515336349945;3569.161247106928;3594.4428613564937;3601.4597810328137;3670.3209906167444;3675.3751862183494;6689.213830036983;6719.160104986877;6760.628165450948;6770.796876093725;6791.932080679228;6813.659317034128;6893.896591551131;6915.965420172867;7025.683844227022;7038.190608080136;6575.243846957565;6614.735410583523;6655.234648015444;6700.899486507707;6714.865702686016;6754.5683553921535;6824.942133969243;6859.759908403182;6878.27778083294;6950.513464057467;6809.795706128824;6825.624590647363;6842.589444633139;6862.416694581017;6863.6568171590225;6574.506911981525;6620.90068648961;6662.900056499253;6681.2984636612455;6724.159480064992;4995;5013.749312534432;5046.293518907282;5048.823291184791;5050.191969284897;6538.476921846146;6688.565243259172;6789.762358317435;6795.7961261162245;6874.931250687429;6479;6521.902171467526;6528.617054775068;6668.199816022108;6698.39714425704;6479.222493300834;6493.383128602775;6542.771003014872;6594.241662208716;6654.268030516542;6392.712327945161;6426.4537514311805;6512.818205901076;6530.804075877541;6627.801165965029;6554.442872355903;6558.376954189344;6629.834254143492;6667.366600172976;6694.665266736741;6335.65153916539;6370.1718776558755;6425.357464253537;6433.356664333529;6473.546851720334 11:26:48 INFO - PID 23335 | |5;yui.html;885.8715486254489;900.7748062984253;924.5608336040382;924.8658944453055;940.1726480696985;19265;20246.898765506172;20380.184792608314;20441.18235270591;20461.590768184647;18220.362287319946;18613.720794188062;18845.905770471127;18908;18940.43178704641;959.5777857742588;969.6654654144309;969.9524513525411;971.4656938683696;974.2157563161652;900.2078171209359;988.2439933450916;990.9950450247738;991.2862738828032;991.6677912899188;1054.088213695152;1056.799208150449;1057.471264367816;1058.4813441413728;1062.7290041039562;935.3592788939599;1023.5291765787747;1024.9846252306222;1051.1380667852363;1056.1550759392494;747.9925200747978;749.0748925077525;749.3592978003837;751.5227830327726;752.289086812962;19995.900020499805;20303.695444568344;20305.39083827473;20328.983550822548;20356.898215508976;19901;21373.78626213749;21522.784772152234;21527.67708484374;21528.89235553828;16107.114108724016;16695.165241737865;16725.916370418192;16858.494245172664;17820.46538603844;6012.0681294399;6044.365341639153;6044.879102417971;6067.150598916155;6068.6662233577135;139883.30058349745;140889;141927.99999999898;141987;145015;15968.201589920458;16016.279267432994;16579.585510362336;16583.585410364594;16605.252763625667;30114.397712045637;30551.541726874115;30642.233944151576;30669.38661226763;30738;8069.435139540294;8306.54314012723;8323.375746819012;8349.499030058216;8352.958235208785;4115.97942010294;4138.358554424069;4141.585841415895;4178.22702799983;4179.728317659343;4883.560479556857;4961.156603377434;4971.279164521196;4974.477679843564;4979.477154898684;926.3746970794687;941.1435593609782;944.9291303152291;951.8524628682566;953.0850383631791;652.3378770547897;657.4280376072848;657.4411750012547;668.7826456401689;669.9866002679919;11268.604180916747;11802.586909458129;12003.699907502383;12256.877431225574;12461.428201708166;631.4948041566728;633.4014356433219;636.3954243468723;646.1890327638783;648.7113234610647;5324.520793128637;5335.813246536431;5340.332458442695;5370.248165256867;6383.6808159592765;123072.38463807624;123367.38316308541;125765.37117314538;128942.35528822296;130052;109123.45438272758;110795;111415;112213.43893280481;112830;92376.53811731032;94622;99052.5047374773;100245.73446749154;101595.49202253942;12759.553415630407;12795;12881.935590321988;12886.613401597968;12890.35548222604;41892.37161442642;43044.56955430531;43743.56256437395;44286.55713442953;45557;57116.428835711115;57928.4207157923;58299.70850145722;58862.705686473004;60898.39101608927;18059.2776288947;18507.814921850608;18535.629287413907;18554.536136596154;18559.814401856347;21886.671699924194;22151.889240553694;22237.332880013626;22452.32643020712;22701.43246418853;20077.29729459462;20379.4905127373;20379.898100509403;20498.487537811674;20515.8974205134;19054.42836714901;19868.50328741793;19908.402747917586;19918.800811991696;19920.003999800243;18512.907435462737;18628.441146765617;18742.531436713645;18801.05994700287;18909.43271701851;12869.163504372185;13288.800667990181;13317.267550284827;13600.455981760619;13854.65363365924;15026.774598380814;15411.61470963235;15420.614484637525;15450.9227453862;15482.380704772133 11:26:48 INFO - PID 23335 | __end_tp_report 11:26:48 INFO - PID 23335 | __start_cc_report 11:26:48 INFO - PID 23335 | _x_x_mozilla_cycle_collect,372 11:26:48 INFO - PID 23335 | __end_cc_report 11:26:48 INFO - PID 23335 | __startTimestamp1504808808633__endTimestamp 11:26:48 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | ------- Summary: start ------- 11:26:48 INFO - PID 23335 | Number of tests: 6 11:26:48 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | [#0] dojo.html Cycles:165 Average:6311.90 Median:6505.67 stddev:735.01 (11.3%) stddev-sans-first:696.95 11:26:48 INFO - PID 23335 | Values: 3251.5 3280.5 3300.9 3312.5 3320.0 6263.5 6360.0 6406.2 6441.6 6487.4 6347.4 6401.3 6532.0 6545.7 6568.5 5831.7 5910.0 5913.0 5950.1 6002.7 5842.4 5959.4 5993.0 6014.6 6022.5 5709.0 5776.9 5854.2 5924.0 5929.3 5771.1 5862.2 5888.1 5916.9 5936.8 5821.9 5869.9 5889.3 5893.0 5968.3 6356.9 6384.8 6402.6 6492.0 6523.0 6881.7 6929.5 6937.2 6945.5 6946.1 6876.7 6882.9 6928.8 6976.8 6993.9 6199.0 6287.8 6295.2 6299.0 6299.7 6912.7 6917.2 6946.0 6948.9 6952.0 6620.9 6641.5 6708.0 6731.5 6821.6 6903.4 6956.2 6984.9 6988.0 6992.2 6853.1 6864.3 6921.8 6928.3 6942.3 6627.1 6757.4 6841.5 6852.1 6918.0 5439.1 5445.7 5457.8 5482.8 5489.1 4719.5 4809.8 4835.6 4860.6 4862.3 5803.4 5977.7 5980.9 6051.3 6052.1 6746.8 6888.9 6931.9 6937.5 6938.9 5939.2 5966.1 5976.9 5977.0 5995.1 5886.8 5900.6 5923.1 5976.3 5984.0 6451.7 6565.7 6622.2 6641.9 6710.8 6964.0 6979.6 6982.6 6984.1 7003.3 6590.0 6713.6 6763.4 6776.4 6784.5 6753.9 6769.9 6782.7 6855.3 6859.0 6707.5 6822.2 6845.2 6908.2 6982.9 6692.2 6717.2 6729.3 6734.9 6744.3 6480.2 6570.8 6579.5 6689.1 6794.9 6423.6 6427.2 6431.7 6439.3 6441.9 6466.1 6505.7 6535.2 6551.5 6551.7 6316.2 6326.6 6492.8 6560.1 6565.9 11:26:48 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | [#1] ext.html Cycles:180 Average:38509.73 Median:3607.88 stddev:56126.66 (1555.7%) stddev-sans-first:56212.86 11:26:48 INFO - PID 23335 | Values: 845.0 868.2 876.6 877.7 877.9 38893.6 39609.4 39640.4 42590.6 42830.0 38611.6 39039.0 39070.6 39112.4 39222.4 7020.0 7109.1 7124.3 7159.1 7625.2 7670.5 7790.6 7794.1 7794.9 7795.7 7779.4 7869.9 7875.5 7875.8 7878.2 7784.8 7812.9 7825.0 7825.4 7826.3 7728.1 7793.3 7793.6 7797.6 7798.5 38133.0 38253.6 38298.8 38368.4 38475.2 3572.1 3598.8 3604.4 3611.4 3614.4 31449.4 31466.0 31504.8 31530.2 31596.2 5090.6 5292.0 5304.1 5322.1 5333.0 187680.0 188991.0 189928.0 190139.0 190371.0 41141.0 47477.5 48051.3 48094.3 48111.8 43784.6 50883.0 52103.7 52144.2 52191.7 16181.3 16473.5 16478.8 16484.0 16485.2 13364.2 13439.5 13469.7 13475.8 13492.7 14310.1 14352.8 14401.1 14486.4 14590.0 5694.2 5705.3 5717.7 5727.0 5767.1 1021.2 1021.4 1022.0 1023.6 1031.0 22920.5 22963.4 22977.9 23345.4 23526.5 1075.6 1079.1 1093.3 1119.4 1130.5 12356.5 12375.1 12400.4 12455.1 12505.4 239455.0 241998.0 242697.0 242775.0 243630.0 52194.7 52620.0 52682.7 52735.2 52831.7 1444.5 1461.5 1463.5 1464.3 1466.2 21989.5 22402.4 22475.3 22682.8 22719.9 37620.2 37711.6 37751.4 37914.2 37924.4 208598.0 209869.0 214985.0 220314.0 220362.0 32731.3 33105.8 33186.2 36839.3 37623.8 45723.5 46200.8 46263.5 46318.8 46491.3 33106.2 33390.3 33452.0 33554.7 33655.5 32764.8 32781.7 33293.7 33369.0 33690.7 37347.6 37407.8 37794.6 37892.2 37996.0 32365.7 32496.0 33078.3 34070.8 34113.0 24628.5 24687.0 24858.4 25481.7 25587.5 11:26:48 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | [#2] jquery.html Cycles:180 Average:36324.38 Median:22744.16 stddev:88688.13 (389.9%) stddev-sans-first:88896.26 11:26:48 INFO - PID 23335 | Values: 555.6 562.5 569.8 570.9 588.2 22101.8 22920.2 22950.8 22960.2 22969.7 23317.4 24455.8 24476.1 24830.0 24928.1 6279.4 6434.0 6438.6 6444.6 6452.4 6194.2 6362.9 6429.8 6454.1 6457.8 6409.9 6420.3 6420.5 6421.8 6423.2 6414.4 6416.2 6416.9 6420.4 6423.3 5735.6 5941.7 5949.4 5968.8 5976.9 28083.4 28602.4 28785.1 28787.7 28791.1 2063.5 2085.2 2088.8 2090.1 2091.0 18690.1 19270.0 19373.0 19543.3 19555.8 2382.6 2415.2 2425.8 2439.5 2457.4 120200.0 126855.0 141313.0 149236.0 149535.3 14458.9 14626.6 14680.0 14782.4 14801.7 22625.3 22681.9 22683.2 22719.4 22721.4 10123.2 10251.7 10287.5 10325.4 10345.6 9608.7 9631.6 9643.5 9669.5 9764.0 8686.0 8865.6 8882.2 8896.5 9025.5 2659.5 2674.9 2715.6 2784.1 2813.5 952.0 961.3 977.1 980.8 996.1 18850.9 19189.8 19258.8 19440.4 19610.4 1036.2 1036.5 1041.2 1045.9 1049.4 10441.9 12355.4 13421.6 13486.0 13587.7 515275.0 525482.0 526812.0 531146.0 536299.0 124632.8 124958.0 125357.0 125995.0 127166.0 1230.3 1233.5 1256.0 1265.4 1265.7 20087.4 20095.9 20477.5 20532.5 20621.8 59505.1 59782.0 60582.4 61085.7 61869.0 70011.3 77104.0 80431.2 81870.2 81967.0 14067.6 14503.4 14650.7 14657.9 14669.6 22766.9 22834.2 22880.3 22939.3 22953.8 16680.6 16931.4 16936.4 18308.8 18470.8 16281.6 16827.2 16943.6 17004.2 17032.7 18534.9 18556.5 18585.8 18877.7 18951.8 14136.5 14262.3 14268.1 14303.7 14304.7 17451.5 17690.6 18227.7 18345.8 18373.2 11:26:48 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | [#3] mootools.html Cycles:180 Average:9633.79 Median:2633.28 stddev:6885.70 (261.5%) stddev-sans-first:6877.02 11:26:48 INFO - PID 23335 | Values: 1368.8 1396.2 1418.4 1418.7 1424.9 15223.8 15908.7 15917.8 15927.1 15928.8 15437.9 15563.5 15577.9 15584.5 15596.9 2443.5 2476.5 2477.0 2478.5 2479.0 2727.1 2797.5 2809.9 2812.8 2813.6 2680.0 2734.0 2749.3 2749.5 2753.0 2673.3 2708.5 2710.8 2712.2 2716.3 2626.7 2639.8 2653.3 2676.7 2720.3 15293.9 15457.3 15460.9 15461.7 15476.3 7866.9 8218.7 8226.6 8267.9 8519.1 5460.7 5654.8 5681.0 5686.6 5717.8 1858.2 1893.1 1893.2 1926.7 1929.7 27053.6 27339.6 27399.9 27424.5 27442.7 6771.7 6803.7 6938.8 6977.3 6977.4 17348.4 17361.7 17370.2 17382.2 17407.3 7916.7 8043.6 8054.5 8059.2 8063.8 7269.1 7437.6 7512.1 7520.5 7533.8 5219.2 5416.7 5440.0 5447.9 5477.6 1579.5 1584.0 1588.8 1593.8 1609.9 916.7 936.8 942.9 945.9 947.7 7944.6 7960.2 8006.6 8034.5 8085.2 722.3 723.3 724.5 727.6 733.5 5906.2 6048.9 6170.5 6299.9 6344.6 22407.0 22433.4 22727.2 22823.4 23008.4 21621.7 21641.0 21775.1 22243.0 22537.0 11466.6 11886.6 11890.9 11914.8 11919.5 8538.4 8994.7 9164.1 9279.9 9320.6 18912.0 19148.9 19260.8 19580.8 19693.1 19177.3 19199.5 19662.9 19816.5 20043.5 12361.3 12583.9 12678.7 12699.7 12748.3 13178.0 14076.5 14235.4 14303.3 14470.3 11577.2 11640.9 11739.5 11863.5 12004.0 10649.7 10790.7 10845.8 10979.8 11077.2 10260.3 10286.0 10305.9 10381.9 10433.4 7574.1 7660.8 7667.1 7675.9 7766.8 7801.0 7876.3 7879.4 7973.7 7993.4 11:26:48 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | [#4] prototype.html Cycles:180 Average:5599.33 Median:6261.20 stddev:1569.72 (25.1%) stddev-sans-first:1526.85 11:26:48 INFO - PID 23335 | Values: 505.1 519.7 524.2 531.0 532.2 6410.4 6413.8 6447.7 6460.0 6503.3 6243.5 6266.3 6267.9 6331.9 6344.4 5200.5 5211.8 5227.8 5262.2 5279.4 4955.5 5082.4 5204.4 5222.0 5301.4 4983.0 5010.3 5021.6 5089.2 5106.1 4988.5 5004.7 5010.8 5060.4 5089.5 4397.0 4488.8 4527.0 4548.0 4549.5 6180.3 6191.1 6225.4 6251.6 6256.1 5700.4 5711.5 5718.5 5757.4 5824.4 6580.5 6618.5 6631.3 6673.9 6702.8 4909.2 4922.9 4960.9 4978.8 4981.0 6708.4 6784.7 6853.3 6869.9 6881.8 4981.4 5027.9 5062.9 5078.2 5082.6 5077.3 5089.4 5108.2 5115.3 5141.6 5763.1 5802.1 5812.3 5815.2 5864.9 6599.3 6677.9 6702.0 6731.0 6744.5 1757.6 1761.4 1774.6 1794.3 1799.4 1170.8 1211.9 1244.4 1251.9 1254.1 5732.9 5760.0 5760.9 5891.5 5900.4 6787.0 6798.9 6803.1 6899.4 6936.0 5895.1 5895.9 5936.9 5945.4 5979.6 3569.2 3594.4 3601.5 3670.3 3675.4 6689.2 6719.2 6760.6 6770.8 6791.9 6813.7 6893.9 6916.0 7025.7 7038.2 6575.2 6614.7 6655.2 6700.9 6714.9 6754.6 6824.9 6859.8 6878.3 6950.5 6809.8 6825.6 6842.6 6862.4 6863.7 6574.5 6620.9 6662.9 6681.3 6724.2 4995.0 5013.7 5046.3 5048.8 5050.2 6538.5 6688.6 6789.8 6795.8 6874.9 6479.0 6521.9 6528.6 6668.2 6698.4 6479.2 6493.4 6542.8 6594.2 6654.3 6392.7 6426.5 6512.8 6530.8 6627.8 6554.4 6558.4 6629.8 6667.4 6694.7 6335.7 6370.2 6425.4 6433.4 6473.5 11:26:48 INFO - PID 23335 | 11:26:48 INFO - PID 23335 | [#5] yui.html Cycles:180 Average:25372.15 Median:20507.19 stddev:35918.61 (175.2%) stddev-sans-first:35972.31 11:26:48 INFO - PID 23335 | Values: 885.9 900.8 924.6 924.9 940.2 19265.0 20246.9 20380.2 20441.2 20461.6 18220.4 18613.7 18845.9 18908.0 18940.4 959.6 969.7 970.0 971.5 974.2 900.2 988.2 991.0 991.3 991.7 1054.1 1056.8 1057.5 1058.5 1062.7 935.4 1023.5 1025.0 1051.1 1056.2 748.0 749.1 749.4 751.5 752.3 19995.9 20303.7 20305.4 20329.0 20356.9 19901.0 21373.8 21522.8 21527.7 21528.9 16107.1 16695.2 16725.9 16858.5 17820.5 6012.1 6044.4 6044.9 6067.2 6068.7 139883.3 140889.0 141928.0 141987.0 145015.0 15968.2 16016.3 16579.6 16583.6 16605.3 30114.4 30551.5 30642.2 30669.4 30738.0 8069.4 8306.5 8323.4 8349.5 8353.0 4116.0 4138.4 4141.6 4178.2 4179.7 4883.6 4961.2 4971.3 4974.5 4979.5 926.4 941.1 944.9 951.9 953.1 652.3 657.4 657.4 668.8 670.0 11268.6 11802.6 12003.7 12256.9 12461.4 631.5 633.4 636.4 646.2 648.7 5324.5 5335.8 5340.3 5370.2 6383.7 123072.4 123367.4 125765.4 128942.4 130052.0 109123.5 110795.0 111415.0 112213.4 112830.0 92376.5 94622.0 99052.5 100245.7 101595.5 12759.6 12795.0 12881.9 12886.6 12890.4 41892.4 43044.6 43743.6 44286.6 45557.0 57116.4 57928.4 58299.7 58862.7 60898.4 18059.3 18507.8 18535.6 18554.5 18559.8 21886.7 22151.9 22237.3 22452.3 22701.4 20077.3 20379.5 20379.9 20498.5 20515.9 19054.4 19868.5 19908.4 19918.8 19920.0 18512.9 18628.4 18742.5 18801.1 18909.4 12869.2 13288.8 13317.3 13600.5 13854.7 15026.8 15411.6 15420.6 15450.9 15482.4 11:26:48 INFO - PID 23335 | -------- Summary: end -------- 11:26:48 INFO - PID 23335 | 11:26:49 INFO - TEST-INFO | 23335: exit 0 11:26:49 INFO - TEST-OK | dromaeo_css | took 1109516ms 11:26:49 INFO - TEST-START | kraken 11:26:49 INFO - Initialising browser for kraken test... 11:26:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39430/getInfo.html -profile /tmp/tmpEsoaJf/profile 11:26:49 INFO - TEST-INFO | started process 23707 (/builds/slave/test/build/application/firefox/firefox http://localhost:39430/getInfo.html) 11:26:54 INFO - TEST-INFO | 23707: exit 0 11:26:54 INFO - Browser initialized. 11:26:54 INFO - Running cycle 1/1 for kraken test... 11:26:54 INFO - Using env: {'DISPLAY': ':0', 11:26:54 INFO - 'HOME': '/home/cltbld', 11:26:54 INFO - 'JSGC_DISABLE_POISONING': '1', 11:26:54 INFO - 'LANG': 'en_US.UTF-8', 11:26:54 INFO - 'LANGUAGE': 'en_US:en', 11:26:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:26:54 INFO - 'LOGNAME': 'cltbld', 11:26:54 INFO - 'MAIL': '/var/mail/cltbld', 11:26:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:54 INFO - 'MOZ_CRASHREPORTER': '1', 11:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:26:54 INFO - 'MOZ_NO_REMOTE': '1', 11:26:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:54 INFO - 'NO_EM_RESTART': '1', 11:26:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:54 INFO - 'PWD': '/builds/slave/test', 11:26:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:54 INFO - 'RUST_BACKTRACE': 'full', 11:26:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:26:54 INFO - 'SHELL': '/bin/bash', 11:26:54 INFO - 'SHLVL': '1', 11:26:54 INFO - 'STYLO_FORCE_DISABLED': '1', 11:26:54 INFO - 'TERM': 'linux', 11:26:54 INFO - 'TMOUT': '86400', 11:26:54 INFO - 'USER': 'cltbld', 11:26:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842', 11:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:54 INFO - '_': '/tools/buildbot/bin/python'} 11:26:54 INFO - TEST-INFO | started process 23904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsoaJf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:55 INFO - PID 23904 | 11:26:55 INFO - PID 23904 | (/builds/slave/test/build/application/firefox/firefox:23955): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:26:55 INFO - PID 23904 | 11:27:06 INFO - PID 23904 | RSS: Main: 169938944 11:27:06 INFO - PID 23904 | 11:27:08 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39430/tests/kraken/driver.html?testName=audio-beat-detection) 11:27:09 INFO - PID 23904 | RSS: Main: 175878144 11:27:09 INFO - PID 23904 | 11:27:12 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39430/tests/kraken/driver.html?testName=audio-dft) 11:27:13 INFO - PID 23904 | RSS: Main: 176799744 11:27:13 INFO - PID 23904 | 11:27:15 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39430/tests/kraken/driver.html?testName=audio-fft) 11:27:16 INFO - PID 23904 | RSS: Main: 171065344 11:27:16 INFO - PID 23904 | 11:27:18 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39430/tests/kraken/driver.html?testName=audio-oscillator) 11:27:19 INFO - PID 23904 | RSS: Main: 172015616 11:27:19 INFO - PID 23904 | 11:27:21 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:21 INFO - PID 23904 | RSS: Main: 172294144 11:27:21 INFO - PID 23904 | 11:27:25 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39430/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:25 INFO - PID 23904 | RSS: Main: 174944256 11:27:25 INFO - PID 23904 | 11:27:29 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39430/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:29 INFO - PID 23904 | RSS: Main: 174702592 11:27:29 INFO - PID 23904 | 11:27:32 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39430/tests/kraken/driver.html?testName=json-parse-financial) 11:27:33 INFO - PID 23904 | RSS: Main: 174751744 11:27:33 INFO - PID 23904 | 11:27:35 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:35 INFO - PID 23904 | RSS: Main: 174301184 11:27:35 INFO - PID 23904 | 11:27:37 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:38 INFO - PID 23904 | RSS: Main: 174825472 11:27:38 INFO - PID 23904 | 11:27:40 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:40 INFO - PID 23904 | RSS: Main: 171356160 11:27:40 INFO - PID 23904 | 11:27:43 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:44 INFO - PID 23904 | RSS: Main: 172691456 11:27:44 INFO - PID 23904 | 11:27:47 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:47 INFO - PID 23904 | RSS: Main: 172433408 11:27:47 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39430/tests/kraken/driver.html?testName=ai-astar) 11:27:49 INFO - PID 23904 | RSS: Main: 174202880 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | __start_tp_report 11:27:49 INFO - PID 23904 | _x_x_mozilla_page_load 11:27:49 INFO - PID 23904 | _x_x_mozilla_page_load_details 11:27:49 INFO - PID 23904 | |i|pagename|runs| 11:27:49 INFO - PID 23904 | |0;ai-astar;108;106;107;106;110;112;109;108;108;107 11:27:49 INFO - PID 23904 | |1;audio-beat-detection;117;118;122;115;114;119;121;118;126;126 11:27:49 INFO - PID 23904 | |2;audio-dft;162;163;163;165;162;162;167;169;163;163 11:27:49 INFO - PID 23904 | |3;audio-fft;74;75;77;74;73;73;75;75;80;75 11:27:49 INFO - PID 23904 | |4;audio-oscillator;78;79;78;78;77;78;78;79;136;79 11:27:49 INFO - PID 23904 | |5;imaging-gaussian-blur;114;114;111;114;110;114;114;114;114;114 11:27:49 INFO - PID 23904 | |6;imaging-darkroom;154;150;150;150;149;147;149;159;149;149 11:27:49 INFO - PID 23904 | |7;imaging-desaturate;95;94;94;95;94;93;93;99;95;94 11:27:49 INFO - PID 23904 | |8;json-parse-financial;52;52;52;54;53;53;52;63;52;51 11:27:49 INFO - PID 23904 | |9;json-stringify-tinderbox;37;38;38;38;43;43;39;38;38;38 11:27:49 INFO - PID 23904 | |10;stanford-crypto-aes;80;75;75;80;74;76;77;79;79;76 11:27:49 INFO - PID 23904 | |11;stanford-crypto-ccm;123;126;122;115;126;137;123;129;122;119 11:27:49 INFO - PID 23904 | |12;stanford-crypto-pbkdf2;180;174;172;174;168;176;181;171;166;168 11:27:49 INFO - PID 23904 | |13;stanford-crypto-sha256-iterative;74;63;64;67;73;63;63;66;64;63 11:27:49 INFO - PID 23904 | __end_tp_report 11:27:49 INFO - PID 23904 | __start_cc_report 11:27:49 INFO - PID 23904 | _x_x_mozilla_cycle_collect,921 11:27:49 INFO - PID 23904 | __end_cc_report 11:27:49 INFO - PID 23904 | __startTimestamp1504808869840__endTimestamp 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | ------- Summary: start ------- 11:27:49 INFO - PID 23904 | Number of tests: 14 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.00 stddev:1.85 (1.7%) stddev-sans-first:1.96 11:27:49 INFO - PID 23904 | Values: 108.0 106.0 107.0 106.0 110.0 112.0 109.0 108.0 108.0 107.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#1] audio-beat-detection Cycles:10 Average:119.60 Median:120.00 stddev:4.14 (3.5%) stddev-sans-first:4.28 11:27:49 INFO - PID 23904 | Values: 117.0 118.0 122.0 115.0 114.0 119.0 121.0 118.0 126.0 126.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.38 (1.5%) stddev-sans-first:2.42 11:27:49 INFO - PID 23904 | Values: 162.0 163.0 163.0 165.0 162.0 162.0 167.0 169.0 163.0 163.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#3] audio-fft Cycles:10 Average:75.10 Median:75.00 stddev:2.08 (2.8%) stddev-sans-first:2.17 11:27:49 INFO - PID 23904 | Values: 74.0 75.0 77.0 74.0 73.0 73.0 75.0 75.0 80.0 75.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:78.00 stddev:18.28 (23.4%) stddev-sans-first:19.26 11:27:49 INFO - PID 23904 | Values: 78.0 79.0 78.0 78.0 77.0 78.0 78.0 79.0 136.0 79.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.49 (1.3%) stddev-sans-first:1.56 11:27:49 INFO - PID 23904 | Values: 114.0 114.0 111.0 114.0 110.0 114.0 114.0 114.0 114.0 114.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.00 stddev:3.44 (2.3%) stddev-sans-first:3.42 11:27:49 INFO - PID 23904 | Values: 154.0 150.0 150.0 150.0 149.0 147.0 149.0 159.0 149.0 149.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:1.71 (1.8%) stddev-sans-first:1.81 11:27:49 INFO - PID 23904 | Values: 95.0 94.0 94.0 95.0 94.0 93.0 93.0 99.0 95.0 94.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:52.50 stddev:3.47 (6.6%) stddev-sans-first:3.64 11:27:49 INFO - PID 23904 | Values: 52.0 52.0 52.0 54.0 53.0 53.0 52.0 63.0 52.0 51.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#9] json-stringify-tinderbox Cycles:10 Average:39.00 Median:38.00 stddev:2.16 (5.7%) stddev-sans-first:2.17 11:27:49 INFO - PID 23904 | Values: 37.0 38.0 38.0 38.0 43.0 43.0 39.0 38.0 38.0 38.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:78.00 stddev:2.23 (2.9%) stddev-sans-first:2.11 11:27:49 INFO - PID 23904 | Values: 80.0 75.0 75.0 80.0 74.0 76.0 77.0 79.0 79.0 76.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:124.50 stddev:5.94 (4.8%) stddev-sans-first:6.28 11:27:49 INFO - PID 23904 | Values: 123.0 126.0 122.0 115.0 126.0 137.0 123.0 129.0 122.0 119.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:174.00 stddev:5.03 (2.9%) stddev-sans-first:4.66 11:27:49 INFO - PID 23904 | Values: 180.0 174.0 172.0 174.0 168.0 176.0 181.0 171.0 166.0 168.0 11:27:49 INFO - PID 23904 | 11:27:49 INFO - PID 23904 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.00 stddev:4.19 (6.4%) stddev-sans-first:3.30 11:27:49 INFO - PID 23904 | Values: 74.0 63.0 64.0 67.0 73.0 63.0 63.0 66.0 64.0 63.0 11:27:49 INFO - PID 23904 | -------- Summary: end -------- 11:27:49 INFO - PID 23904 | 11:27:50 INFO - PID 23904 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:27:50 INFO - TEST-INFO | 23904: exit 0 11:27:50 INFO - TEST-OK | kraken | took 61283ms 11:27:50 INFO - SUITE-END | took 1170s 11:27:51 INFO - Completed test suite (00:19:31) 11:27:51 INFO - javascript benchmark 11:27:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8694.008147990013, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3251.496018117192, 3280.4915238138096, 3300.9339813203737, 3312.4865645824875, 3320.020593924792, 6263.467605253548, 6360.045993101031, 6406.167198264219, 6441.6457094859825, 6487.383698548642, 6347.365263473662, 6401.295857455676, 6532.0, 6545.672716364174, 6568.474522038237, 5831.650100993933, 5910.0, 5913.0, 5950.137230101633, 6002.729877155517, 5842.357340692521, 5959.433853783884, 5993.041113421853, 6014.609050411731, 6022.518198544106, 5708.97145514274, 5776.913346299809, 5854.20968169296, 5923.999999999978, 5929.28848538176, 5771.134329850514, 5862.237909071793, 5888.116782482619, 5916.911246331309, 5936.792212272593, 5821.854453638693, 5869.85325366865, 5889.265155759612, 5893.0, 5968.253968253968, 6356.936430635681, 6384.808455746335, 6402.583832050948, 6492.0, 6523.0, 6881.690323935435, 6929.480288978347, 6937.202221744514, 6945.548539344926, 6946.0622815920215, 6876.656167191671, 6882.8967565486555, 6928.826779330507, 6976.755813546552, 6993.89509157363, 6199.0, 6287.779927702509, 6295.244570651551, 6299.023651334051, 6299.716512756937, 6912.688928998207, 6917.169939607279, 6945.965270173718, 6948.861022779516, 6952.0, 6620.867582648417, 6641.501887358468, 6707.966460167668, 6731.49513786468, 6821.590704557742, 6903.378695917391, 6956.200036995709, 6984.895226571605, 6988.021676965229, 6992.16094068715, 6853.143357080365, 6864.279250678607, 6921.757738479129, 6928.307169283032, 6942.271061538567, 6627.138471998705, 6757.425618822357, 6841.486888483284, 6852.074969879102, 6918.0314755934205, 5439.129739241703, 5445.727713614304, 5457.808976685797, 5482.80810171642, 5489.066858634042, 4719.5044520325555, 4809.807607695723, 4835.564799168092, 4860.635452341088, 4862.319275301461, 5803.390643982321, 5977.731002104916, 5980.880382392328, 6051.334353221142, 6052.061930400795, 6746.763863264762, 6888.862222755617, 6931.930680693229, 6937.479689023344, 6938.895916561256, 5939.227900372924, 5966.134910438049, 5976.8804623908145, 5976.970115149484, 5995.130706047598, 5886.764529418775, 5900.616459930091, 5923.052311630205, 5976.312724036791, 5983.970080149658, 6451.741930322734, 6565.704543295563, 6622.1722284714415, 6641.867162656817, 6710.83222919431, 6963.965180174168, 6979.616121113388, 6982.6159561222585, 6984.057152284377, 7003.264657211123, 6589.967050164719, 6713.563618364986, 6763.425108865801, 6776.356246156607, 6784.457243420613, 6753.898691519533, 6769.864602708017, 6782.69477873487, 6855.348741869514, 6858.965705171442, 6707.530472867048, 6822.249552549315, 6845.178578570603, 6908.2400935896, 6982.860342793218, 6692.1969363674725, 6717.227518835396, 6729.259781424137, 6734.9326506734305, 6744.325567443413, 6480.222373315044, 6570.8357291068105, 6579.4736421087155, 6689.09697190873, 6794.9320506796275, 6423.582467139621, 6427.228732552124, 6431.678416079084, 6439.259485159267, 6441.903371449338, 6466.06242094903, 6505.674716264073, 6535.248446428722, 6551.541392102507, 6551.672416379257, 6316.178896743394, 6326.557141000086, 6492.837679058061, 6560.147180866456, 6565.934340656532], "value": 6258.054864587919, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.049319515545, 868.2359523619216, 876.6274333408304, 877.7454538183923, 877.8814859993906, 38893.61106388935, 39609.405858912105, 39640.40539391904, 42590.57409425905, 42830.0, 38611.61388386115, 39039.0, 39070.60929390705, 39112.413313800316, 39222.41166382506, 7019.964900175518, 7109.146902371723, 7124.323189297034, 7159.140903091637, 7625.199354067799, 7670.501417407851, 7790.571518566477, 7794.103678077008, 7794.922050779504, 7795.688172473095, 7779.377649788032, 7869.921300787005, 7875.527468351888, 7875.8424831503335, 7878.212178782104, 7784.844303113934, 7812.921870781276, 7825.0218722659665, 7825.413094017971, 7826.334761545247, 7728.111267204287, 7793.2596403341595, 7793.649285782153, 7797.649105790253, 7798.532088074677, 38133.0, 38253.617463825285, 38298.80850595729, 38368.42447363292, 38475.23049539021, 3572.0891172751044, 3598.784072955631, 3604.3692353838237, 3611.3860643690637, 3614.4036234021355, 31449.37101257985, 31466.0, 31504.842475787475, 31530.211744706336, 31596.210094747585, 5090.592752579785, 5292.0, 5304.071787437221, 5322.121849894763, 5333.040052790496, 187680.0, 188991.0, 189928.0, 190139.04930475398, 190371.0, 41141.0, 47477.525224748, 48051.27923081157, 48094.27858582124, 48111.75944120327, 43784.562154378684, 50882.98234035299, 52103.739481303106, 52144.21783673248, 52191.73904130455, 16181.271842767104, 16473.505794826175, 16478.83521164797, 16484.0, 16485.17574121289, 13364.198148111145, 13439.529616463376, 13469.663258418423, 13475.797863032063, 13492.730145397038, 14310.141391516334, 14352.784708229385, 14401.135931844123, 14486.420543178156, 14590.0, 5694.177863083773, 5705.258316418839, 5717.714114294268, 5727.0, 5767.134929760569, 1021.1728499915092, 1021.4228960637216, 1021.99489002556, 1023.5752162852333, 1030.9793804123876, 22920.541589168457, 22963.425914352276, 22977.885110574676, 23345.41636459068, 23526.529469410514, 1075.5697720911542, 1079.1205167788228, 1093.327603523843, 1119.361963680694, 1130.4743294368159, 12356.505739770488, 12375.071869609816, 12400.379981000913, 12455.094607355784, 12505.3747312634, 239455.0, 241998.0, 242697.0, 242775.0, 243630.0, 52194.73902630538, 52620.0, 52682.73658631682, 52735.20897186545, 52831.735841320544, 1444.4727674398978, 1461.495783954534, 1463.5170393770031, 1464.2898194375719, 1466.1862666220136, 21989.450263743536, 22402.439939001655, 22475.325740227818, 22682.773172268066, 22719.88640056789, 37620.247595048495, 37711.62288377081, 37751.43372849355, 37914.24171516499, 37924.43113353247, 208598.0, 209869.0, 214985.0, 220314.0, 220362.0, 32731.34537309193, 33105.83447082749, 33186.17034574058, 36839.263214735016, 37623.81188094042, 45723.54276457193, 46200.76899615615, 46263.53736462727, 46318.76840615775, 46491.30263046124, 33106.17234569059, 33390.33219335551, 33452.0, 33554.664453356134, 33655.495167573, 32764.836175818968, 32781.672183277864, 33293.667063329056, 33369.0, 33690.66309336973, 37347.62652373441, 37407.81296093502, 37794.62205377911, 37892.24215515619, 37996.0, 32365.676343236268, 32496.0, 33078.33843323072, 34070.82964585161, 34113.0, 24628.50742985166, 24687.0, 24858.378540536632, 25481.745182547937, 25587.488250235263], "value": 17358.656354907285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.613848375379, 562.5415286541465, 569.8404446754909, 570.9314882214135, 588.2411688921292, 22101.778982210173, 22920.197793077245, 22950.770492295072, 22960.196393126243, 22969.655455168187, 23317.41706457335, 24455.75544244557, 24476.14333498328, 24830.0, 24928.12751553696, 6279.372062793707, 6434.034894765776, 6438.645874476925, 6444.645544495051, 6452.387023232785, 6194.194754681885, 6362.872742545146, 6429.807105786834, 6454.096426500294, 6457.83855403614, 6409.903851442232, 6420.325865784095, 6420.4542613877875, 6421.7752378666755, 6423.164988551482, 6414.4227019568, 6416.230052393696, 6416.871662566746, 6420.357964203589, 6423.293437721847, 5735.627184233053, 5941.732622031976, 5949.405059494059, 5968.7612495500125, 5976.8505787355225, 28083.438331233465, 28602.427951440855, 28785.136445906657, 28787.71212287871, 28791.136265912057, 2063.4531849060013, 2085.238887805955, 2088.8015638514316, 2090.143041353038, 2090.95818083639, 18690.06549672511, 19270.0, 19373.0, 19543.315983940636, 19555.80444195554, 2382.642603609455, 2415.1909110448023, 2425.78167964884, 2439.524292762912, 2457.447074408262, 120200.0, 126855.0, 141313.0, 149236.0, 149535.25232373876, 14458.934107573405, 14626.561203163923, 14680.04579702316, 14782.408703651949, 14801.703965920622, 22625.321240362486, 22681.88659056694, 22683.20608778685, 22719.432014199778, 22721.431964201027, 10123.240756943258, 10251.692449226535, 10287.537060832281, 10325.432101234353, 10345.586176553004, 9608.711738647851, 9631.614735410645, 9643.517824108767, 9669.468179250209, 9764.0, 8685.956570217108, 8865.556722163867, 8882.15619516145, 8896.532072208012, 9025.45847249154, 2659.5212861684695, 2674.946501069968, 2715.6469658944607, 2784.0951690700604, 2813.521701310782, 951.9762005949907, 961.3222678011984, 977.1352353167356, 980.7597138700921, 996.0935548650693, 18850.86894786317, 19189.808101918803, 19258.80741192598, 19440.416787496397, 19610.411687649394, 1036.1658864613908, 1036.5439206749006, 1041.193075366597, 1045.8692663417073, 1049.4018409506507, 10441.947790261152, 12355.38223088842, 13421.597352079454, 13486.0, 13587.728245435233, 515275.0, 525482.0, 526812.0, 531146.0, 536299.0, 124632.75367246392, 124958.0, 125357.0, 125995.0, 127166.0, 1230.329470438613, 1233.5250928392634, 1255.993720031394, 1265.3862876504888, 1265.6645988812973, 20087.39737807868, 20095.899520502306, 20477.488062798548, 20532.486687832923, 20621.79378206259, 59505.10742338782, 59782.0, 60582.39417605768, 61085.69457152686, 61869.0, 70011.29988700252, 77104.0, 80431.19568804237, 81870.18129818626, 81967.0, 14067.577972660836, 14503.419863205354, 14650.681438670144, 14657.853421466076, 14669.559913202622, 22766.886165569067, 22834.200802971816, 22880.313590592308, 22939.311820645406, 22953.770462295164, 16680.582985425463, 16931.407400740914, 16936.40722574704, 18308.816911830712, 18470.81529184691, 16281.59296017609, 16827.158642067603, 16943.576410589834, 17004.234809433357, 17032.744508832624, 18534.907325463286, 18556.536086597942, 18585.81414185841, 18877.71683424722, 18951.810481895005, 14136.50522231717, 14262.286885655883, 14268.14391136535, 14303.713925721218, 14304.713905722036, 17451.47645570635, 17690.557736056187, 18227.726584100983, 18345.81654183441, 18373.173207205975], "value": 12079.291124863645, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.8357397112345, 1396.183232808807, 1418.4113592858957, 1418.6666133458637, 1424.9216293103875, 15223.847761522382, 15908.681826363494, 15917.761233581505, 15927.124008179546, 15928.840711592895, 15437.922810385933, 15563.455279065234, 15577.922110389432, 15584.454544090959, 15596.922015389908, 2443.5479436304295, 2476.529459402717, 2477.0463371601973, 2478.529079474903, 2478.962815557768, 2727.1273192578383, 2797.482465743844, 2809.9438011239763, 2812.774978001755, 2813.6482939632547, 2680.0, 2733.9726602733917, 2749.340158361999, 2749.4913441013377, 2752.9724702753015, 2673.25148958292, 2708.526007948601, 2710.7695845853127, 2712.199901029201, 2716.3209197700576, 2626.7241939596256, 2639.828411153269, 2653.283613424365, 2676.7055623881356, 2720.3335182880123, 15293.923530382388, 15457.304421300956, 15460.92269538645, 15461.690766184725, 15476.303566339542, 7866.921330786676, 8218.671253149867, 8226.629801658939, 8267.875981860278, 8519.105493923173, 5460.672359658433, 5654.802081927154, 5681.034224181858, 5686.5735069869925, 5717.799877004285, 1858.2009735813594, 1893.129160586132, 1893.2332405375844, 1926.6724656808235, 1929.7105434184984, 27053.594196087073, 27339.589906151425, 27399.86300068507, 27424.45151096987, 27442.725572744417, 6771.72913083481, 6803.693833777492, 6938.791836244921, 6977.302269772982, 6977.372036516636, 17348.39280625172, 17361.652766944844, 17370.21834017472, 17382.21780019902, 17407.3037078518, 7916.7229146980735, 8043.638036288381, 8054.516728996279, 8059.153788852203, 8063.838723225503, 7269.127704675473, 7437.628118594049, 7512.060992375953, 7520.511166774142, 7533.849323013509, 5219.217117432339, 5416.674999500043, 5440.0, 5447.918281225785, 5477.643953143033, 1579.5261421573712, 1583.9841601584067, 1588.769628403875, 1593.8087429508532, 1609.9195040248176, 916.6883259691737, 936.840737074699, 942.8915674697498, 945.8817647793888, 947.677789551542, 7944.563049032358, 7960.243776841191, 8006.599670016476, 8034.517928924283, 8085.231902969209, 722.2596838240845, 723.2947875821137, 724.5362967700676, 727.5634619228421, 733.4975541753915, 5906.173135760997, 6048.909266361008, 6170.50635949123, 6299.905501417391, 6344.587601805868, 22407.0, 22433.439164020703, 22727.204547840745, 22823.429414264778, 23008.424789380064, 21621.67567486489, 21641.0, 21775.12899484003, 22243.0, 22537.0, 11466.598669046543, 11886.643400698165, 11890.88109118915, 11914.821277680841, 11919.463624136935, 8538.359623028173, 8994.730158095006, 9164.129407706258, 9279.86080208811, 9320.580573874327, 18912.0, 19148.904255478632, 19260.8073919259, 19580.804191957897, 19693.113809878876, 19177.328793492718, 19199.52001199981, 19662.90168549148, 19816.504587385432, 20043.498912527302, 12361.320127393079, 12583.930365918999, 12678.746425071631, 12699.682507937376, 12748.298843563693, 13178.011649126162, 14076.507322243673, 14235.35940882642, 14303.284835758379, 14470.348834302693, 11577.247478913843, 11640.94179529097, 11739.471723772622, 11863.466144023712, 12004.0, 10649.680509584725, 10790.67627971162, 10845.837312440477, 10979.780404391708, 11077.169212308949, 10260.281780275309, 10286.0, 10305.896941030494, 10381.896181038093, 10433.426161561187, 7574.128975167926, 7660.808479787827, 7667.11828139771, 7675.884861727191, 7766.844663106819, 7800.960995194988, 7876.291133797986, 7879.409044321814, 7973.72091976778, 7993.440459167802], "value": 6819.243505660478, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.05541985772805, 519.6907839835296, 524.2005940940066, 530.9840704778857, 532.2138604405934, 6410.391012853783, 6413.839654008652, 6447.709853056612, 6460.0, 6503.284638689752, 6243.532769799093, 6266.279377871546, 6267.874642507147, 6331.936680633193, 6344.429001389874, 5200.463684694406, 5211.817586384477, 5227.79088836447, 5262.184361423985, 5279.445658205891, 4955.504449555052, 5082.390113186404, 5204.375474943012, 5221.973890130544, 5301.363836339626, 4982.950170498285, 5010.273510340999, 5021.573166280852, 5089.236614507835, 5106.131957567204, 4988.501149884983, 5004.724740139291, 5010.774515146827, 5060.44335123138, 5089.51649593288, 4397.0, 4488.7531185784765, 4527.0, 4547.977260113711, 4549.454065512126, 6180.2892667343385, 6191.1332413461705, 6225.439710426083, 6251.593646412968, 6256.120226223553, 5700.429957004267, 5711.457411545896, 5718.456746609066, 5757.415307152098, 5824.359320474744, 6580.473562115019, 6618.536702430832, 6631.303713110102, 6673.860048755157, 6702.765403210913, 4909.21452567591, 4922.852314430573, 4960.851174464772, 4978.800847966077, 4980.950190498085, 6708.396244337984, 6784.72861085556, 6853.314668533107, 6869.931300686929, 6881.827954301132, 4981.42713587942, 5027.924581131286, 5062.93678327548, 5078.212877003996, 5082.551472830226, 5077.339945807022, 5089.3638295213095, 5108.157154069537, 5115.309433226541, 5141.5886729061585, 5763.135529670499, 5802.071668533014, 5812.302523697099, 5815.185873977646, 5864.882702346014, 6599.274079851212, 6677.899831502531, 6702.0, 6731.0, 6744.5278830482375, 1757.613325068483, 1761.383515769496, 1774.6184570317444, 1794.2912549542857, 1799.4151900632085, 1170.7541416302672, 1211.9333436660893, 1244.4026867103842, 1251.8998480121568, 1254.0907841814794, 5732.914006289909, 5759.992001399738, 5760.942390576124, 5891.528677705774, 5900.409959004065, 6786.966065169741, 6798.898016529756, 6803.115594972622, 6899.379055884994, 6935.965320173468, 5895.086261629454, 5895.911561326584, 5936.881262374728, 5945.435183657545, 5979.5515336349945, 3569.161247106928, 3594.4428613564937, 3601.4597810328137, 3670.3209906167444, 3675.3751862183494, 6689.213830036983, 6719.160104986877, 6760.628165450948, 6770.796876093725, 6791.932080679228, 6813.659317034128, 6893.896591551131, 6915.965420172867, 7025.683844227022, 7038.190608080136, 6575.243846957565, 6614.735410583523, 6655.234648015444, 6700.899486507707, 6714.865702686016, 6754.5683553921535, 6824.942133969243, 6859.759908403182, 6878.27778083294, 6950.513464057467, 6809.795706128824, 6825.624590647363, 6842.589444633139, 6862.416694581017, 6863.6568171590225, 6574.506911981525, 6620.90068648961, 6662.900056499253, 6681.2984636612455, 6724.159480064992, 4995.0, 5013.749312534432, 5046.293518907282, 5048.823291184791, 5050.191969284897, 6538.476921846146, 6688.565243259172, 6789.762358317435, 6795.7961261162245, 6874.931250687429, 6479.0, 6521.902171467526, 6528.617054775068, 6668.199816022108, 6698.39714425704, 6479.222493300834, 6493.383128602775, 6542.771003014872, 6594.241662208716, 6654.268030516542, 6392.712327945161, 6426.4537514311805, 6512.818205901076, 6530.804075877541, 6627.801165965029, 6554.442872355903, 6558.376954189344, 6629.834254143492, 6667.366600172976, 6694.665266736741, 6335.65153916539, 6370.1718776558755, 6425.357464253537, 6433.356664333529, 6473.546851720334], "value": 5136.045184031283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.8715486254489, 900.7748062984253, 924.5608336040382, 924.8658944453055, 940.1726480696985, 19265.0, 20246.898765506172, 20380.184792608314, 20441.18235270591, 20461.590768184647, 18220.362287319946, 18613.720794188062, 18845.905770471127, 18908.0, 18940.43178704641, 959.5777857742588, 969.6654654144309, 969.9524513525411, 971.4656938683696, 974.2157563161652, 900.2078171209359, 988.2439933450916, 990.9950450247738, 991.2862738828032, 991.6677912899188, 1054.088213695152, 1056.799208150449, 1057.471264367816, 1058.4813441413728, 1062.7290041039562, 935.3592788939599, 1023.5291765787747, 1024.9846252306222, 1051.1380667852363, 1056.1550759392494, 747.9925200747978, 749.0748925077525, 749.3592978003837, 751.5227830327726, 752.289086812962, 19995.900020499805, 20303.695444568344, 20305.39083827473, 20328.983550822548, 20356.898215508976, 19901.0, 21373.78626213749, 21522.784772152234, 21527.67708484374, 21528.89235553828, 16107.114108724016, 16695.165241737865, 16725.916370418192, 16858.494245172664, 17820.46538603844, 6012.0681294399, 6044.365341639153, 6044.879102417971, 6067.150598916155, 6068.6662233577135, 139883.30058349745, 140889.0, 141927.99999999898, 141987.0, 145015.0, 15968.201589920458, 16016.279267432994, 16579.585510362336, 16583.585410364594, 16605.252763625667, 30114.397712045637, 30551.541726874115, 30642.233944151576, 30669.38661226763, 30738.0, 8069.435139540294, 8306.54314012723, 8323.375746819012, 8349.499030058216, 8352.958235208785, 4115.97942010294, 4138.358554424069, 4141.585841415895, 4178.22702799983, 4179.728317659343, 4883.560479556857, 4961.156603377434, 4971.279164521196, 4974.477679843564, 4979.477154898684, 926.3746970794687, 941.1435593609782, 944.9291303152291, 951.8524628682566, 953.0850383631791, 652.3378770547897, 657.4280376072848, 657.4411750012547, 668.7826456401689, 669.9866002679919, 11268.604180916747, 11802.586909458129, 12003.699907502383, 12256.877431225574, 12461.428201708166, 631.4948041566728, 633.4014356433219, 636.3954243468723, 646.1890327638783, 648.7113234610647, 5324.520793128637, 5335.813246536431, 5340.332458442695, 5370.248165256867, 6383.6808159592765, 123072.38463807624, 123367.38316308541, 125765.37117314538, 128942.35528822296, 130052.0, 109123.45438272758, 110795.0, 111415.0, 112213.43893280481, 112830.0, 92376.53811731032, 94622.0, 99052.5047374773, 100245.73446749154, 101595.49202253942, 12759.553415630407, 12795.0, 12881.935590321988, 12886.613401597968, 12890.35548222604, 41892.37161442642, 43044.56955430531, 43743.56256437395, 44286.55713442953, 45557.0, 57116.428835711115, 57928.4207157923, 58299.70850145722, 58862.705686473004, 60898.39101608927, 18059.2776288947, 18507.814921850608, 18535.629287413907, 18554.536136596154, 18559.814401856347, 21886.671699924194, 22151.889240553694, 22237.332880013626, 22452.32643020712, 22701.43246418853, 20077.29729459462, 20379.4905127373, 20379.898100509403, 20498.487537811674, 20515.8974205134, 19054.42836714901, 19868.50328741793, 19908.402747917586, 19918.800811991696, 19920.003999800243, 18512.907435462737, 18628.441146765617, 18742.531436713645, 18801.05994700287, 18909.43271701851, 12869.163504372185, 13288.800667990181, 13317.267550284827, 13600.455981760619, 13854.65363365924, 15026.774598380814, 15411.61470963235, 15420.614484637525, 15450.9227453862, 15482.380704772133], "value": 9395.787606486203, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1441.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 107.0, 106.0, 110.0, 112.0, 109.0, 108.0, 108.0, 107.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 122.0, 115.0, 114.0, 119.0, 121.0, 118.0, 126.0, 126.0], "value": 119.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 165.0, 162.0, 162.0, 167.0, 169.0, 163.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 74.0, 73.0, 73.0, 75.0, 75.0, 80.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 77.0, 78.0, 78.0, 79.0, 136.0, 79.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 111.0, 114.0, 110.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 150.0, 150.0, 149.0, 147.0, 149.0, 159.0, 149.0, 149.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 93.0, 93.0, 99.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 54.0, 53.0, 53.0, 52.0, 63.0, 52.0, 51.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 43.0, 43.0, 39.0, 38.0, 38.0, 38.0], "value": 39.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 75.0, 80.0, 74.0, 76.0, 77.0, 79.0, 79.0, 76.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 122.0, 115.0, 126.0, 137.0, 123.0, 129.0, 122.0, 119.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 172.0, 174.0, 168.0, 176.0, 181.0, 171.0, 166.0, 168.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 63.0, 64.0, 67.0, 73.0, 63.0, 63.0, 66.0, 64.0, 63.0], "value": 66.0, "unit": "score"}]}]} 11:27:51 INFO - Return code: 0 11:27:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:27:51 INFO - # TBPL SUCCESS # 11:27:51 INFO - Running post-action listener: _package_coverage_data 11:27:51 INFO - Running post-action listener: _resource_record_post_action 11:27:51 INFO - [mozharness: 2017-09-07 18:27:51.149010Z] Finished run-tests step (success) 11:27:51 INFO - Running post-run listener: _resource_record_post_run 11:27:51 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278515712; Read time: 12; Write time: 133132 11:27:51 INFO - TinderboxPrint: CPU usage
13.1% 11:27:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:27:51 INFO - TinderboxPrint: I/O write bytes / time
278,515,712 / 133,132 11:27:51 INFO - TinderboxPrint: CPU idle
8,228.6 (86.9%) 11:27:51 INFO - TinderboxPrint: CPU user
1,193.2 (12.6%) 11:27:51 INFO - TinderboxPrint: Swap in / out
0 / 0 11:27:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 294912; Read time: 0; Write time: 52 11:27:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:27:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278220800; Read time: 12; Write time: 133080 11:27:51 INFO - Running post-run listener: _upload_blobber_files 11:27:51 INFO - Blob upload gear active. 11:27:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:51 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 11:27:51 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'] 11:27:51 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 11:27:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:27:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:53 INFO - (blobuploader) - INFO - Done attempting. 11:27:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:27:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:54 INFO - (blobuploader) - INFO - Done attempting. 11:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:55 INFO - (blobuploader) - INFO - Done attempting. 11:27:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:27:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:58 INFO - (blobuploader) - INFO - Done attempting. 11:27:58 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:58 INFO - Return code: 0 11:27:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3adfeb2f9c547f890a64aeb41a258e8337f4801d253868aa9e815b74a12d1a11bc2a06267f1d336f13b2c1600e9cfc79711edf64334ef8a7dcc6c808fb305d1a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be1ab0faf7eebd54a996b89f67964fade0988dbec27bc5dacf5ece40599fcd60f3ce91d692a5665e0e597fc5e9e2ba4659b711e0898b84c3bb3860b2a498d83a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/97693c849bf45fef273541d38a40c068dc0bac2fcea250a9f27e02f34d84cd65f4ae386d1d03eabe9e48b32e598b9f937410889cf2a3d837c656e7be8ddc0826", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3be6efc520a260adcd0a3f8f7aa8443327f67ba70e8cd8844849228dfd777faa76e105f7ca827e9d5d20b910db07f61a716ab66042d0a31e9b2e7d2334cb0321"} 11:27:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:58 INFO - Contents: 11:27:58 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3adfeb2f9c547f890a64aeb41a258e8337f4801d253868aa9e815b74a12d1a11bc2a06267f1d336f13b2c1600e9cfc79711edf64334ef8a7dcc6c808fb305d1a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be1ab0faf7eebd54a996b89f67964fade0988dbec27bc5dacf5ece40599fcd60f3ce91d692a5665e0e597fc5e9e2ba4659b711e0898b84c3bb3860b2a498d83a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/97693c849bf45fef273541d38a40c068dc0bac2fcea250a9f27e02f34d84cd65f4ae386d1d03eabe9e48b32e598b9f937410889cf2a3d837c656e7be8ddc0826", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3be6efc520a260adcd0a3f8f7aa8443327f67ba70e8cd8844849228dfd777faa76e105f7ca827e9d5d20b910db07f61a716ab66042d0a31e9b2e7d2334cb0321"} 11:27:58 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:58 INFO - Copying logs to upload dir... 11:27:58 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.638729 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2017-09-07 11:27:58.688520) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:27:58.692843) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3adfeb2f9c547f890a64aeb41a258e8337f4801d253868aa9e815b74a12d1a11bc2a06267f1d336f13b2c1600e9cfc79711edf64334ef8a7dcc6c808fb305d1a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be1ab0faf7eebd54a996b89f67964fade0988dbec27bc5dacf5ece40599fcd60f3ce91d692a5665e0e597fc5e9e2ba4659b711e0898b84c3bb3860b2a498d83a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/97693c849bf45fef273541d38a40c068dc0bac2fcea250a9f27e02f34d84cd65f4ae386d1d03eabe9e48b32e598b9f937410889cf2a3d837c656e7be8ddc0826", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3be6efc520a260adcd0a3f8f7aa8443327f67ba70e8cd8844849228dfd777faa76e105f7ca827e9d5d20b910db07f61a716ab66042d0a31e9b2e7d2334cb0321"} build_url:https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3adfeb2f9c547f890a64aeb41a258e8337f4801d253868aa9e815b74a12d1a11bc2a06267f1d336f13b2c1600e9cfc79711edf64334ef8a7dcc6c808fb305d1a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be1ab0faf7eebd54a996b89f67964fade0988dbec27bc5dacf5ece40599fcd60f3ce91d692a5665e0e597fc5e9e2ba4659b711e0898b84c3bb3860b2a498d83a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/97693c849bf45fef273541d38a40c068dc0bac2fcea250a9f27e02f34d84cd65f4ae386d1d03eabe9e48b32e598b9f937410889cf2a3d837c656e7be8ddc0826", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3be6efc520a260adcd0a3f8f7aa8443327f67ba70e8cd8844849228dfd777faa76e105f7ca827e9d5d20b910db07f61a716ab66042d0a31e9b2e7d2334cb0321"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:27:58.724221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:27:58.724589) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504807568.950170-2067699842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:27:58.807610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:27:58.807987) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:27:58.808356) ========= ========= Total master_lag: 0.80 =========