builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1494567685.94 results: success (0) revision: 8a7d0b15595f9916123848ca906f29c62d4914c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:25.941306) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:25.941767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:25.942047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:25.956393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:25.956669) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 22:41:25-- 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% 221M=0s 2017-05-11 22:41:26 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:26.092332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:26.095674) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019157 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:26.145551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 22:41:26.148918) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a7d0b15595f9916123848ca906f29c62d4914c9 --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 8a7d0b15595f9916123848ca906f29c62d4914c9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 22:41:26,214 truncating revision to first 12 chars 2017-05-11 22:41:26,214 Setting DEBUG logging. 2017-05-11 22:41:26,214 attempt 1/10 2017-05-11 22:41:26,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a7d0b15595f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 22:41:27,270 unpacking tar archive at: mozilla-central-8a7d0b15595f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374185 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 22:41:27.536220) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:27.536540) ========= script_repo_revision: 8a7d0b15595f9916123848ca906f29c62d4914c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:27.539943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:27.540213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 22:41:27.551338) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-11 22:41:27.551662) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:41:27 INFO - MultiFileLogger online at 20170511 22:41:27 in /builds/slave/test 22:41:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:41:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:41:27 INFO - {'append_to_log': False, 22:41:27 INFO - 'base_work_dir': '/builds/slave/test', 22:41:27 INFO - 'blob_upload_branch': 'Firefox', 22:41:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:41:27 INFO - 'branch': 'Firefox', 22:41:27 INFO - 'buildbot_json_path': 'buildprops.json', 22:41:27 INFO - 'config_files': ('talos/linux_config.py',), 22:41:27 INFO - 'default_actions': ('clobber', 22:41:27 INFO - 'read-buildbot-config', 22:41:27 INFO - 'download-and-extract', 22:41:27 INFO - 'populate-webroot', 22:41:27 INFO - 'create-virtualenv', 22:41:27 INFO - 'install', 22:41:27 INFO - 'run-tests'), 22:41:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:41:27 INFO - 'download_minidump_stackwalk': True, 22:41:27 INFO - 'download_symbols': 'ondemand', 22:41:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:41:27 INFO - 'tooltool.py': '/tools/tooltool.py', 22:41:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:41:27 INFO - '/tools/misc-python/virtualenv.py')}, 22:41:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:41:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:41:27 INFO - 'gecko_profile': False, 22:41:27 INFO - 'gecko_profile_interval': 0, 22:41:27 INFO - 'installer_path': 'installer.exe', 22:41:27 INFO - 'log_level': 'info', 22:41:27 INFO - 'log_name': 'talos', 22:41:27 INFO - 'log_to_console': True, 22:41:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:41:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:41:27 INFO - 'opt_config_files': (), 22:41:27 INFO - 'pip_index': False, 22:41:27 INFO - 'suite': 'dromaeojs', 22:41:27 INFO - 'system_bits': '32', 22:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:41:27 INFO - 'title': 'talos-linux64-ix-033', 22:41:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:41:27 INFO - 'use_talos_json': True, 22:41:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:41:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:41:27 INFO - 'work_dir': 'build'} 22:41:27 INFO - [mozharness: 2017-05-12 05:41:27.717703Z] Running clobber step. 22:41:27 INFO - Running pre-action listener: _resource_record_pre_action 22:41:27 INFO - Running main action method: clobber 22:41:27 INFO - rmtree: /builds/slave/test/build 22:41:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:41:29 INFO - Running post-action listener: _resource_record_post_action 22:41:29 INFO - [mozharness: 2017-05-12 05:41:29.159997Z] Finished clobber step (success) 22:41:29 INFO - [mozharness: 2017-05-12 05:41:29.160096Z] Running read-buildbot-config step. 22:41:29 INFO - Running pre-action listener: _resource_record_pre_action 22:41:29 INFO - Running main action method: read_buildbot_config 22:41:29 INFO - Using buildbot properties: 22:41:29 INFO - { 22:41:29 INFO - "project": "", 22:41:29 INFO - "product": "firefox", 22:41:29 INFO - "who": "philringnalda@gmail.com", 22:41:29 INFO - "installer_path": "public/build/target.tar.bz2", 22:41:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:41:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:41:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:41:29 INFO - "stage_platform": "linux64-pgo", 22:41:29 INFO - "basedir": "/builds/slave/test", 22:41:29 INFO - "buildnumber": 177, 22:41:29 INFO - "platform": "ubuntu64_hw", 22:41:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:41:29 INFO - "slavebuilddir": "test", 22:41:29 INFO - "taskId": "LgK1QSq-QTOuAKAPd1D7Jw", 22:41:29 INFO - "branch": "mozilla-central", 22:41:29 INFO - "script_repo_revision": "production", 22:41:29 INFO - "revision": "8a7d0b15595f9916123848ca906f29c62d4914c9", 22:41:29 INFO - "slavename": "talos-linux64-ix-033", 22:41:29 INFO - "repo_path": "mozilla-central" 22:41:29 INFO - } 22:41:29 INFO - Finding installer, test and symbols from parent task. 22:41:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LgK1QSq-QTOuAKAPd1D7Jw'}, attempt #1 22:41:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LgK1QSq-QTOuAKAPd1D7Jw'}, attempt #1 22:41:30 INFO - Task dependencies: Mlva3LD-Rf6aiGF7U7iLzg 22:41:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg'}, attempt #1 22:41:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.tar.bz2 22:41:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/test_packages.json 22:41:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.crashreporter-symbols.zip 22:41:30 INFO - Running post-action listener: _resource_record_post_action 22:41:30 INFO - [mozharness: 2017-05-12 05:41:30.485115Z] Finished read-buildbot-config step (success) 22:41:30 INFO - [mozharness: 2017-05-12 05:41:30.485334Z] Running download-and-extract step. 22:41:30 INFO - Running pre-action listener: _resource_record_pre_action 22:41:30 INFO - Running main action method: download_and_extract 22:41:30 INFO - mkdir: /builds/slave/test/build/tests 22:41:30 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')]} 22:41:30 INFO - trying https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.test_packages.json 22:41:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:41:31 INFO - Downloaded 986 bytes. 22:41:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:41:31 INFO - Using the following test package requirements: 22:41:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:41:31 INFO - u'common': [u'target.common.tests.zip'], 22:41:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:41:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:41:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:41:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:41:31 INFO - u'mozbase': [u'target.common.tests.zip'], 22:41:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:41:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:41:31 INFO - u'web-platform': [u'target.common.tests.zip', 22:41:31 INFO - u'target.web-platform.tests.zip'], 22:41:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:41:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:41:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.common.tests.zip 22:41:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:41:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.common.tests.zip into memory 22:41:32 INFO - Content-Length response header: 60740333 22:41:32 INFO - Bytes received: 60740333 22:41:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:41:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.common.tests.zip 22:41:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:41:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.common.tests.zip into memory 22:41:43 INFO - Content-Length response header: 60740333 22:41:43 INFO - Bytes received: 60740333 22:41:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.talos.tests.zip 22:41:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:41:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.talos.tests.zip into memory 22:41:54 INFO - Content-Length response header: 14409411 22:41:54 INFO - Bytes received: 14409411 22:41:54 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')]} 22:41:54 INFO - trying https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.tar.bz2 22:41:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:41:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:41:56 INFO - Downloaded 68889723 bytes. 22:41:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.tar.bz2 22:41:56 INFO - mkdir: /builds/slave/test/properties 22:41:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:41:56 INFO - Writing to file /builds/slave/test/properties/build_url 22:41:56 INFO - Contents: 22:41:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.tar.bz2 22:41:56 INFO - Running post-action listener: _resource_record_post_action 22:41:56 INFO - Running post-action listener: set_extra_try_arguments 22:41:56 INFO - [mozharness: 2017-05-12 05:41:56.531596Z] Finished download-and-extract step (success) 22:41:56 INFO - [mozharness: 2017-05-12 05:41:56.531693Z] Running populate-webroot step. 22:41:56 INFO - Running pre-action listener: _resource_record_pre_action 22:41:56 INFO - Running main action method: populate_webroot 22:41:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:41:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:41:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:41:56 INFO - '--tppagecycles', 22:41:56 INFO - '7'], 22:41:56 INFO - 'tests': ['tsvgm']}}, 22:41:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:41:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:41:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:41:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:41:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:41:56 INFO - 'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:41:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:41:56 INFO - 'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['damp', 'tps']}, 22:41:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:41:56 INFO - 'tests': ['damp', 'tps']}, 22:41:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['dromaeo_dom']}, 22:41:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:41:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:41:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:41:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['a11yr', 22:41:56 INFO - 'ts_paint', 22:41:56 INFO - 'tpaint', 22:41:56 INFO - 'sessionrestore', 22:41:56 INFO - 'sessionrestore_no_auto_restore', 22:41:56 INFO - 'tabpaint']}, 22:41:56 INFO - 'other-e10s': {'tests': ['a11yr', 22:41:56 INFO - 'ts_paint', 22:41:56 INFO - 'tpaint', 22:41:56 INFO - 'sessionrestore', 22:41:56 INFO - 'sessionrestore_no_auto_restore', 22:41:56 INFO - 'tabpaint']}, 22:41:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:41:56 INFO - 'ts_paint', 22:41:56 INFO - 'tpaint', 22:41:56 INFO - 'sessionrestore', 22:41:56 INFO - 'sessionrestore_no_auto_restore', 22:41:56 INFO - 'tabpaint']}, 22:41:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:41:56 INFO - 'ts_paint', 22:41:56 INFO - 'tpaint', 22:41:56 INFO - 'sessionrestore', 22:41:56 INFO - 'sessionrestore_no_auto_restore', 22:41:56 INFO - 'tabpaint']}, 22:41:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['a11yr', 22:41:56 INFO - 'ts_paint', 22:41:56 INFO - 'tpaint', 22:41:56 INFO - 'sessionrestore', 22:41:56 INFO - 'sessionrestore_no_auto_restore', 22:41:56 INFO - 'tabpaint']}, 22:41:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['a11yr', 22:41:56 INFO - 'ts_paint', 22:41:56 INFO - 'tpaint', 22:41:56 INFO - 'sessionrestore', 22:41:56 INFO - 'sessionrestore_no_auto_restore', 22:41:56 INFO - 'tabpaint']}, 22:41:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:41:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:41:56 INFO - 'bloom_basic_ref']}, 22:41:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['tsvgx', 22:41:56 INFO - 'tsvgr_opacity', 22:41:56 INFO - 'tart', 22:41:56 INFO - 'tscrollx', 22:41:56 INFO - 'cart', 22:41:56 INFO - 'tsvg_static']}, 22:41:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:41:56 INFO - 'tsvgr_opacity', 22:41:56 INFO - 'tart', 22:41:56 INFO - 'tscrollx', 22:41:56 INFO - 'cart', 22:41:56 INFO - 'tsvg_static']}, 22:41:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:41:56 INFO - 'talos_options': ['--disable-e10s'], 22:41:56 INFO - 'tests': ['tp5o']}, 22:41:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:41:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:41:56 INFO - 'talos_options': ['--disable-e10s', 22:41:56 INFO - '--xperf_path', 22:41:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:56 INFO - 'tests': ['tp5n']}, 22:41:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:41:56 INFO - 'talos_options': ['--xperf_path', 22:41:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:56 INFO - 'tests': ['tp5n']}}, 22:41:56 INFO - 'talos.zip': {'path': '', 22:41:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:41:56 INFO - Running post-action listener: _resource_record_post_action 22:41:56 INFO - [mozharness: 2017-05-12 05:41:56.545281Z] Finished populate-webroot step (success) 22:41:56 INFO - [mozharness: 2017-05-12 05:41:56.545377Z] Running create-virtualenv step. 22:41:56 INFO - Running pre-action listener: _resource_record_pre_action 22:41:56 INFO - Running main action method: create_virtualenv 22:41:56 INFO - Creating virtualenv /builds/slave/test/build/venv 22:41:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:41:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:41:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:41:56 INFO - Using real prefix '/usr' 22:41:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:41:57 INFO - Installing distribute.............................................................................................................................................................................................done. 22:41:59 INFO - Installing pip.................done. 22:41:59 INFO - Return code: 0 22:41:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:41:59 INFO - Reading from file tmpfile_stdout 22:41:59 INFO - Output received: 22:41:59 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:41:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:41:59 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')]} 22:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:59 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')]} 22:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:59 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:41:59 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 22:41:59 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 22:41:59 INFO - Using env: {'DISPLAY': ':0', 22:41:59 INFO - 'HOME': '/home/cltbld', 22:41:59 INFO - 'LANG': 'en_US.UTF-8', 22:41:59 INFO - 'LANGUAGE': 'en_US:en', 22:41:59 INFO - 'LOGNAME': 'cltbld', 22:41:59 INFO - 'MAIL': '/var/mail/cltbld', 22:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:59 INFO - 'MOZ_NO_REMOTE': '1', 22:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:59 INFO - 'NO_EM_RESTART': '1', 22:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:59 INFO - 'PWD': '/builds/slave/test', 22:41:59 INFO - 'SHELL': '/bin/bash', 22:41:59 INFO - 'SHLVL': '1', 22:41:59 INFO - 'TERM': 'linux', 22:41:59 INFO - 'TMOUT': '86400', 22:41:59 INFO - 'USER': 'cltbld', 22:41:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:59 INFO - '_': '/tools/buildbot/bin/python'} 22:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:41:59 INFO - Cleaning up... 22:41:59 INFO - Return code: 0 22:41:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:41:59 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')]} 22:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:59 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')]} 22:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:59 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:41:59 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 22:41:59 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 22:41:59 INFO - Using env: {'DISPLAY': ':0', 22:41:59 INFO - 'HOME': '/home/cltbld', 22:41:59 INFO - 'LANG': 'en_US.UTF-8', 22:41:59 INFO - 'LANGUAGE': 'en_US:en', 22:41:59 INFO - 'LOGNAME': 'cltbld', 22:41:59 INFO - 'MAIL': '/var/mail/cltbld', 22:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:59 INFO - 'MOZ_NO_REMOTE': '1', 22:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:59 INFO - 'NO_EM_RESTART': '1', 22:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:59 INFO - 'PWD': '/builds/slave/test', 22:41:59 INFO - 'SHELL': '/bin/bash', 22:41:59 INFO - 'SHLVL': '1', 22:41:59 INFO - 'TERM': 'linux', 22:41:59 INFO - 'TMOUT': '86400', 22:41:59 INFO - 'USER': 'cltbld', 22:41:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:59 INFO - '_': '/tools/buildbot/bin/python'} 22:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:59 INFO - Downloading/unpacking psutil>=3.1.1 22:41:59 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 22:41:59 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 22:41:59 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 22:41:59 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 22:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:42:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:00 INFO - Installing collected packages: psutil 22:42:00 INFO - Running setup.py install for psutil 22:42:01 INFO - building 'psutil._psutil_linux' extension 22:42:01 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 22:42:01 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 22:42:01 INFO - building 'psutil._psutil_posix' extension 22:42:01 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 22:42:01 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 22:42:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:01 INFO - Successfully installed psutil 22:42:01 INFO - Cleaning up... 22:42:01 INFO - Return code: 0 22:42:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:42:01 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')]} 22:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:01 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')]} 22:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:01 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:42:01 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 22:42:01 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 22:42:01 INFO - Using env: {'DISPLAY': ':0', 22:42:01 INFO - 'HOME': '/home/cltbld', 22:42:01 INFO - 'LANG': 'en_US.UTF-8', 22:42:01 INFO - 'LANGUAGE': 'en_US:en', 22:42:01 INFO - 'LOGNAME': 'cltbld', 22:42:01 INFO - 'MAIL': '/var/mail/cltbld', 22:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:01 INFO - 'MOZ_NO_REMOTE': '1', 22:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:01 INFO - 'NO_EM_RESTART': '1', 22:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:01 INFO - 'PWD': '/builds/slave/test', 22:42:01 INFO - 'SHELL': '/bin/bash', 22:42:01 INFO - 'SHLVL': '1', 22:42:01 INFO - 'TERM': 'linux', 22:42:01 INFO - 'TMOUT': '86400', 22:42:01 INFO - 'USER': 'cltbld', 22:42:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:01 INFO - '_': '/tools/buildbot/bin/python'} 22:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:42:01 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 22:42:01 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 22:42:01 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 22:42:01 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 22:42:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:42:02 INFO - Installing collected packages: mozsystemmonitor 22:42:02 INFO - Running setup.py install for mozsystemmonitor 22:42:02 INFO - Successfully installed mozsystemmonitor 22:42:02 INFO - Cleaning up... 22:42:02 INFO - Return code: 0 22:42:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:42: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')]} 22:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42: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')]} 22:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:42: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==2.5.1'] in /builds/slave/test/build 22:42: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==2.5.1 22:42:02 INFO - Using env: {'DISPLAY': ':0', 22:42:02 INFO - 'HOME': '/home/cltbld', 22:42:02 INFO - 'LANG': 'en_US.UTF-8', 22:42:02 INFO - 'LANGUAGE': 'en_US:en', 22:42:02 INFO - 'LOGNAME': 'cltbld', 22:42:02 INFO - 'MAIL': '/var/mail/cltbld', 22:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:02 INFO - 'MOZ_NO_REMOTE': '1', 22:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:02 INFO - 'NO_EM_RESTART': '1', 22:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:02 INFO - 'PWD': '/builds/slave/test', 22:42:02 INFO - 'SHELL': '/bin/bash', 22:42:02 INFO - 'SHLVL': '1', 22:42:02 INFO - 'TERM': 'linux', 22:42:02 INFO - 'TMOUT': '86400', 22:42:02 INFO - 'USER': 'cltbld', 22:42:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:02 INFO - '_': '/tools/buildbot/bin/python'} 22:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:03 INFO - Downloading/unpacking jsonschema==2.5.1 22:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:42:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:04 INFO - Downloading functools32-3.2.3-2.tar.gz 22:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:42:04 INFO - warning: no files found matching '*.txt' 22:42:04 INFO - no previously-included directories found matching 'build' 22:42:04 INFO - no previously-included directories found matching 'dist' 22:42:04 INFO - no previously-included directories found matching '.git*' 22:42:04 INFO - Installing collected packages: jsonschema, functools32 22:42:04 INFO - Running setup.py install for functools32 22:42:04 INFO - warning: no files found matching '*.txt' 22:42:04 INFO - no previously-included directories found matching 'build' 22:42:04 INFO - no previously-included directories found matching 'dist' 22:42:04 INFO - no previously-included directories found matching '.git*' 22:42:04 INFO - Successfully installed jsonschema functools32 22:42:04 INFO - Cleaning up... 22:42:04 INFO - Return code: 0 22:42:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:42:04 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')]} 22:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:04 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')]} 22:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:04 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:42:04 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 22:42:04 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 22:42:04 INFO - Using env: {'DISPLAY': ':0', 22:42:04 INFO - 'HOME': '/home/cltbld', 22:42:04 INFO - 'LANG': 'en_US.UTF-8', 22:42:04 INFO - 'LANGUAGE': 'en_US:en', 22:42:04 INFO - 'LOGNAME': 'cltbld', 22:42:04 INFO - 'MAIL': '/var/mail/cltbld', 22:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:04 INFO - 'MOZ_NO_REMOTE': '1', 22:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:04 INFO - 'NO_EM_RESTART': '1', 22:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:04 INFO - 'PWD': '/builds/slave/test', 22:42:04 INFO - 'SHELL': '/bin/bash', 22:42:04 INFO - 'SHLVL': '1', 22:42:04 INFO - 'TERM': 'linux', 22:42:04 INFO - 'TMOUT': '86400', 22:42:04 INFO - 'USER': 'cltbld', 22:42:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:04 INFO - '_': '/tools/buildbot/bin/python'} 22:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:42:04 INFO - Cleaning up... 22:42:04 INFO - Return code: 0 22:42:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:42:04 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')]} 22:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:04 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')]} 22:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:04 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:42:04 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 22:42:04 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 22:42:04 INFO - Using env: {'DISPLAY': ':0', 22:42:04 INFO - 'HOME': '/home/cltbld', 22:42:04 INFO - 'LANG': 'en_US.UTF-8', 22:42:04 INFO - 'LANGUAGE': 'en_US:en', 22:42:04 INFO - 'LOGNAME': 'cltbld', 22:42:04 INFO - 'MAIL': '/var/mail/cltbld', 22:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:04 INFO - 'MOZ_NO_REMOTE': '1', 22:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:04 INFO - 'NO_EM_RESTART': '1', 22:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:04 INFO - 'PWD': '/builds/slave/test', 22:42:04 INFO - 'SHELL': '/bin/bash', 22:42:04 INFO - 'SHLVL': '1', 22:42:04 INFO - 'TERM': 'linux', 22:42:04 INFO - 'TMOUT': '86400', 22:42:04 INFO - 'USER': 'cltbld', 22:42:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:04 INFO - '_': '/tools/buildbot/bin/python'} 22:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:05 INFO - Downloading/unpacking blobuploader==1.2.4 22:42:05 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 22:42:05 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 22:42:05 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 22:42:05 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 22:42:06 INFO - Downloading blobuploader-1.2.4.tar.gz 22:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:42:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:42:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:06 INFO - Downloading docopt-0.6.1.tar.gz 22:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:42:06 INFO - Installing collected packages: blobuploader, requests, docopt 22:42:06 INFO - Running setup.py install for blobuploader 22:42:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:42:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:42:06 INFO - Running setup.py install for requests 22:42:07 INFO - Running setup.py install for docopt 22:42:07 INFO - Successfully installed blobuploader requests docopt 22:42:07 INFO - Cleaning up... 22:42:07 INFO - Return code: 0 22:42:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:07 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')]} 22:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:07 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')]} 22:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:07 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:42:07 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 22:42:07 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 22:42:07 INFO - Using env: {'DISPLAY': ':0', 22:42:07 INFO - 'HOME': '/home/cltbld', 22:42:07 INFO - 'LANG': 'en_US.UTF-8', 22:42:07 INFO - 'LANGUAGE': 'en_US:en', 22:42:07 INFO - 'LOGNAME': 'cltbld', 22:42:07 INFO - 'MAIL': '/var/mail/cltbld', 22:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:07 INFO - 'MOZ_NO_REMOTE': '1', 22:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:07 INFO - 'NO_EM_RESTART': '1', 22:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:07 INFO - 'PWD': '/builds/slave/test', 22:42:07 INFO - 'SHELL': '/bin/bash', 22:42:07 INFO - 'SHLVL': '1', 22:42:07 INFO - 'TERM': 'linux', 22:42:07 INFO - 'TMOUT': '86400', 22:42:07 INFO - 'USER': 'cltbld', 22:42:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:07 INFO - '_': '/tools/buildbot/bin/python'} 22:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:42:07 INFO - Running setup.py (path:/tmp/pip-2ZRlLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:42:07 INFO - Running setup.py (path:/tmp/pip-j2512g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:42:07 INFO - Running setup.py (path:/tmp/pip-fHmFNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:42:07 INFO - Running setup.py (path:/tmp/pip-B4kXv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:42:07 INFO - Running setup.py (path:/tmp/pip-_wPmNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:42:07 INFO - Running setup.py (path:/tmp/pip-hUigu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:42:07 INFO - Running setup.py (path:/tmp/pip-l_ZJEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:42:08 INFO - Running setup.py (path:/tmp/pip-AkXJWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:42:08 INFO - Running setup.py (path:/tmp/pip-tpT6aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:42:08 INFO - Running setup.py (path:/tmp/pip-HsEugj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:42:08 INFO - Running setup.py (path:/tmp/pip-ZCDoCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:42:08 INFO - Running setup.py (path:/tmp/pip-aQeCjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:42:08 INFO - Running setup.py (path:/tmp/pip-evXVnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:42:08 INFO - Running setup.py (path:/tmp/pip-dUdDVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:08 INFO - Running setup.py (path:/tmp/pip-M34cmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:42:08 INFO - Running setup.py (path:/tmp/pip-uGk4zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:42:08 INFO - Running setup.py (path:/tmp/pip-OQKxdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:42:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:42:08 INFO - Running setup.py install for manifestparser 22:42:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:42:08 INFO - Running setup.py install for mozcrash 22:42:08 INFO - Running setup.py install for mozdebug 22:42:09 INFO - Running setup.py install for mozdevice 22:42:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Running setup.py install for mozfile 22:42:09 INFO - Running setup.py install for mozhttpd 22:42:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Running setup.py install for mozinfo 22:42:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Running setup.py install for mozInstall 22:42:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Running setup.py install for mozleak 22:42:09 INFO - Running setup.py install for mozlog 22:42:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Running setup.py install for moznetwork 22:42:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:42:09 INFO - Running setup.py install for mozprocess 22:42:09 INFO - Running setup.py install for mozprofile 22:42:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:42:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:42:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:42:10 INFO - Running setup.py install for mozrunner 22:42:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:42:10 INFO - Running setup.py install for mozscreenshot 22:42:10 INFO - Running setup.py install for moztest 22:42:10 INFO - Running setup.py install for mozversion 22:42:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:42:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:42:10 INFO - Cleaning up... 22:42:10 INFO - Return code: 0 22:42:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:10 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')]} 22:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:10 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')]} 22:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:10 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:42:10 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 22:42:10 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 22:42:10 INFO - Using env: {'DISPLAY': ':0', 22:42:10 INFO - 'HOME': '/home/cltbld', 22:42:10 INFO - 'LANG': 'en_US.UTF-8', 22:42:10 INFO - 'LANGUAGE': 'en_US:en', 22:42:10 INFO - 'LOGNAME': 'cltbld', 22:42:10 INFO - 'MAIL': '/var/mail/cltbld', 22:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:10 INFO - 'MOZ_NO_REMOTE': '1', 22:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:10 INFO - 'NO_EM_RESTART': '1', 22:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:10 INFO - 'PWD': '/builds/slave/test', 22:42:10 INFO - 'SHELL': '/bin/bash', 22:42:10 INFO - 'SHLVL': '1', 22:42:10 INFO - 'TERM': 'linux', 22:42:10 INFO - 'TMOUT': '86400', 22:42:10 INFO - 'USER': 'cltbld', 22:42:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:10 INFO - '_': '/tools/buildbot/bin/python'} 22:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:42:10 INFO - Running setup.py (path:/tmp/pip-gN3t9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:42:10 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)) 22:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:42:10 INFO - Running setup.py (path:/tmp/pip-gbp6Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:42:10 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)) 22:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:42:10 INFO - Running setup.py (path:/tmp/pip-0BKVFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:42:10 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)) 22:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:42:10 INFO - Running setup.py (path:/tmp/pip-HN6hPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:42:11 INFO - Running setup.py (path:/tmp/pip-IqNrbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:42:11 INFO - Running setup.py (path:/tmp/pip-fRhZu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:42:11 INFO - Running setup.py (path:/tmp/pip-N5pqCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:42:11 INFO - Running setup.py (path:/tmp/pip-r_K1sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:42:11 INFO - Running setup.py (path:/tmp/pip-zSyaao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:42:11 INFO - Running setup.py (path:/tmp/pip-IiAN9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:42:11 INFO - Running setup.py (path:/tmp/pip-Zi7Egl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:42:11 INFO - Running setup.py (path:/tmp/pip-o9ZKrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:42:11 INFO - Running setup.py (path:/tmp/pip-Uf1OTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:42:11 INFO - Running setup.py (path:/tmp/pip-MTtxHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:11 INFO - Running setup.py (path:/tmp/pip-rKz9BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:42:11 INFO - Running setup.py (path:/tmp/pip-z5Ze6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:42:11 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)) 22:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:42:11 INFO - Running setup.py (path:/tmp/pip-ntl2dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:42:11 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)) 22:42:11 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)) 22:42:11 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)) 22:42:11 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)) 22:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:42:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:42:12 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 22:42:12 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 22:42:12 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 22:42:12 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 22:42:13 INFO - Downloading blessings-1.6.tar.gz 22:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:42:13 INFO - Installing collected packages: blessings 22:42:13 INFO - Running setup.py install for blessings 22:42:13 INFO - Successfully installed blessings 22:42:13 INFO - Cleaning up... 22:42:13 INFO - Return code: 0 22:42:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:13 INFO - Reading from file tmpfile_stdout 22:42:13 INFO - Current package versions: 22:42:13 INFO - argparse == 1.2.1 22:42:13 INFO - blessings == 1.6 22:42:13 INFO - blobuploader == 1.2.4 22:42:13 INFO - docopt == 0.6.1 22:42:13 INFO - functools32 == 3.2.3-2 22:42:13 INFO - jsonschema == 2.5.1 22:42:13 INFO - manifestparser == 1.1 22:42:13 INFO - mozInstall == 1.12 22:42:13 INFO - mozcrash == 1.0 22:42:13 INFO - mozdebug == 0.1 22:42:13 INFO - mozdevice == 0.50 22:42:13 INFO - mozfile == 1.2 22:42:13 INFO - mozhttpd == 0.7 22:42:13 INFO - mozinfo == 0.9 22:42:13 INFO - mozleak == 0.1 22:42:13 INFO - mozlog == 3.4 22:42:13 INFO - moznetwork == 0.27 22:42:13 INFO - mozprocess == 0.25 22:42:13 INFO - mozprofile == 0.28 22:42:13 INFO - mozrunner == 6.13 22:42:13 INFO - mozscreenshot == 0.1 22:42:13 INFO - mozsystemmonitor == 0.3 22:42:13 INFO - moztest == 0.8 22:42:13 INFO - mozversion == 1.4 22:42:13 INFO - psutil == 3.1.1 22:42:13 INFO - requests == 1.2.3 22:42:13 INFO - wsgiref == 0.1.2 22:42:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:13 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')]} 22:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:13 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')]} 22:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:13 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:42:13 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 22:42:13 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 22:42:13 INFO - Using env: {'DISPLAY': ':0', 22:42:13 INFO - 'HOME': '/home/cltbld', 22:42:13 INFO - 'LANG': 'en_US.UTF-8', 22:42:13 INFO - 'LANGUAGE': 'en_US:en', 22:42:13 INFO - 'LOGNAME': 'cltbld', 22:42:13 INFO - 'MAIL': '/var/mail/cltbld', 22:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:13 INFO - 'MOZ_NO_REMOTE': '1', 22:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:13 INFO - 'NO_EM_RESTART': '1', 22:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:13 INFO - 'PWD': '/builds/slave/test', 22:42:13 INFO - 'SHELL': '/bin/bash', 22:42:13 INFO - 'SHLVL': '1', 22:42:13 INFO - 'TERM': 'linux', 22:42:13 INFO - 'TMOUT': '86400', 22:42:13 INFO - 'USER': 'cltbld', 22:42:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:13 INFO - '_': '/tools/buildbot/bin/python'} 22:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 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)) 22:42:13 INFO - Cleaning up... 22:42:13 INFO - Return code: 0 22:42:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:42:13 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')]} 22:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:13 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')]} 22:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', '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 22:42:13 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 22:42:13 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 22:42:13 INFO - Using env: {'DISPLAY': ':0', 22:42:13 INFO - 'HOME': '/home/cltbld', 22:42:13 INFO - 'LANG': 'en_US.UTF-8', 22:42:13 INFO - 'LANGUAGE': 'en_US:en', 22:42:13 INFO - 'LOGNAME': 'cltbld', 22:42:13 INFO - 'MAIL': '/var/mail/cltbld', 22:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:13 INFO - 'MOZ_NO_REMOTE': '1', 22:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:13 INFO - 'NO_EM_RESTART': '1', 22:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:13 INFO - 'PWD': '/builds/slave/test', 22:42:13 INFO - 'SHELL': '/bin/bash', 22:42:13 INFO - 'SHLVL': '1', 22:42:13 INFO - 'TERM': 'linux', 22:42:13 INFO - 'TMOUT': '86400', 22:42:13 INFO - 'USER': 'cltbld', 22:42:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:13 INFO - '_': '/tools/buildbot/bin/python'} 22:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:42:13 INFO - Cleaning up... 22:42:13 INFO - Return code: 0 22:42:13 INFO - Running post-action listener: _resource_record_post_action 22:42:13 INFO - Running post-action listener: _start_resource_monitoring 22:42:13 INFO - Starting resource monitoring. 22:42:13 INFO - [mozharness: 2017-05-12 05:42:13.999714Z] Finished create-virtualenv step (success) 22:42:14 INFO - [mozharness: 2017-05-12 05:42:14.000177Z] Running install step. 22:42:14 INFO - Running pre-action listener: _resource_record_pre_action 22:42:14 INFO - Running main action method: install 22:42:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:14 INFO - Reading from file tmpfile_stdout 22:42:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:42:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:42:14 INFO - Reading from file tmpfile_stdout 22:42:14 INFO - Output received: 22:42:14 INFO - Usage: mozinstall [options] installer 22:42:14 INFO - Options: 22:42:14 INFO - -h, --help show this help message and exit 22:42:14 INFO - -d DEST, --destination=DEST 22:42:14 INFO - Directory to install application into. [default: 22:42:14 INFO - "/builds/slave/test"] 22:42:14 INFO - --app=APP Application being installed. [default: firefox] 22:42:14 INFO - mkdir: /builds/slave/test/build/application 22:42:14 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'] 22:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:42:31 INFO - Reading from file tmpfile_stdout 22:42:31 INFO - Output received: 22:42:31 INFO - /builds/slave/test/build/application/firefox/firefox 22:42:31 INFO - Running post-action listener: _resource_record_post_action 22:42:31 INFO - [mozharness: 2017-05-12 05:42:31.588923Z] Finished install step (success) 22:42:31 INFO - [mozharness: 2017-05-12 05:42:31.589171Z] Running run-tests step. 22:42:31 INFO - Running pre-action listener: _resource_record_pre_action 22:42:31 INFO - Running main action method: run_tests 22:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:42:31 INFO - Python 2.7.3 22:42:31 INFO - Return code: 0 22:42:31 INFO - grabbing minidump binary from tooltool 22:42:31 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')]} 22:42:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135fa30>, '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 0x13607f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1360ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:42:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:42:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:42:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:42:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:42:31 INFO - Return code: 0 22:42:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:42:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:42:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:42:31 INFO - ENV: RUST_BACKTRACE is now 1 22:42:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:42:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:42:31 INFO - Using env: {'DISPLAY': ':0', 22:42:31 INFO - 'HOME': '/home/cltbld', 22:42:31 INFO - 'LANG': 'en_US.UTF-8', 22:42:31 INFO - 'LANGUAGE': 'en_US:en', 22:42:31 INFO - 'LOGNAME': 'cltbld', 22:42:31 INFO - 'MAIL': '/var/mail/cltbld', 22:42:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:42:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:31 INFO - 'MOZ_NO_REMOTE': '1', 22:42:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:31 INFO - 'NO_EM_RESTART': '1', 22:42:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:31 INFO - 'PWD': '/builds/slave/test', 22:42:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:42:31 INFO - 'RUST_BACKTRACE': '1', 22:42:31 INFO - 'SHELL': '/bin/bash', 22:42:31 INFO - 'SHLVL': '1', 22:42:31 INFO - 'TERM': 'linux', 22:42:31 INFO - 'TMOUT': '86400', 22:42:31 INFO - 'USER': 'cltbld', 22:42:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471', 22:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:31 INFO - '_': '/tools/buildbot/bin/python'} 22:42:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:42:31 INFO - mozversion application_buildid: 20170512044447 22:42:31 INFO - mozversion application_changeset: 8a7d0b15595f9916123848ca906f29c62d4914c9 22:42:31 INFO - mozversion application_display_name: Nightly 22:42:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:42:31 INFO - mozversion application_name: Firefox 22:42:31 INFO - mozversion application_remotingname: firefox 22:42:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:42:31 INFO - mozversion application_vendor: Mozilla 22:42:31 INFO - mozversion application_version: 55.0a1 22:42:31 INFO - mozversion platform_buildid: 20170512044447 22:42:31 INFO - mozversion platform_changeset: 8a7d0b15595f9916123848ca906f29c62d4914c9 22:42:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:42:31 INFO - mozversion platform_version: 55.0a1 22:42:31 INFO - using testdate: 1494567751 22:42:31 INFO - actual date: 1494567751 22:42:31 INFO - starting webserver on 'localhost:47146' 22:42:31 INFO - SUITE-START | Running 2 tests 22:42:31 INFO - TEST-START | dromaeo_css 22:42:31 INFO - operating with platform_type : linux_ 22:42:31 INFO - Initialising browser for dromaeo_css test... 22:42:31 INFO - TEST-INFO | started process 20558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyCBbNA/profile http://localhost:47146/getInfo.html) 22:42:35 INFO - PID 20558 | __metrics Screen width/height:1600/1200 22:42:35 INFO - PID 20558 | colorDepth:24 22:42:35 INFO - PID 20558 | Browser inner width/height: 1024/695 22:42:35 INFO - PID 20558 | __metrics 22:42:36 INFO - PID 20558 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:42:36 INFO - PID 20558 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:42:38 INFO - TEST-INFO | 20558: exit 0 22:42:38 INFO - Browser initialized. 22:42:38 INFO - Running cycle 1/1 for dromaeo_css test... 22:42:38 INFO - TEST-INFO | started process 20657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyCBbNA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:49 INFO - PID 20657 | RSS: Main: 144277504 22:42:49 INFO - PID 20657 | 22:45:52 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:47146/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47146/tests/dromaeo/cssquery-ext.html) 22:45:54 INFO - PID 20657 | RSS: Main: 254898176 22:45:54 INFO - PID 20657 | 22:48:56 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:47146/tests/dromaeo/cssquery-ext.html (next: http://localhost:47146/tests/dromaeo/cssquery-jquery.html) 22:48:56 INFO - PID 20657 | RSS: Main: 225341440 22:48:56 INFO - PID 20657 | 22:51:58 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:47146/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47146/tests/dromaeo/cssquery-mootools.html) 22:51:58 INFO - PID 20657 | RSS: Main: 217346048 22:51:58 INFO - PID 20657 | 22:55:00 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:47146/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47146/tests/dromaeo/cssquery-prototype.html) 22:55:01 INFO - PID 20657 | RSS: Main: 206692352 22:55:01 INFO - PID 20657 | 22:58:04 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:47146/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47146/tests/dromaeo/cssquery-yui.html) 22:58:04 INFO - PID 20657 | RSS: Main: 177754112 22:58:04 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:47146/tests/dromaeo/cssquery-yui.html (next: http://localhost:47146/tests/dromaeo/cssquery-dojo.html) 23:01:06 INFO - PID 20657 | RSS: Main: 276320256 23:01:06 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | __start_tp_report 23:01:06 INFO - PID 20657 | _x_x_mozilla_page_load 23:01:06 INFO - PID 20657 | _x_x_mozilla_page_load_details 23:01:06 INFO - PID 20657 | |i|pagename|runs| 23:01:06 INFO - PID 20657 | |0;dojo.html;3316.137804170915;3318.054354508965;3329.6004479462467;3336.399448099343;3369.2250782320066;5594.748236329365;5696.202531645573;5773.711314434272;5799.333076696176;5814.156947242653;5759.82720518384;5785.797497087603;5792.189093526899;5855.209546711193;5856.121581762738;4697.859064228079;5012.122878496249;5107.974460127694;5149.2791009258735;5206.817761378353;5167.870803229912;5182.844514664547;5241.213817927303;5248.501392367719;5253.7373131343475;5050.494950504938;5110.897782044375;5144.717040562768;5215.348081489814;5220.4779522047875;5171.534561889411;5178.14560597501;5187.8184263550975;5189.532942035197;5189.714565698885;5082.517160869711;5084.237364395333;5084.669496482717;5095.515925987025;5149.227615857614;5770.480656740871;5773.364929857712;5790.13148027795;5800.448957349087;5849.707514624251;6117.357677443893;6130.948521380046;6137.4509353495005;6144.0783882417545;6236.906446403307;6222.533310001768;6234.906476402857;6249.343818898996;6300.275468321156;6315.052742088677;5718.828435146994;5831.096180092092;5844.386339434298;5847.707614619252;5888.175655408247;6215.12988181655;6291.591046582049;6403;6420.550561460746;6424.678766061678;6083.087536869505;6083.422074902877;6088.817335479943;6108.7861924833305;6125.479643195349;6253.6560489173535;6255.655938923403;6266.154069200691;6271.905921411182;6273.7176827042895;6190.876182476325;6225.3774622537385;6245.406686364788;6247.875042499125;6251.687415629201;6112.2970858351855;6129.05316799051;6140.228185505611;6238.344973777779;6264.874702505925;4841.806327746851;4860.80556777732;4862.562369386772;4866.659333846667;4870.318155458239;4265.658747300208;4266.168097221012;4268.146370725867;4272.252355837716;4303.806328715215;5884.735186916599;5885.382034886361;5934.554908381889;5940.495057920125;5941.970290148522;6142.078688196806;6163.907541386883;6175.042868355322;6270.717817698214;6278.340774218641;5947.167396564484;5959.731812068468;5962.4633782959745;5963.284405871236;5998.610090344114;5500.697461639568;5501.779928802803;5502.064649009678;5509.00837849191;5509.035918714209;6331.271903731038;6365.458935990493;6445.1943507061615;6565.671716414065;6628.900566491507;6286.811395657955;6299.464545513682;6326.462250708557;6339.936600634119;6343.5876668016435;6408.391202835724;6486.610803351814;6491.870162596627;6583.0454584086;6645.435138013323;6161.44546990773;6218.471429928326;6226.5641405101205;6227.501799856092;6229.065640154013;6094.924532418307;6145.709401025656;6172.753089876354;6246.718897649525;6268.874622507616;6118.43644382056;6141.232345956755;6154.9384506154365;6155.630662160284;6164.106204600397;6090.348809980562;6128.930927367261;6130.734471166852;6145.10895920098;6149.938500614937;5976.790812321722;6059.575829691879;6066.787662431793;6112.625067133324;6129.526413748002;6150.077488376779;6167.259928808392;6175.135481032748;6175.7838475654935;6177.6911154441195;5931.169636250842;5976.3127240366175;5981.312149102909;5995.070764031582;6021.7591296347655 23:01:06 INFO - PID 20657 | |1;ext.html;619.108483783352;673.8854394752892;690.39935256327;1111.4998250787144;1132.4677401621236;30439.847800760992;35576.64423355766;38481.23037539248;38555.42166867499;38678.806605967;40208.19583608326;40535.79732101336;40614;40676;40744.79627601865;5602.327720673525;7195.676194571244;7347.302006309392;7351.816204594901;7352.889706654404;5696.943030569682;7177.6770045348085;7352.963235183816;7354.926450735477;7354.926450735505;7423.369013633847;7443.739469118582;7472.66373013213;7482.700691972314;7484.438667099962;5593.328800543961;7401.70393184272;7445.925540744604;7447.106347238312;7447.702091916317;5685.260916080883;7171.964140179266;7323.816904577375;7326.3040011198855;7327.487075904689;35176;35251.64748352535;35263.29473410543;35311.4703279451;35527.467087993704;3463.203463203452;3499.91250218744;3504.667056629616;3508.08789714676;3508.5263489428858;27752.167434976982;27813;27884;28004.719952800417;28046;3811.942820857689;3826.3877779555414;3850.133719912997;3859.4017927221043;3859.787711675857;190553;190676;190924;191070;191299;47512.7624361876;47541.86061627235;47878;47889;48042;49555.75222123938;49618.751906240235;49949.25076123861;50022.499775002514;50081.74959125181;13902.374393152333;13986.230757308445;13997.580072597635;14008.789868151986;14041.648958775908;9995.800083998425;10200.4389758564;11188.496517656726;11207.775844483065;11226.719332016764;11647.708807279885;11701.2979221247;11909.22590031645;11970.640880773592;11981.88018119825;4943.876403089952;4952.653314267966;4985.401751789808;5029.7736601853;5068.619853511002;1046.3460337289193;1105.2318638546294;1115.6485707002269;1119.9664010079712;1133.5182547417314;26037.479250415265;26071.739282607312;26107.347316317246;26138.477230455286;26168.476630467663;1201.7956947318976;1210.661014915825;1217;1218.2933898338943;1227.5642147037852;13224;13532.188068715908;13570.660733481545;13733.381997810122;13742.106763060368;235009;235684;236098;236498;237364;51331.48668513267;51411.742941285804;51434;51464.48535514597;51476.742616286676;1486.6877955629222;1506.5103841251419;1536.0860288128545;1544.274191130167;1568.3021055630136;23994.160204392763;25025.249242522754;25155.24534263975;25340.87329563414;25418.491630167664;37186.814065929495;37215;37215.62784372122;37233.25533489261;37296.25407491889;209851;210005;210196;210351;210728;29156.854215728785;32280.515792262664;32459.513107302937;32497.83751081324;32525.349493009533;36487.81756091202;37935.62064379321;38481.6151838478;39484.012899677735;39721.80139099286;27228.591571126846;27958.580621291105;30014.399712006074;30432;30906;30279.848600756854;30891.382172356876;30998.535021975138;31691.52462713107;31698;36242.8187859059;36429.27141457103;36448.63551364453;36462.088447789014;36471.63528364788;28801;31451;32031;32128.839355803073;32300.67699322977;24217.887007852565;25879.22362329133;26619.467610648066;26849.731502685503;26919.461610767285 23:01:06 INFO - PID 20657 | |2;jquery.html;431.79529113772577;434.9195398851215;441.52977079410425;453.77991674038094;455.148871610089;18813.905930470362;19834.801651983475;20489.590208195827;20654.586908261826;20687.379378618647;20667.483312917186;22387.44031399216;22634;22708.318750437513;23259.534809303845;5689.089745640708;5796.159556864252;5804.419558044183;5804.622699524539;5813.418658134174;5588.686658635238;5617.4382561743905;5646.153077038456;5683.971580142114;5685.744141513642;5627.521660658849;5645.774169033234;5654.434556544354;5660.518855897254;5662.37713851476;5494.230807686927;5655.8586035349235;5673.461021202979;5683.914741278884;5686.317641882959;4985.725785081855;5156.071907056728;5170.767315470775;5178.948210517884;5180.041692286939;25811;25975.870120649466;26500;26730.198094057014;26977.865110674516;2091.288961752996;2161.135545781684;2165.1231251343074;2196.6595177747477;2198.8900554972347;17133.22900469482;17440.215190316467;17692.292308307653;17710.55723606907;17882.10589470521;2107.6417009108336;2208.6797414374987;2238.362066810951;2269.296518079384;2278.0659929428853;109113.17981381714;113296;115046;119140;120698;12089.939550302191;12118.272903625635;12144.453499592539;12523.812142817866;12539.623811285675;17815.376461823773;17853.107344632976;17855.196516156804;17863.821361786475;17882.5529361767;8874.955625221832;8956;9210.907890921006;9260.629574817067;9266.490343031199;8467.703630372907;8611.268042216481;8617.827643447095;8968.417052891542;8991.235744961752;7940.761777146695;7950.880736788953;8045.316148127357;8175.550344731097;8176.713815016565;2095.371388583419;2145.903434345458;2160.2655097267007;2236.3961730333044;2355.8939847706893;1022.6574097677361;1038.6416686243233;1056.8626078609884;1067.0769784136667;1071.212658695858;19039.333623323393;20751.377458676263;20876.895615521826;21060.789392106188;21119.577608447744;1056.1603525197486;1060.6977011551826;1076.1337123615408;1077.5312738958578;1092.464692300767;10773.24587278883;11190.799186051107;11218;11247.493862776031;11277.661670149908;491666;493947;499182;504431;507414;97008;97670.51164744131;98944;100285.49857250814;102548.48725756473;1177.4289469607234;1195.3784032303154;1215.3072748533427;1236.5795629486017;1237.0536539547254;16723.163841808106;16962.66074678475;17299;20625.865577393386;22315.665265020714;47966.52033479621;48653;48870.75564622154;49437;49572;59600.70199648974;60023;61050.69474652598;61275;61676.1407666271;9244.029376915327;9352.939424327453;9398.577064032272;9699.854502182614;9798.118169364792;14381.92809035948;14595.27023648792;15012.774808377664;15579.376824926876;15727.213639317759;12233.69415764613;12308.692282693004;12471.5011399543;12587.496500139892;12760.489580416679;12143.089268304735;12242.020638348733;12463.439145238304;12464.376781161087;12568.308743018855;13243.66890827737;13505.797413039008;13505.864941350854;13686.110402823784;13728.519501817389;9486.95256523713;9490.335676502855;9660.178884794872;9710.368826026286;10040.246981476272;12681.23912565249;12681.429335679732;12701.872981270439;12943.288119153536;13298.667533311746 23:01:06 INFO - PID 20657 | |3;mootools.html;1216.8661447240797;1374.725054989002;1411.4565892131527;1426.700392917488;1438.2521089033698;9863.358881672686;11347.092232621391;11947.701307467318;12029.939850300758;12038.398080095982;11664.941675291633;11761.470733816977;11779.646610601696;11780.116491263168;11781.057515398768;2030.3198428526462;2380.928572142834;2419.516096780651;2420.6732091167733;2421.249412682065;2013.0538646835964;2262.9321120366335;2321.419645088728;2332.6850875131895;2337.228714524203;2312.8034117099983;2336.707911511061;2345.9178928737497;2365.420471984358;2367.573836709392;2256.4584499720113;2257.322803159054;2265.9660105098437;2268.0474200835606;2271.46620544172;2227.6992605998144;2291.4385975436126;2297.5864344417996;2300.3214051854743;2301.4476525633727;10753.462326883624;10831.404272764994;10842.295250808751;11191.66425007251;11469.426528673534;6285.654289014103;6470.514711396664;6482.57863238888;6496.707648155844;6503.479721622259;3799.715021373408;3804.524434445694;3854.9784307158625;3949.5063117110362;3987.940180897289;1350.1089281074542;1368.6167872995477;1373.9313034348243;1391.742527632381;1449.1812126148693;16832.410865619768;16898.324067037305;16917.23872425756;16929.83070169295;16936.830631693647;5219.660722053054;5465.454527556192;5517.834464966058;5553.6390134641115;5636.746346414421;14577;14612.853871461362;14618.049826761226;14618.122912625064;14629.487967921072;6444.097826304321;6519.706613202323;6539.574927629689;6549.181352330958;6562.868742625216;5871.794487193013;5970.910436343458;6007.519398448114;6027.578069535178;6096.69516524172;4120.423140760296;4245.257080011047;4270.252705776476;4279.144171165717;4299.6775241856985;1188.488949751615;1197.5449329254827;1199.7960346741074;1203.1577895473204;1209.1535924852462;860.8192279621225;862.4738909265343;866.328595338605;876.1238761238761;907.6369452219166;6246.906296405557;6253.78111766086;6261.906071408933;6302.873942521124;6438.871222575523;650.0996120373317;653.9967300163469;945.4988855906381;973.9415635061778;984.0946329376991;4422.469303683579;4557.45310562728;4610.147122782296;4737.218358970731;4783.378160839069;15215.163166025754;15252.313645885963;15607.765883511756;15722.13528255934;15754.842451575338;14439;15042.247887605576;15080.095194288378;15124.621884452978;15453.613659658598;9301.395409298373;9443.763905902408;9454.385464944618;9485.383450075724;9532.618695252113;6894.13823272091;7239.420846332386;7261.564306141649;7306.123265208209;7378.926210737824;13473.124246923919;13501.189928604315;13616.727665446833;13696.246706431242;13837.238951857342;12258.509659613515;13875.51435699786;13966.371513281723;14085.859141408864;14100.36548355306;8705;9557.474338911426;9784;9841.163501102486;9861.211103111877;11076.889231107585;11153.83269250978;11204.383758893013;11248.437578121226;11266.718332041437;9089.954550227207;9499.762505937408;9569.138777510057;9623.374480658735;9705;9362.578683959102;9374;9376.390534615228;9424.858627120462;9556.617735290789;8060.234277743605;8063.838723225385;8106.959465202636;8189.754307370788;8201.179882011751;6215.627062376272;6232.626042437469;6247.5001999840815;6292.2449306081735;6546.869062618625;6298.590591611531;6310.400511951358;6430.131932189094;6607.636579988147;6630.403263706289 23:01:06 INFO - PID 20657 | |4;prototype.html;389.3711655676084;400.70147739933736;420.61303600687376;421.41002596365087;424.1897974868001;5520.261117747917;5704.942950570493;5811.564132690044;5813.825585232445;5835.811570661002;5582.91625625615;5742.913856292149;5764.221830052941;5772.913406298899;5779.653220806744;4536;4567.680262381627;4572.40558727365;4577.107464044496;4596.563326483995;4270.893227669302;4579.748113853737;4584.266517357223;4588.678792484528;4627.329037289608;4554.863354099382;4565.634749220071;4567.743870435624;4568.680192386534;4581.312803079548;4575.313702944552;4585.128825523157;4587.243104887706;4591.79336929839;4601.28680054592;4086.9182616347507;4188.392683060939;4199.202151591188;4209.936850947238;4217.683673724452;5655;5678.801241956512;5683.772649094031;5686.687232202227;5699.401562835884;5466.453354664542;5481.451854814487;5484.91772623411;5492.450754924515;5512.779488820443;5940.37626049263;6178.165947597106;6193.411625895533;6203.131561581382;6219.844503887439;4730.929036064462;4736.668433209677;4745.16959532084;4746.477887432379;4763.476017638057;6386.07401926718;6404.583702059351;6425.068365087083;6471.288158302583;6494.83093043252;4905.730184839868;4905.730184839868;4909.288153217834;4920.892799120241;4929.630277729113;4936.160852655057;4964.429090654548;4986.576141028053;4986.675866068694;4992.126377883856;5309.2301616266195;5406.297181366397;5468.058839112137;5471.7264136793;5485.259489968803;5946.137810017523;6204.472619827275;6212.4408803207925;6212.875742485125;6213.906791398133;1645.7366821308772;1663.1268583993258;1712.2380540659535;1718.8195239499923;1721.3803030908862;1193.6061099837034;1234.6851552853964;1238.8231180378677;1252.3362617812575;1257.5158563952943;5841.678707671034;5846.41535846412;5869.647821130746;5869.853253668693;5890.293164820249;6251.9687401563615;6292.2134733158355;6314.273858506239;6317.842053948688;6318.210223722035;5708.429157084258;5829.446202610745;5891.970540147272;5930.436608522184;5944.3164036136395;3308.2135646750485;3334.6494669658828;3340.916477088092;3346.54821599081;3348.263382055944;6501.4148726613885;6561.179852518435;6561.639109849004;6612.8346791330605;6614.776266390733;6431;6445.388652836791;6447.0672889537345;6463.547551671338;6464.25661048976;6303.2751233607805;6528.575642583217;6581.716565269727;6587.176602924635;6615.867682646416;6253.124562561154;6263.592866463665;6277.457629659995;6295.559310848196;6314.210723659543;6152.969235153795;6200.81397558074;6213.502919766498;6219.657918814509;6226.782062627786;6545.672716364258;6602.504812139205;6629.171353580802;6632.867342653023;6642.6014439133805;4880.365552478155;4880.804767809248;4916.852494425173;4917.819853124815;4918.114689395481;6003.3996600339615;6184.969075154595;6202.7829025985675;6260.499160067275;6317.273513546001;5968.253968253968;6184.350643182401;6190.7523699051535;6199.318075011835;6215.316315205414;6007.158997740233;6062.242219722535;6159.938400615936;6161.260648722182;6181.794550062695;6162.168107305456;6175.135481032569;6208.72060757258;6220.875582488416;6229.159063526366;6147.508199344131;6192.553941193293;6229;6229.657368844757;6250.843728906813;5920.348761636303;5945.524358051259;5956.225690660186;5994.910076348771;6029.186059881859 23:01:06 INFO - PID 20657 | |5;yui.html;827.3009307135468;861.9525926074066;869.1265278395211;873.3406278259916;875.6935072724547;16572;16687.16564171791;17192.312307507684;17272.654546909056;17273.04998225097;16780.748288775678;16992.708872863477;17106.657866842655;17130;17143.14284285787;981.7103954333471;989.5942663507964;999.6601155607092;1000.024975648744;1000.3197825478671;1015.0914931136629;1022.9693109206736;1023.1558963854812;1024.1550720655453;1024.2676486312284;1054.0987455725322;1056.7410984308856;1056.9365838049703;1057.4659796802605;1061.2147011211725;1045.5660900726189;1047.282611411182;1048.6906362623006;1048.8007278617115;1049.1030169205335;770.768769369187;773.6402572803673;775.0196002057402;775.3758224629171;778.2334400615389;14703.92648036753;14726.558203253919;14932.776008359884;15742.68514629701;15929.123898185595;14229.501967431193;14233.074850134812;14527.927360363235;14565.6358591035;14755.409783608642;13460.326983650877;13615.863841361559;13657.658558536017;13658.863411365957;13989.3704783285;5377.193420986883;5389.164679474688;5392.433794451605;5397.8380648580605;5398.163284690879;91039.54480227556;97102;98894.07741458101;99164.0083599162;99421;14143;14164.504242351675;14170.22063786481;14555.41778328855;14942.775858362133;25749.871250643628;25775.48449031009;26478.470430591282;26483.821941367158;26535;8596.570171491401;8666.523341216294;8738.432001919855;8785.34109941757;8785.736427907173;4036.798160091984;4149.792510374529;4170.145120250341;4184.476940382452;4199.790010499462;4460.1971645104195;4501.48232953208;4526.23054080807;4549.181147393435;4549.567791059844;873.5108339329995;905.1536813079791;907.981840363189;916.5325683901258;918.4397517514311;720.1538192623751;733.9119305683353;744.5904752386166;764.9885251721229;776.8679324514846;11186.38474883873;12568.428946381702;13006.609801705965;13260.403281852146;13275.468981240836;734.4051318432087;736.9926300736925;738.2949283434415;749.2732049911577;757.1330826204075;5156.355455568054;5387.164989426645;5389.8113566025;5414.29614150158;5447.101228297287;74475;76053;80348;81737.59131204306;85063.57468212744;71784;73194;74362;78983;79798;64665;70575;72353.63823180851;73773.26226737771;74902;12316.445759940645;12795.744085118431;13006.349682515647;13033.869661303645;13137.715571107223;33579.49630755492;33745.493817592265;33882.83058584691;34117.97646070622;35457;55925;56124.978841614895;56303.15545266906;57232.13839308101;57493.42506574881;17128.486145415656;17260.482185534453;17282.926048874215;17284.135793210036;17303.3943811966;18232.45302640923;18739.812601873808;18872.24511019599;18881.90559047196;19089.140988655265;15886.9673471224;15953.8404615957;16018.119003454922;16394.672106558042;16475.752863706814;17146.657066858344;17165.828341716424;17170.484885453458;17366;17443.738343924597;16664.083475408483;16986.830131698523;17109;17487.300507979537;17692.557686057953;11034.724131896766;11196.272242304223;11214.83177752318;11473.196876218584;11628;14680.486182983972;14715.190664513555;15127.16800575979;15197.392104315704;15240 23:01:06 INFO - PID 20657 | __end_tp_report 23:01:06 INFO - PID 20657 | __start_cc_report 23:01:06 INFO - PID 20657 | _x_x_mozilla_cycle_collect,1176 23:01:06 INFO - PID 20657 | __end_cc_report 23:01:06 INFO - PID 20657 | __startTimestamp1494568866638__endTimestamp 23:01:06 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | ------- Summary: start ------- 23:01:06 INFO - PID 20657 | Number of tests: 6 23:01:06 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | [#0] dojo.html Cycles:165 Average:5777.58 Median:6066.79 stddev:680.63 (11.2%) stddev-sans-first:654.76 23:01:06 INFO - PID 20657 | Values: 3316.1 3318.1 3329.6 3336.4 3369.2 5594.7 5696.2 5773.7 5799.3 5814.2 5759.8 5785.8 5792.2 5855.2 5856.1 4697.9 5012.1 5108.0 5149.3 5206.8 5167.9 5182.8 5241.2 5248.5 5253.7 5050.5 5110.9 5144.7 5215.3 5220.5 5171.5 5178.1 5187.8 5189.5 5189.7 5082.5 5084.2 5084.7 5095.5 5149.2 5770.5 5773.4 5790.1 5800.4 5849.7 6117.4 6130.9 6137.5 6144.1 6236.9 6222.5 6234.9 6249.3 6300.3 6315.1 5718.8 5831.1 5844.4 5847.7 5888.2 6215.1 6291.6 6403.0 6420.6 6424.7 6083.1 6083.4 6088.8 6108.8 6125.5 6253.7 6255.7 6266.2 6271.9 6273.7 6190.9 6225.4 6245.4 6247.9 6251.7 6112.3 6129.1 6140.2 6238.3 6264.9 4841.8 4860.8 4862.6 4866.7 4870.3 4265.7 4266.2 4268.1 4272.3 4303.8 5884.7 5885.4 5934.6 5940.5 5942.0 6142.1 6163.9 6175.0 6270.7 6278.3 5947.2 5959.7 5962.5 5963.3 5998.6 5500.7 5501.8 5502.1 5509.0 5509.0 6331.3 6365.5 6445.2 6565.7 6628.9 6286.8 6299.5 6326.5 6339.9 6343.6 6408.4 6486.6 6491.9 6583.0 6645.4 6161.4 6218.5 6226.6 6227.5 6229.1 6094.9 6145.7 6172.8 6246.7 6268.9 6118.4 6141.2 6154.9 6155.6 6164.1 6090.3 6128.9 6130.7 6145.1 6149.9 5976.8 6059.6 6066.8 6112.6 6129.5 6150.1 6167.3 6175.1 6175.8 6177.7 5931.2 5976.3 5981.3 5995.1 6021.8 23:01:06 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | [#1] ext.html Cycles:180 Average:37273.42 Median:32511.59 stddev:55367.01 (170.3%) stddev-sans-first:55453.92 23:01:06 INFO - PID 20657 | Values: 619.1 673.9 690.4 1111.5 1132.5 30439.8 35576.6 38481.2 38555.4 38678.8 40208.2 40535.8 40614.0 40676.0 40744.8 5602.3 7195.7 7347.3 7351.8 7352.9 5696.9 7177.7 7353.0 7354.9 7354.9 7423.4 7443.7 7472.7 7482.7 7484.4 5593.3 7401.7 7445.9 7447.1 7447.7 5685.3 7172.0 7323.8 7326.3 7327.5 35176.0 35251.6 35263.3 35311.5 35527.5 3463.2 3499.9 3504.7 3508.1 3508.5 27752.2 27813.0 27884.0 28004.7 28046.0 3811.9 3826.4 3850.1 3859.4 3859.8 190553.0 190676.0 190924.0 191070.0 191299.0 47512.8 47541.9 47878.0 47889.0 48042.0 49555.8 49618.8 49949.3 50022.5 50081.7 13902.4 13986.2 13997.6 14008.8 14041.6 9995.8 10200.4 11188.5 11207.8 11226.7 11647.7 11701.3 11909.2 11970.6 11981.9 4943.9 4952.7 4985.4 5029.8 5068.6 1046.3 1105.2 1115.6 1120.0 1133.5 26037.5 26071.7 26107.3 26138.5 26168.5 1201.8 1210.7 1217.0 1218.3 1227.6 13224.0 13532.2 13570.7 13733.4 13742.1 235009.0 235684.0 236098.0 236498.0 237364.0 51331.5 51411.7 51434.0 51464.5 51476.7 1486.7 1506.5 1536.1 1544.3 1568.3 23994.2 25025.2 25155.2 25340.9 25418.5 37186.8 37215.0 37215.6 37233.3 37296.3 209851.0 210005.0 210196.0 210351.0 210728.0 29156.9 32280.5 32459.5 32497.8 32525.3 36487.8 37935.6 38481.6 39484.0 39721.8 27228.6 27958.6 30014.4 30432.0 30906.0 30279.8 30891.4 30998.5 31691.5 31698.0 36242.8 36429.3 36448.6 36462.1 36471.6 28801.0 31451.0 32031.0 32128.8 32300.7 24217.9 25879.2 26619.5 26849.7 26919.5 23:01:06 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | [#2] jquery.html Cycles:180 Average:31675.77 Median:2197.77 stddev:83110.90 (3781.6%) stddev-sans-first:83310.94 23:01:06 INFO - PID 20657 | Values: 431.8 434.9 441.5 453.8 455.1 18813.9 19834.8 20489.6 20654.6 20687.4 20667.5 22387.4 22634.0 22708.3 23259.5 5689.1 5796.2 5804.4 5804.6 5813.4 5588.7 5617.4 5646.2 5684.0 5685.7 5627.5 5645.8 5654.4 5660.5 5662.4 5494.2 5655.9 5673.5 5683.9 5686.3 4985.7 5156.1 5170.8 5178.9 5180.0 25811.0 25975.9 26500.0 26730.2 26977.9 2091.3 2161.1 2165.1 2196.7 2198.9 17133.2 17440.2 17692.3 17710.6 17882.1 2107.6 2208.7 2238.4 2269.3 2278.1 109113.2 113296.0 115046.0 119140.0 120698.0 12089.9 12118.3 12144.5 12523.8 12539.6 17815.4 17853.1 17855.2 17863.8 17882.6 8875.0 8956.0 9210.9 9260.6 9266.5 8467.7 8611.3 8617.8 8968.4 8991.2 7940.8 7950.9 8045.3 8175.6 8176.7 2095.4 2145.9 2160.3 2236.4 2355.9 1022.7 1038.6 1056.9 1067.1 1071.2 19039.3 20751.4 20876.9 21060.8 21119.6 1056.2 1060.7 1076.1 1077.5 1092.5 10773.2 11190.8 11218.0 11247.5 11277.7 491666.0 493947.0 499182.0 504431.0 507414.0 97008.0 97670.5 98944.0 100285.5 102548.5 1177.4 1195.4 1215.3 1236.6 1237.1 16723.2 16962.7 17299.0 20625.9 22315.7 47966.5 48653.0 48870.8 49437.0 49572.0 59600.7 60023.0 61050.7 61275.0 61676.1 9244.0 9352.9 9398.6 9699.9 9798.1 14381.9 14595.3 15012.8 15579.4 15727.2 12233.7 12308.7 12471.5 12587.5 12760.5 12143.1 12242.0 12463.4 12464.4 12568.3 13243.7 13505.8 13505.9 13686.1 13728.5 9487.0 9490.3 9660.2 9710.4 10040.2 12681.2 12681.4 12701.9 12943.3 13298.7 23:01:06 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | [#3] mootools.html Cycles:180 Average:7261.13 Median:3829.75 stddev:4707.83 (122.9%) stddev-sans-first:4699.13 23:01:06 INFO - PID 20657 | Values: 1216.9 1374.7 1411.5 1426.7 1438.3 9863.4 11347.1 11947.7 12029.9 12038.4 11664.9 11761.5 11779.6 11780.1 11781.1 2030.3 2380.9 2419.5 2420.7 2421.2 2013.1 2262.9 2321.4 2332.7 2337.2 2312.8 2336.7 2345.9 2365.4 2367.6 2256.5 2257.3 2266.0 2268.0 2271.5 2227.7 2291.4 2297.6 2300.3 2301.4 10753.5 10831.4 10842.3 11191.7 11469.4 6285.7 6470.5 6482.6 6496.7 6503.5 3799.7 3804.5 3855.0 3949.5 3987.9 1350.1 1368.6 1373.9 1391.7 1449.2 16832.4 16898.3 16917.2 16929.8 16936.8 5219.7 5465.5 5517.8 5553.6 5636.7 14577.0 14612.9 14618.0 14618.1 14629.5 6444.1 6519.7 6539.6 6549.2 6562.9 5871.8 5970.9 6007.5 6027.6 6096.7 4120.4 4245.3 4270.3 4279.1 4299.7 1188.5 1197.5 1199.8 1203.2 1209.2 860.8 862.5 866.3 876.1 907.6 6246.9 6253.8 6261.9 6302.9 6438.9 650.1 654.0 945.5 973.9 984.1 4422.5 4557.5 4610.1 4737.2 4783.4 15215.2 15252.3 15607.8 15722.1 15754.8 14439.0 15042.2 15080.1 15124.6 15453.6 9301.4 9443.8 9454.4 9485.4 9532.6 6894.1 7239.4 7261.6 7306.1 7378.9 13473.1 13501.2 13616.7 13696.2 13837.2 12258.5 13875.5 13966.4 14085.9 14100.4 8705.0 9557.5 9784.0 9841.2 9861.2 11076.9 11153.8 11204.4 11248.4 11266.7 9090.0 9499.8 9569.1 9623.4 9705.0 9362.6 9374.0 9376.4 9424.9 9556.6 8060.2 8063.8 8107.0 8189.8 8201.2 6215.6 6232.6 6247.5 6292.2 6546.9 6298.6 6310.4 6430.1 6607.6 6630.4 23:01:06 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | [#4] prototype.html Cycles:180 Average:5248.58 Median:5832.63 stddev:1481.86 (25.4%) stddev-sans-first:1440.44 23:01:06 INFO - PID 20657 | Values: 389.4 400.7 420.6 421.4 424.2 5520.3 5704.9 5811.6 5813.8 5835.8 5582.9 5742.9 5764.2 5772.9 5779.7 4536.0 4567.7 4572.4 4577.1 4596.6 4270.9 4579.7 4584.3 4588.7 4627.3 4554.9 4565.6 4567.7 4568.7 4581.3 4575.3 4585.1 4587.2 4591.8 4601.3 4086.9 4188.4 4199.2 4209.9 4217.7 5655.0 5678.8 5683.8 5686.7 5699.4 5466.5 5481.5 5484.9 5492.5 5512.8 5940.4 6178.2 6193.4 6203.1 6219.8 4730.9 4736.7 4745.2 4746.5 4763.5 6386.1 6404.6 6425.1 6471.3 6494.8 4905.7 4905.7 4909.3 4920.9 4929.6 4936.2 4964.4 4986.6 4986.7 4992.1 5309.2 5406.3 5468.1 5471.7 5485.3 5946.1 6204.5 6212.4 6212.9 6213.9 1645.7 1663.1 1712.2 1718.8 1721.4 1193.6 1234.7 1238.8 1252.3 1257.5 5841.7 5846.4 5869.6 5869.9 5890.3 6252.0 6292.2 6314.3 6317.8 6318.2 5708.4 5829.4 5892.0 5930.4 5944.3 3308.2 3334.6 3340.9 3346.5 3348.3 6501.4 6561.2 6561.6 6612.8 6614.8 6431.0 6445.4 6447.1 6463.5 6464.3 6303.3 6528.6 6581.7 6587.2 6615.9 6253.1 6263.6 6277.5 6295.6 6314.2 6153.0 6200.8 6213.5 6219.7 6226.8 6545.7 6602.5 6629.2 6632.9 6642.6 4880.4 4880.8 4916.9 4917.8 4918.1 6003.4 6185.0 6202.8 6260.5 6317.3 5968.3 6184.4 6190.8 6199.3 6215.3 6007.2 6062.2 6159.9 6161.3 6181.8 6162.2 6175.1 6208.7 6220.9 6229.2 6147.5 6192.6 6229.0 6229.7 6250.8 5920.3 5945.5 5956.2 5994.9 6029.2 23:01:06 INFO - PID 20657 | 23:01:06 INFO - PID 20657 | [#5] yui.html Cycles:180 Average:19638.74 Median:18985.52 stddev:24537.19 (129.2%) stddev-sans-first:24565.36 23:01:06 INFO - PID 20657 | Values: 827.3 862.0 869.1 873.3 875.7 16572.0 16687.2 17192.3 17272.7 17273.0 16780.7 16992.7 17106.7 17130.0 17143.1 981.7 989.6 999.7 1000.0 1000.3 1015.1 1023.0 1023.2 1024.2 1024.3 1054.1 1056.7 1056.9 1057.5 1061.2 1045.6 1047.3 1048.7 1048.8 1049.1 770.8 773.6 775.0 775.4 778.2 14703.9 14726.6 14932.8 15742.7 15929.1 14229.5 14233.1 14527.9 14565.6 14755.4 13460.3 13615.9 13657.7 13658.9 13989.4 5377.2 5389.2 5392.4 5397.8 5398.2 91039.5 97102.0 98894.1 99164.0 99421.0 14143.0 14164.5 14170.2 14555.4 14942.8 25749.9 25775.5 26478.5 26483.8 26535.0 8596.6 8666.5 8738.4 8785.3 8785.7 4036.8 4149.8 4170.1 4184.5 4199.8 4460.2 4501.5 4526.2 4549.2 4549.6 873.5 905.2 908.0 916.5 918.4 720.2 733.9 744.6 765.0 776.9 11186.4 12568.4 13006.6 13260.4 13275.5 734.4 737.0 738.3 749.3 757.1 5156.4 5387.2 5389.8 5414.3 5447.1 74475.0 76053.0 80348.0 81737.6 85063.6 71784.0 73194.0 74362.0 78983.0 79798.0 64665.0 70575.0 72353.6 73773.3 74902.0 12316.4 12795.7 13006.3 13033.9 13137.7 33579.5 33745.5 33882.8 34118.0 35457.0 55925.0 56125.0 56303.2 57232.1 57493.4 17128.5 17260.5 17282.9 17284.1 17303.4 18232.5 18739.8 18872.2 18881.9 19089.1 15887.0 15953.8 16018.1 16394.7 16475.8 17146.7 17165.8 17170.5 17366.0 17443.7 16664.1 16986.8 17109.0 17487.3 17692.6 11034.7 11196.3 11214.8 11473.2 11628.0 14680.5 14715.2 15127.2 15197.4 15240.0 23:01:06 INFO - PID 20657 | -------- Summary: end -------- 23:01:06 INFO - PID 20657 | 23:01:07 INFO - TEST-INFO | 20657: exit 0 23:01:07 INFO - TEST-OK | dromaeo_css | took 1115618ms 23:01:07 INFO - TEST-START | kraken 23:01:07 INFO - operating with platform_type : linux_ 23:01:07 INFO - Initialising browser for kraken test... 23:01:07 INFO - TEST-INFO | started process 20988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp81X5t5/profile http://localhost:47146/getInfo.html) 23:01:11 INFO - PID 20988 | __metrics Screen width/height:1600/1200 23:01:11 INFO - PID 20988 | colorDepth:24 23:01:11 INFO - PID 20988 | Browser inner width/height: 1024/695 23:01:11 INFO - PID 20988 | __metrics 23:01:12 INFO - PID 20988 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:01:12 INFO - PID 20988 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:01:13 INFO - TEST-INFO | 20988: exit 0 23:01:13 INFO - Browser initialized. 23:01:13 INFO - Running cycle 1/1 for kraken test... 23:01:13 INFO - TEST-INFO | started process 21089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp81X5t5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:25 INFO - PID 21089 | RSS: Main: 144416768 23:01:25 INFO - PID 21089 | 23:01:27 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47146/tests/kraken/driver.html?testName=audio-beat-detection) 23:01:28 INFO - PID 21089 | RSS: Main: 216911872 23:01:28 INFO - PID 21089 | 23:01:31 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47146/tests/kraken/driver.html?testName=audio-dft) 23:01:31 INFO - PID 21089 | RSS: Main: 179126272 23:01:31 INFO - PID 21089 | 23:01:34 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47146/tests/kraken/driver.html?testName=audio-fft) 23:01:35 INFO - PID 21089 | RSS: Main: 259448832 23:01:35 INFO - PID 21089 | 23:01:37 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47146/tests/kraken/driver.html?testName=audio-oscillator) 23:01:37 INFO - PID 21089 | RSS: Main: 170283008 23:01:37 INFO - PID 21089 | 23:01:39 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47146/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:01:40 INFO - PID 21089 | RSS: Main: 173424640 23:01:40 INFO - PID 21089 | 23:01:43 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47146/tests/kraken/driver.html?testName=imaging-darkroom) 23:01:44 INFO - PID 21089 | RSS: Main: 234835968 23:01:44 INFO - PID 21089 | 23:01:47 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47146/tests/kraken/driver.html?testName=imaging-desaturate) 23:01:48 INFO - PID 21089 | RSS: Main: 246468608 23:01:48 INFO - PID 21089 | 23:01:50 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47146/tests/kraken/driver.html?testName=json-parse-financial) 23:01:51 INFO - PID 21089 | RSS: Main: 253399040 23:01:51 INFO - PID 21089 | 23:01:52 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47146/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:01:53 INFO - PID 21089 | RSS: Main: 198488064 23:01:53 INFO - PID 21089 | 23:01:55 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47146/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:01:55 INFO - PID 21089 | RSS: Main: 202616832 23:01:55 INFO - PID 21089 | 23:01:57 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47146/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:01:58 INFO - PID 21089 | RSS: Main: 212172800 23:01:58 INFO - PID 21089 | 23:02:00 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47146/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:02:01 INFO - PID 21089 | RSS: Main: 221351936 23:02:01 INFO - PID 21089 | 23:02:04 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47146/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:02:05 INFO - PID 21089 | RSS: Main: 217055232 23:02:05 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | Cycle 1(1): loaded http://localhost:47146/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47146/tests/kraken/driver.html?testName=ai-astar) 23:02:06 INFO - PID 21089 | RSS: Main: 266883072 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | __start_tp_report 23:02:06 INFO - PID 21089 | _x_x_mozilla_page_load 23:02:06 INFO - PID 21089 | _x_x_mozilla_page_load_details 23:02:06 INFO - PID 21089 | |i|pagename|runs| 23:02:06 INFO - PID 21089 | |0;ai-astar;107;109;110;109;110;111;109;110;110;110 23:02:06 INFO - PID 21089 | |1;audio-beat-detection;150;117;116;167;116;116;117;118;136;115 23:02:06 INFO - PID 21089 | |2;audio-dft;162;160;162;161;160;161;163;161;163;163 23:02:06 INFO - PID 21089 | |3;audio-fft;73;74;74;110;74;73;74;74;95;73 23:02:06 INFO - PID 21089 | |4;audio-oscillator;85;82;102;82;82;82;94;82;82;109 23:02:06 INFO - PID 21089 | |5;imaging-gaussian-blur;113;113;112;114;113;113;113;113;113;113 23:02:06 INFO - PID 21089 | |6;imaging-darkroom;146;148;146;146;147;147;147;147;147;147 23:02:06 INFO - PID 21089 | |7;imaging-desaturate;94;94;94;94;94;95;94;94;94;94 23:02:06 INFO - PID 21089 | |8;json-parse-financial;45;46;49;45;45;47;46;48;47;47 23:02:06 INFO - PID 21089 | |9;json-stringify-tinderbox;54;54;54;54;53;54;54;54;54;53 23:02:06 INFO - PID 21089 | |10;stanford-crypto-aes;78;80;79;79;80;79;78;79;79;78 23:02:06 INFO - PID 21089 | |11;stanford-crypto-ccm;124;134;132;123;121;124;125;132;173;125 23:02:06 INFO - PID 21089 | |12;stanford-crypto-pbkdf2;182;186;183;182;173;185;181;184;188;188 23:02:06 INFO - PID 21089 | |13;stanford-crypto-sha256-iterative;66;65;66;67;64;64;63;65;66;64 23:02:06 INFO - PID 21089 | __end_tp_report 23:02:06 INFO - PID 21089 | __start_cc_report 23:02:06 INFO - PID 21089 | _x_x_mozilla_cycle_collect,1712 23:02:06 INFO - PID 21089 | __end_cc_report 23:02:06 INFO - PID 21089 | __startTimestamp1494568926940__endTimestamp 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | ------- Summary: start ------- 23:02:06 INFO - PID 21089 | Number of tests: 14 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.08 (1.0%) stddev-sans-first:0.67 23:02:06 INFO - PID 21089 | Values: 107.0 109.0 110.0 109.0 110.0 111.0 109.0 110.0 110.0 110.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:117.50 stddev:18.25 (15.5%) stddev-sans-first:17.32 23:02:06 INFO - PID 21089 | Values: 150.0 117.0 116.0 167.0 116.0 116.0 117.0 118.0 136.0 115.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 23:02:06 INFO - PID 21089 | Values: 162.0 160.0 162.0 161.0 160.0 161.0 163.0 161.0 163.0 163.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#3] audio-fft Cycles:10 Average:79.40 Median:74.00 stddev:12.69 (17.1%) stddev-sans-first:13.24 23:02:06 INFO - PID 21089 | Values: 73.0 74.0 74.0 110.0 74.0 73.0 74.0 74.0 95.0 73.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:82.00 stddev:9.99 (12.2%) stddev-sans-first:10.53 23:02:06 INFO - PID 21089 | Values: 85.0 82.0 102.0 82.0 82.0 82.0 94.0 82.0 82.0 109.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 23:02:06 INFO - PID 21089 | Values: 113.0 113.0 112.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 23:02:06 INFO - PID 21089 | Values: 146.0 148.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:02:06 INFO - PID 21089 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#8] json-parse-financial Cycles:10 Average:46.50 Median:47.00 stddev:1.35 (2.9%) stddev-sans-first:1.32 23:02:06 INFO - PID 21089 | Values: 45.0 46.0 49.0 45.0 45.0 47.0 46.0 48.0 47.0 47.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 23:02:06 INFO - PID 21089 | Values: 54.0 54.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 53.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 23:02:06 INFO - PID 21089 | Values: 78.0 80.0 79.0 79.0 80.0 79.0 78.0 79.0 79.0 78.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:128.50 stddev:15.30 (11.9%) stddev-sans-first:16.00 23:02:06 INFO - PID 21089 | Values: 124.0 134.0 132.0 123.0 121.0 124.0 125.0 132.0 173.0 125.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:184.50 stddev:4.34 (2.4%) stddev-sans-first:4.58 23:02:06 INFO - PID 21089 | Values: 182.0 186.0 183.0 182.0 173.0 185.0 181.0 184.0 188.0 188.0 23:02:06 INFO - PID 21089 | 23:02:06 INFO - PID 21089 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.27 23:02:06 INFO - PID 21089 | Values: 66.0 65.0 66.0 67.0 64.0 64.0 63.0 65.0 66.0 64.0 23:02:06 INFO - PID 21089 | -------- Summary: end -------- 23:02:06 INFO - PID 21089 | 23:02:07 INFO - TEST-INFO | 21089: exit 0 23:02:08 INFO - TEST-OK | kraken | took 60547ms 23:02:08 INFO - SUITE-END | took 1176s 23:02:08 INFO - Completed test suite (00:19:36) 23:02:08 INFO - javascript benchmark 23:02:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7724.8211581096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.137804170915, 3318.054354508965, 3329.6004479462467, 3336.399448099343, 3369.2250782320066, 5594.748236329365, 5696.202531645573, 5773.711314434272, 5799.333076696176, 5814.156947242653, 5759.82720518384, 5785.797497087603, 5792.189093526899, 5855.209546711193, 5856.121581762738, 4697.859064228079, 5012.122878496249, 5107.974460127694, 5149.2791009258735, 5206.817761378353, 5167.870803229912, 5182.844514664547, 5241.213817927303, 5248.501392367719, 5253.7373131343475, 5050.494950504938, 5110.897782044375, 5144.717040562768, 5215.348081489814, 5220.4779522047875, 5171.534561889411, 5178.14560597501, 5187.8184263550975, 5189.532942035197, 5189.714565698885, 5082.517160869711, 5084.237364395333, 5084.669496482717, 5095.515925987025, 5149.227615857614, 5770.480656740871, 5773.364929857712, 5790.13148027795, 5800.448957349087, 5849.707514624251, 6117.357677443893, 6130.948521380046, 6137.4509353495005, 6144.0783882417545, 6236.906446403307, 6222.533310001768, 6234.906476402857, 6249.343818898996, 6300.275468321156, 6315.052742088677, 5718.828435146994, 5831.096180092092, 5844.386339434298, 5847.707614619252, 5888.175655408247, 6215.12988181655, 6291.591046582049, 6403.0, 6420.550561460746, 6424.678766061678, 6083.087536869505, 6083.422074902877, 6088.817335479943, 6108.7861924833305, 6125.479643195349, 6253.6560489173535, 6255.655938923403, 6266.154069200691, 6271.905921411182, 6273.7176827042895, 6190.876182476325, 6225.3774622537385, 6245.406686364788, 6247.875042499125, 6251.687415629201, 6112.2970858351855, 6129.05316799051, 6140.228185505611, 6238.344973777779, 6264.874702505925, 4841.806327746851, 4860.80556777732, 4862.562369386772, 4866.659333846667, 4870.318155458239, 4265.658747300208, 4266.168097221012, 4268.146370725867, 4272.252355837716, 4303.806328715215, 5884.735186916599, 5885.382034886361, 5934.554908381889, 5940.495057920125, 5941.970290148522, 6142.078688196806, 6163.907541386883, 6175.042868355322, 6270.717817698214, 6278.340774218641, 5947.167396564484, 5959.731812068468, 5962.4633782959745, 5963.284405871236, 5998.610090344114, 5500.697461639568, 5501.779928802803, 5502.064649009678, 5509.00837849191, 5509.035918714209, 6331.271903731038, 6365.458935990493, 6445.1943507061615, 6565.671716414065, 6628.900566491507, 6286.811395657955, 6299.464545513682, 6326.462250708557, 6339.936600634119, 6343.5876668016435, 6408.391202835724, 6486.610803351814, 6491.870162596627, 6583.0454584086, 6645.435138013323, 6161.44546990773, 6218.471429928326, 6226.5641405101205, 6227.501799856092, 6229.065640154013, 6094.924532418307, 6145.709401025656, 6172.753089876354, 6246.718897649525, 6268.874622507616, 6118.43644382056, 6141.232345956755, 6154.9384506154365, 6155.630662160284, 6164.106204600397, 6090.348809980562, 6128.930927367261, 6130.734471166852, 6145.10895920098, 6149.938500614937, 5976.790812321722, 6059.575829691879, 6066.787662431793, 6112.625067133324, 6129.526413748002, 6150.077488376779, 6167.259928808392, 6175.135481032748, 6175.7838475654935, 6177.6911154441195, 5931.169636250842, 5976.3127240366175, 5981.312149102909, 5995.070764031582, 6021.7591296347655], "value": 5730.204797209533, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.108483783352, 673.8854394752892, 690.39935256327, 1111.4998250787144, 1132.4677401621236, 30439.847800760992, 35576.64423355766, 38481.23037539248, 38555.42166867499, 38678.806605967, 40208.19583608326, 40535.79732101336, 40614.0, 40676.0, 40744.79627601865, 5602.327720673525, 7195.676194571244, 7347.302006309392, 7351.816204594901, 7352.889706654404, 5696.943030569682, 7177.6770045348085, 7352.963235183816, 7354.926450735477, 7354.926450735505, 7423.369013633847, 7443.739469118582, 7472.66373013213, 7482.700691972314, 7484.438667099962, 5593.328800543961, 7401.70393184272, 7445.925540744604, 7447.106347238312, 7447.702091916317, 5685.260916080883, 7171.964140179266, 7323.816904577375, 7326.3040011198855, 7327.487075904689, 35176.0, 35251.64748352535, 35263.29473410543, 35311.4703279451, 35527.467087993704, 3463.203463203452, 3499.91250218744, 3504.667056629616, 3508.08789714676, 3508.5263489428858, 27752.167434976982, 27813.0, 27884.0, 28004.719952800417, 28046.0, 3811.942820857689, 3826.3877779555414, 3850.133719912997, 3859.4017927221043, 3859.787711675857, 190553.0, 190676.0, 190924.0, 191070.0, 191299.0, 47512.7624361876, 47541.86061627235, 47878.0, 47889.0, 48042.0, 49555.75222123938, 49618.751906240235, 49949.25076123861, 50022.499775002514, 50081.74959125181, 13902.374393152333, 13986.230757308445, 13997.580072597635, 14008.789868151986, 14041.648958775908, 9995.800083998425, 10200.4389758564, 11188.496517656726, 11207.775844483065, 11226.719332016764, 11647.708807279885, 11701.2979221247, 11909.22590031645, 11970.640880773592, 11981.88018119825, 4943.876403089952, 4952.653314267966, 4985.401751789808, 5029.7736601853, 5068.619853511002, 1046.3460337289193, 1105.2318638546294, 1115.6485707002269, 1119.9664010079712, 1133.5182547417314, 26037.479250415265, 26071.739282607312, 26107.347316317246, 26138.477230455286, 26168.476630467663, 1201.7956947318976, 1210.661014915825, 1217.0, 1218.2933898338943, 1227.5642147037852, 13224.0, 13532.188068715908, 13570.660733481545, 13733.381997810122, 13742.106763060368, 235009.0, 235684.0, 236098.0, 236498.0, 237364.0, 51331.48668513267, 51411.742941285804, 51434.0, 51464.48535514597, 51476.742616286676, 1486.6877955629222, 1506.5103841251419, 1536.0860288128545, 1544.274191130167, 1568.3021055630136, 23994.160204392763, 25025.249242522754, 25155.24534263975, 25340.87329563414, 25418.491630167664, 37186.814065929495, 37215.0, 37215.62784372122, 37233.25533489261, 37296.25407491889, 209851.0, 210005.0, 210196.0, 210351.0, 210728.0, 29156.854215728785, 32280.515792262664, 32459.513107302937, 32497.83751081324, 32525.349493009533, 36487.81756091202, 37935.62064379321, 38481.6151838478, 39484.012899677735, 39721.80139099286, 27228.591571126846, 27958.580621291105, 30014.399712006074, 30432.0, 30906.0, 30279.848600756854, 30891.382172356876, 30998.535021975138, 31691.52462713107, 31698.0, 36242.8187859059, 36429.27141457103, 36448.63551364453, 36462.088447789014, 36471.63528364788, 28801.0, 31451.0, 32031.0, 32128.839355803073, 32300.67699322977, 24217.887007852565, 25879.22362329133, 26619.467610648066, 26849.731502685503, 26919.461610767285], "value": 16506.939781669495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.79529113772577, 434.9195398851215, 441.52977079410425, 453.77991674038094, 455.148871610089, 18813.905930470362, 19834.801651983475, 20489.590208195827, 20654.586908261826, 20687.379378618647, 20667.483312917186, 22387.44031399216, 22634.0, 22708.318750437513, 23259.534809303845, 5689.089745640708, 5796.159556864252, 5804.419558044183, 5804.622699524539, 5813.418658134174, 5588.686658635238, 5617.4382561743905, 5646.153077038456, 5683.971580142114, 5685.744141513642, 5627.521660658849, 5645.774169033234, 5654.434556544354, 5660.518855897254, 5662.37713851476, 5494.230807686927, 5655.8586035349235, 5673.461021202979, 5683.914741278884, 5686.317641882959, 4985.725785081855, 5156.071907056728, 5170.767315470775, 5178.948210517884, 5180.041692286939, 25811.0, 25975.870120649466, 26500.0, 26730.198094057014, 26977.865110674516, 2091.288961752996, 2161.135545781684, 2165.1231251343074, 2196.6595177747477, 2198.8900554972347, 17133.22900469482, 17440.215190316467, 17692.292308307653, 17710.55723606907, 17882.10589470521, 2107.6417009108336, 2208.6797414374987, 2238.362066810951, 2269.296518079384, 2278.0659929428853, 109113.17981381714, 113296.0, 115046.0, 119140.0, 120698.0, 12089.939550302191, 12118.272903625635, 12144.453499592539, 12523.812142817866, 12539.623811285675, 17815.376461823773, 17853.107344632976, 17855.196516156804, 17863.821361786475, 17882.5529361767, 8874.955625221832, 8956.0, 9210.907890921006, 9260.629574817067, 9266.490343031199, 8467.703630372907, 8611.268042216481, 8617.827643447095, 8968.417052891542, 8991.235744961752, 7940.761777146695, 7950.880736788953, 8045.316148127357, 8175.550344731097, 8176.713815016565, 2095.371388583419, 2145.903434345458, 2160.2655097267007, 2236.3961730333044, 2355.8939847706893, 1022.6574097677361, 1038.6416686243233, 1056.8626078609884, 1067.0769784136667, 1071.212658695858, 19039.333623323393, 20751.377458676263, 20876.895615521826, 21060.789392106188, 21119.577608447744, 1056.1603525197486, 1060.6977011551826, 1076.1337123615408, 1077.5312738958578, 1092.464692300767, 10773.24587278883, 11190.799186051107, 11218.0, 11247.493862776031, 11277.661670149908, 491666.0, 493947.0, 499182.0, 504431.0, 507414.0, 97008.0, 97670.51164744131, 98944.0, 100285.49857250814, 102548.48725756473, 1177.4289469607234, 1195.3784032303154, 1215.3072748533427, 1236.5795629486017, 1237.0536539547254, 16723.163841808106, 16962.66074678475, 17299.0, 20625.865577393386, 22315.665265020714, 47966.52033479621, 48653.0, 48870.75564622154, 49437.0, 49572.0, 59600.70199648974, 60023.0, 61050.69474652598, 61275.0, 61676.1407666271, 9244.029376915327, 9352.939424327453, 9398.577064032272, 9699.854502182614, 9798.118169364792, 14381.92809035948, 14595.27023648792, 15012.774808377664, 15579.376824926876, 15727.213639317759, 12233.69415764613, 12308.692282693004, 12471.5011399543, 12587.496500139892, 12760.489580416679, 12143.089268304735, 12242.020638348733, 12463.439145238304, 12464.376781161087, 12568.308743018855, 13243.66890827737, 13505.797413039008, 13505.864941350854, 13686.110402823784, 13728.519501817389, 9486.95256523713, 9490.335676502855, 9660.178884794872, 9710.368826026286, 10040.246981476272, 12681.23912565249, 12681.429335679732, 12701.872981270439, 12943.288119153536, 13298.667533311746], "value": 10283.589604379007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.8661447240797, 1374.725054989002, 1411.4565892131527, 1426.700392917488, 1438.2521089033698, 9863.358881672686, 11347.092232621391, 11947.701307467318, 12029.939850300758, 12038.398080095982, 11664.941675291633, 11761.470733816977, 11779.646610601696, 11780.116491263168, 11781.057515398768, 2030.3198428526462, 2380.928572142834, 2419.516096780651, 2420.6732091167733, 2421.249412682065, 2013.0538646835964, 2262.9321120366335, 2321.419645088728, 2332.6850875131895, 2337.228714524203, 2312.8034117099983, 2336.707911511061, 2345.9178928737497, 2365.420471984358, 2367.573836709392, 2256.4584499720113, 2257.322803159054, 2265.9660105098437, 2268.0474200835606, 2271.46620544172, 2227.6992605998144, 2291.4385975436126, 2297.5864344417996, 2300.3214051854743, 2301.4476525633727, 10753.462326883624, 10831.404272764994, 10842.295250808751, 11191.66425007251, 11469.426528673534, 6285.654289014103, 6470.514711396664, 6482.57863238888, 6496.707648155844, 6503.479721622259, 3799.715021373408, 3804.524434445694, 3854.9784307158625, 3949.5063117110362, 3987.940180897289, 1350.1089281074542, 1368.6167872995477, 1373.9313034348243, 1391.742527632381, 1449.1812126148693, 16832.410865619768, 16898.324067037305, 16917.23872425756, 16929.83070169295, 16936.830631693647, 5219.660722053054, 5465.454527556192, 5517.834464966058, 5553.6390134641115, 5636.746346414421, 14577.0, 14612.853871461362, 14618.049826761226, 14618.122912625064, 14629.487967921072, 6444.097826304321, 6519.706613202323, 6539.574927629689, 6549.181352330958, 6562.868742625216, 5871.794487193013, 5970.910436343458, 6007.519398448114, 6027.578069535178, 6096.69516524172, 4120.423140760296, 4245.257080011047, 4270.252705776476, 4279.144171165717, 4299.6775241856985, 1188.488949751615, 1197.5449329254827, 1199.7960346741074, 1203.1577895473204, 1209.1535924852462, 860.8192279621225, 862.4738909265343, 866.328595338605, 876.1238761238761, 907.6369452219166, 6246.906296405557, 6253.78111766086, 6261.906071408933, 6302.873942521124, 6438.871222575523, 650.0996120373317, 653.9967300163469, 945.4988855906381, 973.9415635061778, 984.0946329376991, 4422.469303683579, 4557.45310562728, 4610.147122782296, 4737.218358970731, 4783.378160839069, 15215.163166025754, 15252.313645885963, 15607.765883511756, 15722.13528255934, 15754.842451575338, 14439.0, 15042.247887605576, 15080.095194288378, 15124.621884452978, 15453.613659658598, 9301.395409298373, 9443.763905902408, 9454.385464944618, 9485.383450075724, 9532.618695252113, 6894.13823272091, 7239.420846332386, 7261.564306141649, 7306.123265208209, 7378.926210737824, 13473.124246923919, 13501.189928604315, 13616.727665446833, 13696.246706431242, 13837.238951857342, 12258.509659613515, 13875.51435699786, 13966.371513281723, 14085.859141408864, 14100.36548355306, 8705.0, 9557.474338911426, 9784.0, 9841.163501102486, 9861.211103111877, 11076.889231107585, 11153.83269250978, 11204.383758893013, 11248.437578121226, 11266.718332041437, 9089.954550227207, 9499.762505937408, 9569.138777510057, 9623.374480658735, 9705.0, 9362.578683959102, 9374.0, 9376.390534615228, 9424.858627120462, 9556.617735290789, 8060.234277743605, 8063.838723225385, 8106.959465202636, 8189.754307370788, 8201.179882011751, 6215.627062376272, 6232.626042437469, 6247.5001999840815, 6292.2449306081735, 6546.869062618625, 6298.590591611531, 6310.400511951358, 6430.131932189094, 6607.636579988147, 6630.403263706289], "value": 5407.279626329692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3711655676084, 400.70147739933736, 420.61303600687376, 421.41002596365087, 424.1897974868001, 5520.261117747917, 5704.942950570493, 5811.564132690044, 5813.825585232445, 5835.811570661002, 5582.91625625615, 5742.913856292149, 5764.221830052941, 5772.913406298899, 5779.653220806744, 4536.0, 4567.680262381627, 4572.40558727365, 4577.107464044496, 4596.563326483995, 4270.893227669302, 4579.748113853737, 4584.266517357223, 4588.678792484528, 4627.329037289608, 4554.863354099382, 4565.634749220071, 4567.743870435624, 4568.680192386534, 4581.312803079548, 4575.313702944552, 4585.128825523157, 4587.243104887706, 4591.79336929839, 4601.28680054592, 4086.9182616347507, 4188.392683060939, 4199.202151591188, 4209.936850947238, 4217.683673724452, 5655.0, 5678.801241956512, 5683.772649094031, 5686.687232202227, 5699.401562835884, 5466.453354664542, 5481.451854814487, 5484.91772623411, 5492.450754924515, 5512.779488820443, 5940.37626049263, 6178.165947597106, 6193.411625895533, 6203.131561581382, 6219.844503887439, 4730.929036064462, 4736.668433209677, 4745.16959532084, 4746.477887432379, 4763.476017638057, 6386.07401926718, 6404.583702059351, 6425.068365087083, 6471.288158302583, 6494.83093043252, 4905.730184839868, 4905.730184839868, 4909.288153217834, 4920.892799120241, 4929.630277729113, 4936.160852655057, 4964.429090654548, 4986.576141028053, 4986.675866068694, 4992.126377883856, 5309.2301616266195, 5406.297181366397, 5468.058839112137, 5471.7264136793, 5485.259489968803, 5946.137810017523, 6204.472619827275, 6212.4408803207925, 6212.875742485125, 6213.906791398133, 1645.7366821308772, 1663.1268583993258, 1712.2380540659535, 1718.8195239499923, 1721.3803030908862, 1193.6061099837034, 1234.6851552853964, 1238.8231180378677, 1252.3362617812575, 1257.5158563952943, 5841.678707671034, 5846.41535846412, 5869.647821130746, 5869.853253668693, 5890.293164820249, 6251.9687401563615, 6292.2134733158355, 6314.273858506239, 6317.842053948688, 6318.210223722035, 5708.429157084258, 5829.446202610745, 5891.970540147272, 5930.436608522184, 5944.3164036136395, 3308.2135646750485, 3334.6494669658828, 3340.916477088092, 3346.54821599081, 3348.263382055944, 6501.4148726613885, 6561.179852518435, 6561.639109849004, 6612.8346791330605, 6614.776266390733, 6431.0, 6445.388652836791, 6447.0672889537345, 6463.547551671338, 6464.25661048976, 6303.2751233607805, 6528.575642583217, 6581.716565269727, 6587.176602924635, 6615.867682646416, 6253.124562561154, 6263.592866463665, 6277.457629659995, 6295.559310848196, 6314.210723659543, 6152.969235153795, 6200.81397558074, 6213.502919766498, 6219.657918814509, 6226.782062627786, 6545.672716364258, 6602.504812139205, 6629.171353580802, 6632.867342653023, 6642.6014439133805, 4880.365552478155, 4880.804767809248, 4916.852494425173, 4917.819853124815, 4918.114689395481, 6003.3996600339615, 6184.969075154595, 6202.7829025985675, 6260.499160067275, 6317.273513546001, 5968.253968253968, 6184.350643182401, 6190.7523699051535, 6199.318075011835, 6215.316315205414, 6007.158997740233, 6062.242219722535, 6159.938400615936, 6161.260648722182, 6181.794550062695, 6162.168107305456, 6175.135481032569, 6208.72060757258, 6220.875582488416, 6229.159063526366, 6147.508199344131, 6192.553941193293, 6229.0, 6229.657368844757, 6250.843728906813, 5920.348761636303, 5945.524358051259, 5956.225690660186, 5994.910076348771, 6029.186059881859], "value": 4798.665610148305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.3009307135468, 861.9525926074066, 869.1265278395211, 873.3406278259916, 875.6935072724547, 16572.0, 16687.16564171791, 17192.312307507684, 17272.654546909056, 17273.04998225097, 16780.748288775678, 16992.708872863477, 17106.657866842655, 17130.0, 17143.14284285787, 981.7103954333471, 989.5942663507964, 999.6601155607092, 1000.024975648744, 1000.3197825478671, 1015.0914931136629, 1022.9693109206736, 1023.1558963854812, 1024.1550720655453, 1024.2676486312284, 1054.0987455725322, 1056.7410984308856, 1056.9365838049703, 1057.4659796802605, 1061.2147011211725, 1045.5660900726189, 1047.282611411182, 1048.6906362623006, 1048.8007278617115, 1049.1030169205335, 770.768769369187, 773.6402572803673, 775.0196002057402, 775.3758224629171, 778.2334400615389, 14703.92648036753, 14726.558203253919, 14932.776008359884, 15742.68514629701, 15929.123898185595, 14229.501967431193, 14233.074850134812, 14527.927360363235, 14565.6358591035, 14755.409783608642, 13460.326983650877, 13615.863841361559, 13657.658558536017, 13658.863411365957, 13989.3704783285, 5377.193420986883, 5389.164679474688, 5392.433794451605, 5397.8380648580605, 5398.163284690879, 91039.54480227556, 97102.0, 98894.07741458101, 99164.0083599162, 99421.0, 14143.0, 14164.504242351675, 14170.22063786481, 14555.41778328855, 14942.775858362133, 25749.871250643628, 25775.48449031009, 26478.470430591282, 26483.821941367158, 26535.0, 8596.570171491401, 8666.523341216294, 8738.432001919855, 8785.34109941757, 8785.736427907173, 4036.798160091984, 4149.792510374529, 4170.145120250341, 4184.476940382452, 4199.790010499462, 4460.1971645104195, 4501.48232953208, 4526.23054080807, 4549.181147393435, 4549.567791059844, 873.5108339329995, 905.1536813079791, 907.981840363189, 916.5325683901258, 918.4397517514311, 720.1538192623751, 733.9119305683353, 744.5904752386166, 764.9885251721229, 776.8679324514846, 11186.38474883873, 12568.428946381702, 13006.609801705965, 13260.403281852146, 13275.468981240836, 734.4051318432087, 736.9926300736925, 738.2949283434415, 749.2732049911577, 757.1330826204075, 5156.355455568054, 5387.164989426645, 5389.8113566025, 5414.29614150158, 5447.101228297287, 74475.0, 76053.0, 80348.0, 81737.59131204306, 85063.57468212744, 71784.0, 73194.0, 74362.0, 78983.0, 79798.0, 64665.0, 70575.0, 72353.63823180851, 73773.26226737771, 74902.0, 12316.445759940645, 12795.744085118431, 13006.349682515647, 13033.869661303645, 13137.715571107223, 33579.49630755492, 33745.493817592265, 33882.83058584691, 34117.97646070622, 35457.0, 55925.0, 56124.978841614895, 56303.15545266906, 57232.13839308101, 57493.42506574881, 17128.486145415656, 17260.482185534453, 17282.926048874215, 17284.135793210036, 17303.3943811966, 18232.45302640923, 18739.812601873808, 18872.24511019599, 18881.90559047196, 19089.140988655265, 15886.9673471224, 15953.8404615957, 16018.119003454922, 16394.672106558042, 16475.752863706814, 17146.657066858344, 17165.828341716424, 17170.484885453458, 17366.0, 17443.738343924597, 16664.083475408483, 16986.830131698523, 17109.0, 17487.300507979537, 17692.557686057953, 11034.724131896766, 11196.272242304223, 11214.83177752318, 11473.196876218584, 11628.0, 14680.486182983972, 14715.190664513555, 15127.16800575979, 15197.392104315704, 15240.0], "value": 8418.223029244493, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1478.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 110.0, 109.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 116.0, 167.0, 116.0, 116.0, 117.0, 118.0, 136.0, 115.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 160.0, 161.0, 163.0, 161.0, 163.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 110.0, 74.0, 73.0, 74.0, 74.0, 95.0, 73.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 102.0, 82.0, 82.0, 82.0, 94.0, 82.0, 82.0, 109.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 49.0, 45.0, 45.0, 47.0, 46.0, 48.0, 47.0, 47.0], "value": 46.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 79.0, 80.0, 79.0, 78.0, 79.0, 79.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 134.0, 132.0, 123.0, 121.0, 124.0, 125.0, 132.0, 173.0, 125.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 183.0, 182.0, 173.0, 185.0, 181.0, 184.0, 188.0, 188.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 67.0, 64.0, 64.0, 63.0, 65.0, 66.0, 64.0], "value": 65.0, "unit": "score"}]}]} 23:02:08 INFO - Return code: 0 23:02:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:02:08 INFO - # TBPL SUCCESS # 23:02:08 INFO - Running post-action listener: _resource_record_post_action 23:02:08 INFO - [mozharness: 2017-05-12 06:02:08.233364Z] Finished run-tests step (success) 23:02:08 INFO - Running post-run listener: _resource_record_post_run 23:02:08 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 395399168; Read time: 0; Write time: 303840 23:02:08 INFO - TinderboxPrint: CPU usage
12.9% 23:02:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:02:08 INFO - TinderboxPrint: I/O write bytes / time
395,399,168 / 303,840 23:02:08 INFO - TinderboxPrint: CPU idle
8,296.4 (87.1%) 23:02:08 INFO - TinderboxPrint: CPU user
1,187.8 (12.5%) 23:02:08 INFO - TinderboxPrint: Swap in / out
0 / 0 23:02:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111943680; Read time: 0; Write time: 119292 23:02:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 265277440; Read time: 0; Write time: 178408 23:02:08 INFO - Running post-run listener: _upload_blobber_files 23:02:08 INFO - Blob upload gear active. 23:02:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:02:08 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 23:02:08 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:02:08 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:02:09 INFO - (blobuploader) - INFO - Open directory for files ... 23:02:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:02:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:02:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:10 INFO - (blobuploader) - INFO - Done attempting. 23:02:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:02:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:14 INFO - (blobuploader) - INFO - Done attempting. 23:02:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:02:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:15 INFO - (blobuploader) - INFO - Done attempting. 23:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:16 INFO - (blobuploader) - INFO - Done attempting. 23:02:16 INFO - (blobuploader) - INFO - Iteration through files over. 23:02:16 INFO - Return code: 0 23:02:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:02:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:02:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160e2c3c86575ce8e0082a282d2bce188fab645d03c4f5aa4664bcf0141b41384183e79920c726fdd2a48334f9df0c1028e09d2d96e8f7c4be198b741ad81f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daf7b8839d7404260dfd13071c8aff417bcc1ff43e2545d801ba86519cfd111eb1a67d21260eebe6fd17cc151b2ed20f91d048f4923ed5eff70da2e714ac6ac1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3212412510ab9c34fcd6100133c541aed209cbff63cc509aefa231986f5cd1e77f358610ca437b92ef5ffd494b7a17166a44b72f3015487f143dc12bb037f87c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77538750351d0924d04b7afa39158531cbd36128a042e87c252cc5b10544c94d2f86705f71305bf7e1d13387bd3813c80beed6c340c354cdfda26c61a9c068b4"} 23:02:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:02:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:02:16 INFO - Contents: 23:02:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160e2c3c86575ce8e0082a282d2bce188fab645d03c4f5aa4664bcf0141b41384183e79920c726fdd2a48334f9df0c1028e09d2d96e8f7c4be198b741ad81f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daf7b8839d7404260dfd13071c8aff417bcc1ff43e2545d801ba86519cfd111eb1a67d21260eebe6fd17cc151b2ed20f91d048f4923ed5eff70da2e714ac6ac1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3212412510ab9c34fcd6100133c541aed209cbff63cc509aefa231986f5cd1e77f358610ca437b92ef5ffd494b7a17166a44b72f3015487f143dc12bb037f87c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77538750351d0924d04b7afa39158531cbd36128a042e87c252cc5b10544c94d2f86705f71305bf7e1d13387bd3813c80beed6c340c354cdfda26c61a9c068b4"} 23:02:16 INFO - Running post-run listener: copy_logs_to_upload_dir 23:02:16 INFO - Copying logs to upload dir... 23:02:16 INFO - mkdir: /builds/slave/test/build/upload/logs 23:02:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.723493 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-11 23:02:16.317651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 23:02:16.322102) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160e2c3c86575ce8e0082a282d2bce188fab645d03c4f5aa4664bcf0141b41384183e79920c726fdd2a48334f9df0c1028e09d2d96e8f7c4be198b741ad81f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daf7b8839d7404260dfd13071c8aff417bcc1ff43e2545d801ba86519cfd111eb1a67d21260eebe6fd17cc151b2ed20f91d048f4923ed5eff70da2e714ac6ac1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3212412510ab9c34fcd6100133c541aed209cbff63cc509aefa231986f5cd1e77f358610ca437b92ef5ffd494b7a17166a44b72f3015487f143dc12bb037f87c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77538750351d0924d04b7afa39158531cbd36128a042e87c252cc5b10544c94d2f86705f71305bf7e1d13387bd3813c80beed6c340c354cdfda26c61a9c068b4"} build_url:https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/Mlva3LD-Rf6aiGF7U7iLzg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160e2c3c86575ce8e0082a282d2bce188fab645d03c4f5aa4664bcf0141b41384183e79920c726fdd2a48334f9df0c1028e09d2d96e8f7c4be198b741ad81f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daf7b8839d7404260dfd13071c8aff417bcc1ff43e2545d801ba86519cfd111eb1a67d21260eebe6fd17cc151b2ed20f91d048f4923ed5eff70da2e714ac6ac1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3212412510ab9c34fcd6100133c541aed209cbff63cc509aefa231986f5cd1e77f358610ca437b92ef5ffd494b7a17166a44b72f3015487f143dc12bb037f87c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77538750351d0924d04b7afa39158531cbd36128a042e87c252cc5b10544c94d2f86705f71305bf7e1d13387bd3813c80beed6c340c354cdfda26c61a9c068b4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 23:02:16.347143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 23:02:16.347452) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1494567685.48266-2075876471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 23:02:16.429393) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 23:02:16.432713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 23:02:16.433017) ========= ========= Total master_lag: 0.19 =========