builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-079 starttime: 1494558185.96 results: success (0) revision: ad45e59c7683a1354c8b73566f653d515f8d9a42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:05.959545) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:05.959996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:05.960265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:05.974937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:05.975278) ========= 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=1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 20:03:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2017-05-11 20:03:06 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092759 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.081951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.082257) ========= 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=1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017852 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.132813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.133183) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ad45e59c7683a1354c8b73566f653d515f8d9a42 --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 ad45e59c7683a1354c8b73566f653d515f8d9a42 --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=1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 20:03:06,790 truncating revision to first 12 chars 2017-05-11 20:03:06,790 Setting DEBUG logging. 2017-05-11 20:03:06,790 attempt 1/10 2017-05-11 20:03:06,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ad45e59c7683?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 20:03:07,178 unpacking tar archive at: mozilla-central-ad45e59c7683/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685942 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.832971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.833272) ========= script_repo_revision: ad45e59c7683a1354c8b73566f653d515f8d9a42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.833646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.833999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 20:03:06.843240) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-11 20:03:06.843607) ========= /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=1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:03:07 INFO - MultiFileLogger online at 20170511 20:03:07 in /builds/slave/test 20:03:07 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 20:03:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:03:07 INFO - {'append_to_log': False, 20:03:07 INFO - 'base_work_dir': '/builds/slave/test', 20:03:07 INFO - 'blob_upload_branch': 'Firefox', 20:03:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:03:07 INFO - 'branch': 'Firefox', 20:03:07 INFO - 'buildbot_json_path': 'buildprops.json', 20:03:07 INFO - 'config_files': ('talos/linux_config.py',), 20:03:07 INFO - 'default_actions': ('clobber', 20:03:07 INFO - 'read-buildbot-config', 20:03:07 INFO - 'download-and-extract', 20:03:07 INFO - 'populate-webroot', 20:03:07 INFO - 'create-virtualenv', 20:03:07 INFO - 'install', 20:03:07 INFO - 'run-tests'), 20:03:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:03:07 INFO - 'download_minidump_stackwalk': True, 20:03:07 INFO - 'download_symbols': 'ondemand', 20:03:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:03:07 INFO - 'tooltool.py': '/tools/tooltool.py', 20:03:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:03:07 INFO - '/tools/misc-python/virtualenv.py')}, 20:03:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:03:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:03:07 INFO - 'gecko_profile': False, 20:03:07 INFO - 'gecko_profile_interval': 0, 20:03:07 INFO - 'installer_path': 'installer.exe', 20:03:07 INFO - 'log_level': 'info', 20:03:07 INFO - 'log_name': 'talos', 20:03:07 INFO - 'log_to_console': True, 20:03:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:03:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:03:07 INFO - 'opt_config_files': (), 20:03:07 INFO - 'pip_index': False, 20:03:07 INFO - 'suite': 'dromaeojs', 20:03:07 INFO - 'system_bits': '32', 20:03:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:03:07 INFO - 'title': 'talos-linux64-ix-079', 20:03:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:03:07 INFO - 'use_talos_json': True, 20:03:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:03:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:03:07 INFO - 'work_dir': 'build'} 20:03:07 INFO - [mozharness: 2017-05-12 03:03:07.598143Z] Running clobber step. 20:03:07 INFO - Running pre-action listener: _resource_record_pre_action 20:03:07 INFO - Running main action method: clobber 20:03:07 INFO - rmtree: /builds/slave/test/build 20:03:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:03:09 INFO - Running post-action listener: _resource_record_post_action 20:03:09 INFO - [mozharness: 2017-05-12 03:03:09.052236Z] Finished clobber step (success) 20:03:09 INFO - [mozharness: 2017-05-12 03:03:09.052335Z] Running read-buildbot-config step. 20:03:09 INFO - Running pre-action listener: _resource_record_pre_action 20:03:09 INFO - Running main action method: read_buildbot_config 20:03:09 INFO - Using buildbot properties: 20:03:09 INFO - { 20:03:09 INFO - "project": "", 20:03:09 INFO - "product": "firefox", 20:03:09 INFO - "who": "ihsiao@mozilla.com", 20:03:09 INFO - "installer_path": "public/build/target.tar.bz2", 20:03:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:03:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 20:03:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 20:03:09 INFO - "stage_platform": "linux64-pgo", 20:03:09 INFO - "basedir": "/builds/slave/test", 20:03:09 INFO - "buildnumber": 180, 20:03:09 INFO - "platform": "ubuntu64_hw", 20:03:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:03:09 INFO - "slavebuilddir": "test", 20:03:09 INFO - "taskId": "HraB4hBcQOmN3kphFvYqFg", 20:03:09 INFO - "branch": "mozilla-central", 20:03:09 INFO - "script_repo_revision": "production", 20:03:09 INFO - "revision": "ad45e59c7683a1354c8b73566f653d515f8d9a42", 20:03:09 INFO - "slavename": "talos-linux64-ix-079", 20:03:09 INFO - "repo_path": "mozilla-central" 20:03:09 INFO - } 20:03:09 INFO - Finding installer, test and symbols from parent task. 20:03:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HraB4hBcQOmN3kphFvYqFg'}, attempt #1 20:03:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HraB4hBcQOmN3kphFvYqFg'}, attempt #1 20:03:09 INFO - Task dependencies: BKFRYa33Sp28ywOhxvTeGg 20:03:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg'}, attempt #1 20:03:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.tar.bz2 20:03:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/test_packages.json 20:03:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.crashreporter-symbols.zip 20:03:10 INFO - Running post-action listener: _resource_record_post_action 20:03:10 INFO - [mozharness: 2017-05-12 03:03:10.393842Z] Finished read-buildbot-config step (success) 20:03:10 INFO - [mozharness: 2017-05-12 03:03:10.394061Z] Running download-and-extract step. 20:03:10 INFO - Running pre-action listener: _resource_record_pre_action 20:03:10 INFO - Running main action method: download_and_extract 20:03:10 INFO - mkdir: /builds/slave/test/build/tests 20:03: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')]} 20:03:10 INFO - trying https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.test_packages.json 20:03:10 INFO - Downloading https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:03:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:03:11 INFO - Downloaded 986 bytes. 20:03:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:03:11 INFO - Using the following test package requirements: 20:03:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:03:11 INFO - u'common': [u'target.common.tests.zip'], 20:03:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:03:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:03:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:03:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:03:11 INFO - u'mozbase': [u'target.common.tests.zip'], 20:03:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:03:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:03:11 INFO - u'web-platform': [u'target.common.tests.zip', 20:03:11 INFO - u'target.web-platform.tests.zip'], 20:03:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:03:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:03:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.common.tests.zip 20:03:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:03:11 INFO - Fetch https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.common.tests.zip into memory 20:03:12 INFO - Content-Length response header: 60748089 20:03:12 INFO - Bytes received: 60748089 20:03:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:03:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.common.tests.zip 20:03:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:03:21 INFO - Fetch https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.common.tests.zip into memory 20:03:23 INFO - Content-Length response header: 60748089 20:03:23 INFO - Bytes received: 60748089 20:03:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.talos.tests.zip 20:03:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:03:33 INFO - Fetch https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.talos.tests.zip into memory 20:03:34 INFO - Content-Length response header: 14409411 20:03:34 INFO - Bytes received: 14409411 20:03:34 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')]} 20:03:34 INFO - trying https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.tar.bz2 20:03:34 INFO - Downloading https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:03:35 INFO - Downloaded 68863910 bytes. 20:03:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.tar.bz2 20:03:35 INFO - mkdir: /builds/slave/test/properties 20:03:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:03:35 INFO - Writing to file /builds/slave/test/properties/build_url 20:03:35 INFO - Contents: 20:03:35 INFO - build_url:https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.tar.bz2 20:03:35 INFO - Running post-action listener: _resource_record_post_action 20:03:35 INFO - Running post-action listener: set_extra_try_arguments 20:03:35 INFO - [mozharness: 2017-05-12 03:03:35.854716Z] Finished download-and-extract step (success) 20:03:35 INFO - [mozharness: 2017-05-12 03:03:35.854814Z] Running populate-webroot step. 20:03:35 INFO - Running pre-action listener: _resource_record_pre_action 20:03:35 INFO - Running main action method: populate_webroot 20:03:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:35 INFO - '--tppagecycles', 20:03:35 INFO - '7'], 20:03:35 INFO - 'tests': ['tsvgm']}}, 20:03:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:03:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:03:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:03:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:03:35 INFO - 'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:03:35 INFO - 'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['damp', 'tps']}, 20:03:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:03:35 INFO - 'tests': ['damp', 'tps']}, 20:03:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['dromaeo_dom']}, 20:03:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 20:03:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:03:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other-e10s': {'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 20:03:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 20:03:35 INFO - 'bloom_basic_ref']}, 20:03:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['tsvgx', 20:03:35 INFO - 'tsvgr_opacity', 20:03:35 INFO - 'tart', 20:03:35 INFO - 'tscrollx', 20:03:35 INFO - 'cart', 20:03:35 INFO - 'tsvg_static']}, 20:03:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:03:35 INFO - 'tsvgr_opacity', 20:03:35 INFO - 'tart', 20:03:35 INFO - 'tscrollx', 20:03:35 INFO - 'cart', 20:03:35 INFO - 'tsvg_static']}, 20:03:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:03:35 INFO - 'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['tp5o']}, 20:03:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:03:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:03:35 INFO - 'talos_options': ['--disable-e10s', 20:03:35 INFO - '--xperf_path', 20:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:35 INFO - 'tests': ['tp5n']}, 20:03:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:03:35 INFO - 'talos_options': ['--xperf_path', 20:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:35 INFO - 'tests': ['tp5n']}}, 20:03:35 INFO - 'talos.zip': {'path': '', 20:03:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:35 INFO - Running post-action listener: _resource_record_post_action 20:03:35 INFO - [mozharness: 2017-05-12 03:03:35.868513Z] Finished populate-webroot step (success) 20:03:35 INFO - [mozharness: 2017-05-12 03:03:35.868603Z] Running create-virtualenv step. 20:03:35 INFO - Running pre-action listener: _resource_record_pre_action 20:03:35 INFO - Running main action method: create_virtualenv 20:03:35 INFO - Creating virtualenv /builds/slave/test/build/venv 20:03:35 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 20:03:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:03:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:35 INFO - Using real prefix '/usr' 20:03:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:03:36 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:38 INFO - Installing pip.................done. 20:03:38 INFO - Return code: 0 20:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:03:38 INFO - Reading from file tmpfile_stdout 20:03:38 INFO - Output received: 20:03:38 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) 20:03:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:03:38 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')]} 20:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:38 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')]} 20:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:38 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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:38 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 20:03:38 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 20:03:38 INFO - Using env: {'DISPLAY': ':0', 20:03:38 INFO - 'HOME': '/home/cltbld', 20:03:38 INFO - 'LANG': 'en_US.UTF-8', 20:03:38 INFO - 'LANGUAGE': 'en_US:en', 20:03:38 INFO - 'LOGNAME': 'cltbld', 20:03:38 INFO - 'MAIL': '/var/mail/cltbld', 20:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:38 INFO - 'MOZ_NO_REMOTE': '1', 20:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:38 INFO - 'NO_EM_RESTART': '1', 20:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:38 INFO - 'PWD': '/builds/slave/test', 20:03:38 INFO - 'SHELL': '/bin/bash', 20:03:38 INFO - 'SHLVL': '1', 20:03:38 INFO - 'TERM': 'linux', 20:03:38 INFO - 'TMOUT': '86400', 20:03:38 INFO - 'USER': 'cltbld', 20:03:38 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:38 INFO - '_': '/tools/buildbot/bin/python'} 20:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:38 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 20:03:38 INFO - Cleaning up... 20:03:38 INFO - Return code: 0 20:03:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:03:38 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')]} 20:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:38 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')]} 20:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:38 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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:38 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 20:03:38 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 20:03:38 INFO - Using env: {'DISPLAY': ':0', 20:03:38 INFO - 'HOME': '/home/cltbld', 20:03:38 INFO - 'LANG': 'en_US.UTF-8', 20:03:38 INFO - 'LANGUAGE': 'en_US:en', 20:03:38 INFO - 'LOGNAME': 'cltbld', 20:03:38 INFO - 'MAIL': '/var/mail/cltbld', 20:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:38 INFO - 'MOZ_NO_REMOTE': '1', 20:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:38 INFO - 'NO_EM_RESTART': '1', 20:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:38 INFO - 'PWD': '/builds/slave/test', 20:03:38 INFO - 'SHELL': '/bin/bash', 20:03:38 INFO - 'SHLVL': '1', 20:03:38 INFO - 'TERM': 'linux', 20:03:38 INFO - 'TMOUT': '86400', 20:03:38 INFO - 'USER': 'cltbld', 20:03:38 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:38 INFO - '_': '/tools/buildbot/bin/python'} 20:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:39 INFO - Downloading/unpacking psutil>=3.1.1 20:03:39 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 20:03:39 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 20:03:39 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 20:03:39 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 20:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:40 INFO - Installing collected packages: psutil 20:03:40 INFO - Running setup.py install for psutil 20:03:40 INFO - building 'psutil._psutil_linux' extension 20:03:40 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 20:03:40 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 20:03:40 INFO - building 'psutil._psutil_posix' extension 20:03:40 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 20:03:40 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 20:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:40 INFO - Successfully installed psutil 20:03:40 INFO - Cleaning up... 20:03:40 INFO - Return code: 0 20:03:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:03:40 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')]} 20:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:40 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')]} 20:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:40 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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:40 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 20:03:40 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 20:03:40 INFO - Using env: {'DISPLAY': ':0', 20:03:40 INFO - 'HOME': '/home/cltbld', 20:03:40 INFO - 'LANG': 'en_US.UTF-8', 20:03:40 INFO - 'LANGUAGE': 'en_US:en', 20:03:40 INFO - 'LOGNAME': 'cltbld', 20:03:40 INFO - 'MAIL': '/var/mail/cltbld', 20:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:40 INFO - 'MOZ_NO_REMOTE': '1', 20:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:40 INFO - 'NO_EM_RESTART': '1', 20:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:40 INFO - 'PWD': '/builds/slave/test', 20:03:40 INFO - 'SHELL': '/bin/bash', 20:03:40 INFO - 'SHLVL': '1', 20:03:40 INFO - 'TERM': 'linux', 20:03:40 INFO - 'TMOUT': '86400', 20:03:40 INFO - 'USER': 'cltbld', 20:03:40 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:40 INFO - '_': '/tools/buildbot/bin/python'} 20:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:03:41 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 20:03:41 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 20:03:41 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 20:03:41 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 20:03:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:03:42 INFO - Installing collected packages: mozsystemmonitor 20:03:42 INFO - Running setup.py install for mozsystemmonitor 20:03:42 INFO - Successfully installed mozsystemmonitor 20:03:42 INFO - Cleaning up... 20:03:42 INFO - Return code: 0 20:03:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:03:42 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')]} 20:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:42 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')]} 20:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:42 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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:42 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 20:03:42 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 20:03:42 INFO - Using env: {'DISPLAY': ':0', 20:03:42 INFO - 'HOME': '/home/cltbld', 20:03:42 INFO - 'LANG': 'en_US.UTF-8', 20:03:42 INFO - 'LANGUAGE': 'en_US:en', 20:03:42 INFO - 'LOGNAME': 'cltbld', 20:03:42 INFO - 'MAIL': '/var/mail/cltbld', 20:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:42 INFO - 'MOZ_NO_REMOTE': '1', 20:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:42 INFO - 'NO_EM_RESTART': '1', 20:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:42 INFO - 'PWD': '/builds/slave/test', 20:03:42 INFO - 'SHELL': '/bin/bash', 20:03:42 INFO - 'SHLVL': '1', 20:03:42 INFO - 'TERM': 'linux', 20:03:42 INFO - 'TMOUT': '86400', 20:03:42 INFO - 'USER': 'cltbld', 20:03:42 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:42 INFO - '_': '/tools/buildbot/bin/python'} 20:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:42 INFO - Downloading/unpacking jsonschema==2.5.1 20:03:42 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 20:03:42 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 20:03:42 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 20:03:42 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 20:03:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:03:43 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 20:03:43 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 20:03:43 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 20:03:43 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 20:03:43 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:43 INFO - warning: no files found matching '*.txt' 20:03:43 INFO - no previously-included directories found matching 'build' 20:03:43 INFO - no previously-included directories found matching 'dist' 20:03:43 INFO - no previously-included directories found matching '.git*' 20:03:43 INFO - Installing collected packages: jsonschema, functools32 20:03:43 INFO - Running setup.py install for functools32 20:03:43 INFO - warning: no files found matching '*.txt' 20:03:43 INFO - no previously-included directories found matching 'build' 20:03:43 INFO - no previously-included directories found matching 'dist' 20:03:43 INFO - no previously-included directories found matching '.git*' 20:03:43 INFO - Successfully installed jsonschema functools32 20:03:43 INFO - Cleaning up... 20:03:43 INFO - Return code: 0 20:03:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:03:43 INFO - Using env: {'DISPLAY': ':0', 20:03:43 INFO - 'HOME': '/home/cltbld', 20:03:43 INFO - 'LANG': 'en_US.UTF-8', 20:03:43 INFO - 'LANGUAGE': 'en_US:en', 20:03:43 INFO - 'LOGNAME': 'cltbld', 20:03:43 INFO - 'MAIL': '/var/mail/cltbld', 20:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:43 INFO - 'MOZ_NO_REMOTE': '1', 20:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:43 INFO - 'NO_EM_RESTART': '1', 20:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:43 INFO - 'PWD': '/builds/slave/test', 20:03:43 INFO - 'SHELL': '/bin/bash', 20:03:43 INFO - 'SHLVL': '1', 20:03:43 INFO - 'TERM': 'linux', 20:03:43 INFO - 'TMOUT': '86400', 20:03:43 INFO - 'USER': 'cltbld', 20:03:43 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:43 INFO - '_': '/tools/buildbot/bin/python'} 20:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:03:44 INFO - Cleaning up... 20:03:44 INFO - Return code: 0 20:03:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:03:44 INFO - Using env: {'DISPLAY': ':0', 20:03:44 INFO - 'HOME': '/home/cltbld', 20:03:44 INFO - 'LANG': 'en_US.UTF-8', 20:03:44 INFO - 'LANGUAGE': 'en_US:en', 20:03:44 INFO - 'LOGNAME': 'cltbld', 20:03:44 INFO - 'MAIL': '/var/mail/cltbld', 20:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:44 INFO - 'MOZ_NO_REMOTE': '1', 20:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:44 INFO - 'NO_EM_RESTART': '1', 20:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:44 INFO - 'PWD': '/builds/slave/test', 20:03:44 INFO - 'SHELL': '/bin/bash', 20:03:44 INFO - 'SHLVL': '1', 20:03:44 INFO - 'TERM': 'linux', 20:03:44 INFO - 'TMOUT': '86400', 20:03:44 INFO - 'USER': 'cltbld', 20:03:44 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:44 INFO - '_': '/tools/buildbot/bin/python'} 20:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:45 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:45 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 20:03:45 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 20:03:45 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 20:03:45 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 20:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:03:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:45 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 20:03:45 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 20:03:45 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 20:03:45 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 20:03:46 INFO - Downloading docopt-0.6.1.tar.gz 20:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:46 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:46 INFO - Running setup.py install for blobuploader 20:03:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:03:46 INFO - Running setup.py install for requests 20:03:46 INFO - Running setup.py install for docopt 20:03:46 INFO - Successfully installed blobuploader requests docopt 20:03:46 INFO - Cleaning up... 20:03:46 INFO - Return code: 0 20:03:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:46 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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:46 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 20:03:46 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 20:03:46 INFO - Using env: {'DISPLAY': ':0', 20:03:46 INFO - 'HOME': '/home/cltbld', 20:03:46 INFO - 'LANG': 'en_US.UTF-8', 20:03:46 INFO - 'LANGUAGE': 'en_US:en', 20:03:46 INFO - 'LOGNAME': 'cltbld', 20:03:46 INFO - 'MAIL': '/var/mail/cltbld', 20:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:46 INFO - 'MOZ_NO_REMOTE': '1', 20:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:46 INFO - 'NO_EM_RESTART': '1', 20:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:46 INFO - 'PWD': '/builds/slave/test', 20:03:46 INFO - 'SHELL': '/bin/bash', 20:03:46 INFO - 'SHLVL': '1', 20:03:46 INFO - 'TERM': 'linux', 20:03:46 INFO - 'TMOUT': '86400', 20:03:46 INFO - 'USER': 'cltbld', 20:03:46 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:46 INFO - '_': '/tools/buildbot/bin/python'} 20:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:47 INFO - Running setup.py (path:/tmp/pip-vFHI3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:47 INFO - Running setup.py (path:/tmp/pip-pd16qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:47 INFO - Running setup.py (path:/tmp/pip-Bq0YcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:47 INFO - Running setup.py (path:/tmp/pip-qBX03y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:47 INFO - Running setup.py (path:/tmp/pip-oJWULX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:47 INFO - Running setup.py (path:/tmp/pip-ScmCcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:47 INFO - Running setup.py (path:/tmp/pip-wTfRPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:47 INFO - Running setup.py (path:/tmp/pip-VWsasL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:47 INFO - Running setup.py (path:/tmp/pip-69Pq_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:47 INFO - Running setup.py (path:/tmp/pip-EwPi9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:47 INFO - Running setup.py (path:/tmp/pip-OVA6L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:47 INFO - Running setup.py (path:/tmp/pip-BWxyty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:47 INFO - Running setup.py (path:/tmp/pip-_PATjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:48 INFO - Running setup.py (path:/tmp/pip-81KmI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:48 INFO - Running setup.py (path:/tmp/pip-bCiTwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:48 INFO - Running setup.py (path:/tmp/pip-Xfz4It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:48 INFO - Running setup.py (path:/tmp/pip-2zx_df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:48 INFO - Running setup.py install for manifestparser 20:03:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:03:48 INFO - Running setup.py install for mozcrash 20:03:48 INFO - Running setup.py install for mozdebug 20:03:48 INFO - Running setup.py install for mozdevice 20:03:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:03:48 INFO - Running setup.py install for mozfile 20:03:48 INFO - Running setup.py install for mozhttpd 20:03:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:03:48 INFO - Running setup.py install for mozinfo 20:03:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:03:48 INFO - Running setup.py install for mozInstall 20:03:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Running setup.py install for mozleak 20:03:49 INFO - Running setup.py install for mozlog 20:03:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Running setup.py install for moznetwork 20:03:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Running setup.py install for mozprocess 20:03:49 INFO - Running setup.py install for mozprofile 20:03:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Running setup.py install for mozrunner 20:03:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:03:49 INFO - Running setup.py install for mozscreenshot 20:03:49 INFO - Running setup.py install for moztest 20:03:49 INFO - Running setup.py install for mozversion 20:03:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:03:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:03:50 INFO - Cleaning up... 20:03:50 INFO - Return code: 0 20:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:50 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')]} 20:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:50 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')]} 20:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:50 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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:50 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 20:03:50 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 20:03:50 INFO - Using env: {'DISPLAY': ':0', 20:03:50 INFO - 'HOME': '/home/cltbld', 20:03:50 INFO - 'LANG': 'en_US.UTF-8', 20:03:50 INFO - 'LANGUAGE': 'en_US:en', 20:03:50 INFO - 'LOGNAME': 'cltbld', 20:03:50 INFO - 'MAIL': '/var/mail/cltbld', 20:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:50 INFO - 'MOZ_NO_REMOTE': '1', 20:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:50 INFO - 'NO_EM_RESTART': '1', 20:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:50 INFO - 'PWD': '/builds/slave/test', 20:03:50 INFO - 'SHELL': '/bin/bash', 20:03:50 INFO - 'SHLVL': '1', 20:03:50 INFO - 'TERM': 'linux', 20:03:50 INFO - 'TMOUT': '86400', 20:03:50 INFO - 'USER': 'cltbld', 20:03:50 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:50 INFO - '_': '/tools/buildbot/bin/python'} 20:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:50 INFO - Running setup.py (path:/tmp/pip-RFIQqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:50 INFO - Running setup.py (path:/tmp/pip-x7JyxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:50 INFO - Running setup.py (path:/tmp/pip-RgPuDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:50 INFO - Running setup.py (path:/tmp/pip-F3v2ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:50 INFO - Running setup.py (path:/tmp/pip-kDvZ0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:50 INFO - Running setup.py (path:/tmp/pip-pMtPl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:50 INFO - Running setup.py (path:/tmp/pip-uQZ88v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:50 INFO - Running setup.py (path:/tmp/pip-R6cgFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:50 INFO - Running setup.py (path:/tmp/pip-mvVcxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:50 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)) 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:50 INFO - Running setup.py (path:/tmp/pip-bYFMD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:51 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)) 20:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:51 INFO - Running setup.py (path:/tmp/pip-QOcZF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:51 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)) 20:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:51 INFO - Running setup.py (path:/tmp/pip-vqIna6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:51 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)) 20:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:51 INFO - Running setup.py (path:/tmp/pip-CutglK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:51 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)) 20:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:51 INFO - Running setup.py (path:/tmp/pip-OG61cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:51 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)) 20:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:51 INFO - Running setup.py (path:/tmp/pip-rF11We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:51 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)) 20:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:51 INFO - Running setup.py (path:/tmp/pip-YkqObh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:51 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)) 20:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:51 INFO - Running setup.py (path:/tmp/pip-gjpIX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:51 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)) 20:03:51 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)) 20:03:51 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)) 20:03:51 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)) 20:03:51 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)) 20:03:51 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)) 20:03:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:52 INFO - Downloading blessings-1.6.tar.gz 20:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:03:52 INFO - Installing collected packages: blessings 20:03:52 INFO - Running setup.py install for blessings 20:03:52 INFO - Successfully installed blessings 20:03:52 INFO - Cleaning up... 20:03:52 INFO - Return code: 0 20:03:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:03:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:03:53 INFO - Reading from file tmpfile_stdout 20:03:53 INFO - Current package versions: 20:03:53 INFO - argparse == 1.2.1 20:03:53 INFO - blessings == 1.6 20:03:53 INFO - blobuploader == 1.2.4 20:03:53 INFO - docopt == 0.6.1 20:03:53 INFO - functools32 == 3.2.3-2 20:03:53 INFO - jsonschema == 2.5.1 20:03:53 INFO - manifestparser == 1.1 20:03:53 INFO - mozInstall == 1.12 20:03:53 INFO - mozcrash == 1.0 20:03:53 INFO - mozdebug == 0.1 20:03:53 INFO - mozdevice == 0.50 20:03:53 INFO - mozfile == 1.2 20:03:53 INFO - mozhttpd == 0.7 20:03:53 INFO - mozinfo == 0.9 20:03:53 INFO - mozleak == 0.1 20:03:53 INFO - mozlog == 3.4 20:03:53 INFO - moznetwork == 0.27 20:03:53 INFO - mozprocess == 0.25 20:03:53 INFO - mozprofile == 0.28 20:03:53 INFO - mozrunner == 6.13 20:03:53 INFO - mozscreenshot == 0.1 20:03:53 INFO - mozsystemmonitor == 0.3 20:03:53 INFO - moztest == 0.8 20:03:53 INFO - mozversion == 1.4 20:03:53 INFO - psutil == 3.1.1 20:03:53 INFO - requests == 1.2.3 20:03:53 INFO - wsgiref == 0.1.2 20:03:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:53 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')]} 20:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:53 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')]} 20:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:53 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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:53 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 20:03:53 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 20:03:53 INFO - Using env: {'DISPLAY': ':0', 20:03:53 INFO - 'HOME': '/home/cltbld', 20:03:53 INFO - 'LANG': 'en_US.UTF-8', 20:03:53 INFO - 'LANGUAGE': 'en_US:en', 20:03:53 INFO - 'LOGNAME': 'cltbld', 20:03:53 INFO - 'MAIL': '/var/mail/cltbld', 20:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:53 INFO - 'MOZ_NO_REMOTE': '1', 20:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:53 INFO - 'NO_EM_RESTART': '1', 20:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:53 INFO - 'PWD': '/builds/slave/test', 20:03:53 INFO - 'SHELL': '/bin/bash', 20:03:53 INFO - 'SHLVL': '1', 20:03:53 INFO - 'TERM': 'linux', 20:03:53 INFO - 'TMOUT': '86400', 20:03:53 INFO - 'USER': 'cltbld', 20:03:53 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:53 INFO - '_': '/tools/buildbot/bin/python'} 20:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 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)) 20:03:53 INFO - Cleaning up... 20:03:53 INFO - Return code: 0 20:03:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:03:53 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')]} 20:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:53 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')]} 20:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x21371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2303a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, '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': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', '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 20:03:53 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 20:03:53 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 20:03:53 INFO - Using env: {'DISPLAY': ':0', 20:03:53 INFO - 'HOME': '/home/cltbld', 20:03:53 INFO - 'LANG': 'en_US.UTF-8', 20:03:53 INFO - 'LANGUAGE': 'en_US:en', 20:03:53 INFO - 'LOGNAME': 'cltbld', 20:03:53 INFO - 'MAIL': '/var/mail/cltbld', 20:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:53 INFO - 'MOZ_NO_REMOTE': '1', 20:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:53 INFO - 'NO_EM_RESTART': '1', 20:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:53 INFO - 'PWD': '/builds/slave/test', 20:03:53 INFO - 'SHELL': '/bin/bash', 20:03:53 INFO - 'SHLVL': '1', 20:03:53 INFO - 'TERM': 'linux', 20:03:53 INFO - 'TMOUT': '86400', 20:03:53 INFO - 'USER': 'cltbld', 20:03:53 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:53 INFO - '_': '/tools/buildbot/bin/python'} 20:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:03:53 INFO - Cleaning up... 20:03:53 INFO - Return code: 0 20:03:53 INFO - Running post-action listener: _resource_record_post_action 20:03:53 INFO - Running post-action listener: _start_resource_monitoring 20:03:53 INFO - Starting resource monitoring. 20:03:53 INFO - [mozharness: 2017-05-12 03:03:53.546250Z] Finished create-virtualenv step (success) 20:03:53 INFO - [mozharness: 2017-05-12 03:03:53.546714Z] Running install step. 20:03:53 INFO - Running pre-action listener: _resource_record_pre_action 20:03:53 INFO - Running main action method: install 20:03:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:03:53 INFO - Reading from file tmpfile_stdout 20:03:53 INFO - Detecting whether we're running mozinstall >=1.0... 20:03:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:03:53 INFO - Reading from file tmpfile_stdout 20:03:53 INFO - Output received: 20:03:53 INFO - Usage: mozinstall [options] installer 20:03:53 INFO - Options: 20:03:53 INFO - -h, --help show this help message and exit 20:03:53 INFO - -d DEST, --destination=DEST 20:03:53 INFO - Directory to install application into. [default: 20:03:53 INFO - "/builds/slave/test"] 20:03:53 INFO - --app=APP Application being installed. [default: firefox] 20:03:53 INFO - mkdir: /builds/slave/test/build/application 20:03:53 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'] 20:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:04:10 INFO - Reading from file tmpfile_stdout 20:04:10 INFO - Output received: 20:04:10 INFO - /builds/slave/test/build/application/firefox/firefox 20:04:10 INFO - Running post-action listener: _resource_record_post_action 20:04:10 INFO - [mozharness: 2017-05-12 03:04:10.989344Z] Finished install step (success) 20:04:10 INFO - [mozharness: 2017-05-12 03:04:10.989562Z] Running run-tests step. 20:04:10 INFO - Running pre-action listener: _resource_record_pre_action 20:04:10 INFO - Running main action method: run_tests 20:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:04:10 INFO - Python 2.7.3 20:04:10 INFO - Return code: 0 20:04:10 INFO - grabbing minidump binary from tooltool 20:04: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')]} 20:04:10 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 0x24a6a30>, '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 0x24a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:04:10 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 20:04:10 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 20:04:10 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 20:04:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:04:11 INFO - Return code: 0 20:04:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:04:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:04:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:04:11 INFO - ENV: RUST_BACKTRACE is now 1 20:04:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:04:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:04:11 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/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 20:04:11 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/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 20:04:11 INFO - Using env: {'DISPLAY': ':0', 20:04:11 INFO - 'HOME': '/home/cltbld', 20:04:11 INFO - 'LANG': 'en_US.UTF-8', 20:04:11 INFO - 'LANGUAGE': 'en_US:en', 20:04:11 INFO - 'LOGNAME': 'cltbld', 20:04:11 INFO - 'MAIL': '/var/mail/cltbld', 20:04:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:04:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:11 INFO - 'MOZ_NO_REMOTE': '1', 20:04:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:11 INFO - 'NO_EM_RESTART': '1', 20:04:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:11 INFO - 'PWD': '/builds/slave/test', 20:04:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:04:11 INFO - 'RUST_BACKTRACE': '1', 20:04:11 INFO - 'SHELL': '/bin/bash', 20:04:11 INFO - 'SHLVL': '1', 20:04:11 INFO - 'TERM': 'linux', 20:04:11 INFO - 'TMOUT': '86400', 20:04:11 INFO - 'USER': 'cltbld', 20:04:11 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116', 20:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:11 INFO - '_': '/tools/buildbot/bin/python'} 20:04:11 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/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 20:04:11 INFO - mozversion application_buildid: 20170512021404 20:04:11 INFO - mozversion application_changeset: ad45e59c7683a1354c8b73566f653d515f8d9a42 20:04:11 INFO - mozversion application_display_name: Nightly 20:04:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:04:11 INFO - mozversion application_name: Firefox 20:04:11 INFO - mozversion application_remotingname: firefox 20:04:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:04:11 INFO - mozversion application_vendor: Mozilla 20:04:11 INFO - mozversion application_version: 55.0a1 20:04:11 INFO - mozversion platform_buildid: 20170512021404 20:04:11 INFO - mozversion platform_changeset: ad45e59c7683a1354c8b73566f653d515f8d9a42 20:04:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:04:11 INFO - mozversion platform_version: 55.0a1 20:04:11 INFO - using testdate: 1494558251 20:04:11 INFO - actual date: 1494558251 20:04:11 INFO - starting webserver on 'localhost:36532' 20:04:11 INFO - SUITE-START | Running 2 tests 20:04:11 INFO - TEST-START | dromaeo_css 20:04:11 INFO - operating with platform_type : linux_ 20:04:11 INFO - Initialising browser for dromaeo_css test... 20:04:11 INFO - TEST-INFO | started process 30599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3fiwqq/profile http://localhost:36532/getInfo.html) 20:04:15 INFO - PID 30599 | __metrics Screen width/height:1600/1200 20:04:15 INFO - PID 30599 | colorDepth:24 20:04:15 INFO - PID 30599 | Browser inner width/height: 1024/695 20:04:15 INFO - PID 30599 | __metrics 20:04:16 INFO - PID 30599 | 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" 20:04:16 INFO - PID 30599 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:04:17 INFO - TEST-INFO | 30599: exit 0 20:04:17 INFO - Browser initialized. 20:04:17 INFO - Running cycle 1/1 for dromaeo_css test... 20:04:17 INFO - TEST-INFO | started process 30698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3fiwqq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:29 INFO - PID 30698 | RSS: Main: 144470016 20:04:29 INFO - PID 30698 | 20:07:31 INFO - PID 30698 | Cycle 1(1): loaded http://localhost:36532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36532/tests/dromaeo/cssquery-ext.html) 20:07:33 INFO - PID 30698 | RSS: Main: 325218304 20:07:33 INFO - PID 30698 | 20:10:35 INFO - PID 30698 | Cycle 1(1): loaded http://localhost:36532/tests/dromaeo/cssquery-ext.html (next: http://localhost:36532/tests/dromaeo/cssquery-jquery.html) 20:10:35 INFO - PID 30698 | RSS: Main: 233861120 20:10:35 INFO - PID 30698 | 20:13:37 INFO - PID 30698 | Cycle 1(1): loaded http://localhost:36532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36532/tests/dromaeo/cssquery-mootools.html) 20:13:37 INFO - PID 30698 | RSS: Main: 178294784 20:13:37 INFO - PID 30698 | 20:16:39 INFO - PID 30698 | Cycle 1(1): loaded http://localhost:36532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36532/tests/dromaeo/cssquery-prototype.html) 20:16:40 INFO - PID 30698 | RSS: Main: 176041984 20:16:40 INFO - PID 30698 | 20:19:43 INFO - PID 30698 | Cycle 1(1): loaded http://localhost:36532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36532/tests/dromaeo/cssquery-yui.html) 20:19:43 INFO - PID 30698 | RSS: Main: 178978816 20:19:43 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | Cycle 1(1): loaded http://localhost:36532/tests/dromaeo/cssquery-yui.html (next: http://localhost:36532/tests/dromaeo/cssquery-dojo.html) 20:22:45 INFO - PID 30698 | RSS: Main: 263983104 20:22:45 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | __start_tp_report 20:22:45 INFO - PID 30698 | _x_x_mozilla_page_load 20:22:45 INFO - PID 30698 | _x_x_mozilla_page_load_details 20:22:45 INFO - PID 30698 | |i|pagename|runs| 20:22:45 INFO - PID 30698 | |0;dojo.html;3268.150280926957;3281.3601347737185;3287.5726155599777;3308.8841890533836;3330.78349907256;5599.524040456556;5750.1949727038245;5752.511036561892;5778.76884924603;5788;5713.542916566675;5748.310202775673;5748.741306641201;5750.453706897838;5751.223584816049;5128.102582048136;5136.691798492084;5162.096633089213;5193.065248255312;5202.947970520303;5239.3712754469325;5254.500822421864;5255.0803609368395;5262.894742105155;5267.446918073604;5100.438951715309;5199.714015729133;5225.294585231002;5258.789648414059;5317.175837745136;5040.697558146523;5079.492050794928;5195.5324020837925;5208.765605547722;5267.894642107156;5064.366954130734;5110.591152707774;5146.511081447256;5170.922436163461;5172.456892026321;5735.139729040678;5756.481916627482;5785.190073389686;5794.1308803679785;5800.187973683645;6067.24159480065;6263.843403914893;6265.968670156665;6269.059641053833;6269.592476489013;6141.332587233735;6158.1686472326555;6178.567500274982;6198.504119670415;6258.843528911768;5836.241288632451;5836.795712150054;5840.649561026352;5841.7371218295275;5859;6391.265004524539;6393.392627700361;6401.9039714404325;6404.135441715402;6405.871882562323;5977.790777322773;6046.486048685823;6057.242844644419;6071.726772295257;6102.186302349175;5961.821145365646;6032.788852390146;6039.63762174271;6119.816953237485;6198.2871969723155;6201.7519299228425;6225.688715564294;6232.657203853832;6240.594361366497;6243;6165.537584681167;6187.257529096537;6199.504039676815;6201.937980620226;6237.625742455467;4626.606738427271;4636.466806317249;4678.95321046792;4705.294205869079;4757.9286310705365;4210.894727631834;4222.809973551198;4242.406063151161;4258.574142585717;4287.292596721569;5827.883442331215;5831.06702927538;5839.416058394211;5845.561582881301;5896.587238893322;6075.362086980804;6144.047672610753;6218.844528886723;6253.312135665074;6276.403741644536;5767.250257466502;5853.5317174625925;5887.470127688529;5889.587728858939;5900.439458251545;5337.412884582693;5346.1713434417725;5371.946280537223;5395.244665746799;5428.212909128154;6231.563790534619;6422.03669449577;6482.416582507597;6485.902711459237;6488.351164883474;6116.579253789288;6126.334466362847;6226.968865155645;6229.781957631461;6234.501239900887;6471.838204044937;6480.967595161994;6483.935160648522;6492.902606461002;6497.545171837926;6161.876762464815;6163.35284795108;6166.722497487534;6170.475509581735;6170.969145154425;6071.666058366833;6148.354422785722;6157.168782214523;6207.751689932533;6241.188645476059;6078.483328916915;6100.420460056288;6100.847478813065;6103.877922441615;6130.172426722514;5872.324682661549;5940.227770389822;6058.878822423439;6117.908231376444;6120.908186377297;5924.6149000314845;5980.312264089685;6002.459778619946;6005.189299444519;6007.90988135187;6046.97201475759;6051.152838602511;6053.273607166992;6054.7275372607455;6059.697015149137;5828.766849326149;5888.293404791452;5890.352061273342;5891.263592050994;5893.823185304448 20:22:45 INFO - PID 30698 | |1;ext.html;698.4935921456944;779.485539543901;800.3157300508066;1135.3698697223042;1158.073541167067;28698.713012869892;32839.50740738891;35332.47001294982;35367.2926541469;35535;38205.61794382055;38478.23043539128;38549.61450385495;38589.42115868264;38612.61387386125;5561.5828812839;7169.211386747466;7310.81722956925;7311.195768465464;7316.853662926738;5684.5452363811;7125.8218544536285;7306.780796576111;7310.2689731027;7312.670929808145;7388.852222955537;7432.256774322578;7443.181250062489;7444.8883266751045;7449.702011919544;5608.5793565482345;7324.121105467325;7383.778486645409;7389;7389.2241314662;5696.344920334173;7052.717891284343;7236.49344545882;7245;7250.2024777274455;34570;34631;34874.47688284678;34878.476822847675;34981.47527787085;3436.621971583124;3457.3258214648154;3465.42820434628;3480.4083305838067;3481.721462283011;27112;27182.45635087287;27201.727982720116;27243.318917027034;27445.58831617527;3748.8687895923513;3777.924441511182;3794.1083845296334;3795.4686343911876;3836.2135762168687;187807;187920;188594;188604;189079;44498.327675593595;44828;44840;44917.55082449199;44980.55019449829;45996;46241.7687911565;46286.305705414445;46377.30434043492;46405;15187.240637968278;15251.542453726406;15253.694926101416;15350.769738453931;15352.616184595474;11206.887931120747;11411;12513.562025329253;12552.435140418704;12622.431990560446;12450.128491005542;12670.36648167588;12672.80990785139;12783.233006019482;12803.807942880865;5304.92042619361;5355.678659280456;5377;5481.835544933659;5516.448355164452;1070.7590792071878;1087.211771465681;1110.3948348150277;1111.8721347045032;1113.3709454158375;24650.383740406276;24878;25040.874795625907;25205.87397063003;25481;1189.6371606660052;1193.6359410379744;1197.161986609377;1199.6161228406827;1218.0742635596832;12778.936105319413;12915;13111.582873695383;13335.333233338488;13436.932815336057;255734;257473;260368;261997;262238;49332;49594.50405495899;49660.751696241285;49802;49833.75083124561;1486.1751727790963;1532.348751780511;1540.106738091904;1546.9226538673022;1553.4252326639216;23764.52470950606;24690.01239950382;24750.628740568547;24764.628530572416;24801.87599061993;36539.451908220864;46442.535574645175;47483.52516474929;47506;47690.04619907652;239233;241776;241783;241976;242837;28811.254536910066;28869.855650722453;33951.15122121967;34144.317113658086;34282;39270.60729392784;39276.803615981735;41044;41059;41121.58878411297;31057.378852423277;31411.685883140875;31544;31940.84029579837;32677;32242.35515289634;32376.514352285205;32924.1768955778;33335.66664333326;33706;36023.27953440969;36057.819710901276;37152.44271335878;37326.81336593408;37338.43992340063;30383.24041898882;30672.693273067875;30709.23226919345;31177.53233701451;31659.20851978719;24292.878535607917;25050.37374065663;25064.62403063992;25483;25506.617400738633 20:22:45 INFO - PID 30698 | |2;jquery.html;422.64920116303455;434.3961892968772;435.7821089455271;454.5954100850244;458.22559873813253;18891.716624250646;19908.203671853127;20403.285884994028;20624.793752062476;20639;21224.681629775565;23218;23417.765822341815;23564;23786.76213237867;5479.1781232815;5711;5715.571332150084;5723.370429252779;5723.627964182315;5411.350637923435;5463.426340234278;5615.185798059279;5615.5507559395355;5623.184638227475;5551.8889622207535;5560.277163968678;5564.666120032791;5568.248286481314;5578.888422231553;5475.780968761244;5537.8061767838135;5566.192902029183;5574;5576.219329293902;5009.073321435546;5042.294078828967;5048.7980480780725;5049.394072711299;5050.116229659831;25686.614700779504;26496.205113846423;26593.202203933914;26593.734062659318;26788.464230715275;2105.357865850915;2147.892605369741;2189.1243502599086;2195.242641288769;2197.9340619781433;16986.915065424717;17019.149042547822;17121.486355409357;17212.56968575783;17395;2179.8256139508803;2234.2850287907877;2254.357508110197;2257.164849005862;2283.394900351408;109969;112508.43745781301;114218;114272.85727142706;115990;12332.568360107532;12514.937425312815;12606.936965315115;12614.243145411305;12802.16785908913;17831.554211144827;17872.91063544674;17886.373976910745;17907.73138402925;17914;8912.153345432174;9225.815483690423;9330.860037099314;9340.859887101698;9392.107749763762;8592.355573332025;8600.182982616641;8674.91325086741;8850.026497085315;8886.24466920306;7779.922200778033;7990.3208227300165;8118.553479558563;8151.225633564802;8174.7956301092945;2197.791209835063;2203.3720389689183;2213.557288542298;2242.977570224277;2307.4346785037774;1038.8182068138046;1062.6875808376649;1067.829147336438;1072.104792498257;1083.5990683447017;23610.52778944446;25708.871455642602;25900.22299331023;26307.736922630913;26600.467990640467;1075.2688172042929;1086.8261078227445;1088.5373716170755;1090.536521978156;1094.5348227003492;11089.667309980714;11587.59443419493;11666.70833229176;11754.177207595387;11791.410429478492;502184;502551;514637;551121;556034.8146037371;96577.51711241399;99650.5017474908;104104.47947760213;104596.47701761442;104969;1224.2370985780447;1241.366902879538;1291.2446218962014;1295.242283264301;1295.9805602915965;20420.651625062714;20754.377368678965;21057.368278951657;21314.147434102462;21378.57242855103;45052.774736126106;45399.546004540854;45604.315935261664;45964.31053534133;46585.53414465812;60930;61134.694326528086;61993.69003154955;62004;62273.68863155655;9605.807883842424;9799.657012004545;9824.263180261652;9854.310198286052;9931.751706207402;14676.853231467549;14883.553493395215;15242.542723718307;15540.84459155394;15680.76478852841;12738.872611274139;12758;12785;12798.68003299925;13157.802632960322;12318.199317044364;12501.312427816194;12567.120301578801;12659.620211393672;13031;13071.738565228452;13417.463301467831;13852.861471385157;13883.375248114062;14550.708985820436;9582.952085239529;9618.134367906921;9839.950800245953;10071.244656650633;10092.747681308027;12807.551735689207;13185.868141318464;13444.798328025283;13542.458301668217;13766.105203161762 20:22:45 INFO - PID 30698 | |3;mootools.html;1230.5262473947528;1361.3737680666893;1411.6823714664201;1419.3754747910918;1438.0077746355014;9238.491882946444;10767.24629275951;11481.196316257865;11519.712007199803;11520.251183673055;11138.665840024812;11251;11258.268212566198;11261.887381126186;11267.943660281708;1952.9707054394196;2344.7303560090554;2386.72552656445;2387.6776635154206;2388.6058800298015;2048.0169518631064;2061.8556701030934;2062.979370206294;2295.5064661097863;2396.18529699902;2270.693456383392;2276.726792784868;2278.8290878184202;2281.121768119278;2284.463151159476;2230;2234.720659917502;2257.8871056447274;2259.1189436119926;2259.141526220042;2188.89055547222;2206.0844749428966;2242.4169715873827;2263.898124584381;2291.0950174681075;10414.479276036243;10489.475526223658;10501.789964200749;10867.184961127869;10961.506732197071;6085.726142323606;6279.748810047593;6281.214848143982;6297.2128483939505;6298.433141017331;3681.7790932544135;3835.5780864104927;3891.727579069438;3954.169624378884;3970.980145099285;1235.8516977962613;1349.601867449105;1392.3873495661876;1434.2756907761618;1443.0547991065869;16608.169591520375;16632.085235312054;16635.41776037845;16645.916770416192;16676.16619169037;5192.350956130484;5305.62860599762;5563.415841336682;5565.638233514808;5605.80379686709;13698.178109313472;13728.65678358049;13733.862661373458;13751.656208594664;13755.243461609507;6384.265809431975;6389.488840892717;6434.517411194179;6437.227532696106;6439.903401448982;5826.2134611827705;5851.795187168429;5889;5914.556408269397;5947.31605865331;3993.6206060424215;4113.506379234451;4418.646508279394;4571.702839315434;4604.907901841944;1363.1820907455447;1394.414345974693;1394.7838085096826;1415.3064998151037;1416.6529200345776;876.5660997806;887.5207388010531;899.6131663384676;910.139917777707;910.8406028945041;6483.546151769331;6576.605403675699;6608.801735947929;6618.569792963442;6638.402543771083;939.6194541210821;954.4321128928416;959.0553304994575;974.7806743482802;978.3738407419257;4413.7793110344355;4597.241455159928;4782.258749893772;4963.90072198554;5082.440931497532;14052.578422647337;14767.630809229855;14794.186319752302;14867.776983345042;15060.698786024219;14231.430742770173;14444.494442694666;14727;14731.263436828116;14754.188519631309;9047.095290470901;9273.536323183815;9274.44353338802;9277;9312.767180820534;6863.794086177422;6918.619475928872;6946.680130775137;6975.093237879246;7194.100737407824;12887.871121289043;13024.739505210033;13083.215007099605;13300.201987880759;13318.667033324244;13378.665533361354;13532.93233533826;13645;13675.316234188052;13861.168329900238;9211.078892110736;9241.537923103953;9265.166135047608;9380.108889655472;9391.671291505038;9427.528623568931;9704.563294651898;10432.321899076536;10583.62957296491;10963.50664220096;9447.574859131219;9574.425534467955;9575.473348965874;9852.211823053995;9968.55141518619;9413.717588472357;9513.429194248367;9518.476483793458;9538.093881081286;9577.569009394454;7991.880121798294;8039.437239393186;8102.513849169069;8112.43212975086;8141;6320.241571011508;6331.0819931110655;6342.746290148342;6494.870102598016;6522.543421960418;6385.584936979081;6464.967675161594;6483.2544257411;6708.021133765454;6716.395524402632 20:22:45 INFO - PID 30698 | |4;prototype.html;396.26492855752576;397.24126917587415;403.5097356711595;406.0721251939318;410.8562003298844;5750.6262092963925;5834.745529711111;5835.503982161511;5843.276233511114;5846.327672317685;5548.335896036907;5675.34733505647;5742.28221472316;5777.711114444282;5792.536597072235;4438.511763705989;4453.131639330332;4474.060447306069;4487.080148569552;4488.147252022105;4491.6182124519455;4492.618127459154;4493.662975276851;4494.775261236941;4496.707713998596;4412;4413.6910416270875;4440.4893437254805;4451.221036318648;4468.530804265554;4426.955730442686;4432.623227025707;4440.86677399677;4443.822247110112;4462.866114016585;3965.7422267552806;3974.225026119908;3975.8210880510446;3985.900352491211;3986.063275130342;5534.976029434527;5608.943910560883;5621.409751976024;5637.210790489294;5663.32040155184;5231.110711179109;5242.1088414969545;5245.527902488794;5247.632665713401;5271.472852714698;5922.170896074553;6124.755009799603;6130;6132.478739307119;6139.938600613981;4436.423264975532;4474.709143905636;4485.663575231838;4486.259767138418;4492.820287188509;6127.479164270998;6320.178376811031;6341.143945567382;6344.936550634481;6376.234851817811;4646.721196728207;4719.3628860103445;4721.457032441244;4735.289706543977;4735.763211839394;4771.284307353924;4790.4251489820745;4801.18379875422;4824.782884770194;4835.443923948791;4891.926621100686;5017.724025178577;5052.469490703496;5356.384015838151;5371.973140134352;6097.664628445478;6144;6144.201253836973;6151.907721384183;6155.876882462326;1496.1621491964534;1496.3266530061517;1497.2407421279952;1506.367325723199;1507.3217052326497;966.3042609321277;1003.6500906281041;1004.4927311707687;1006.0945149365483;1018.3635227982511;5839.240898683144;5852.4440178183;5859.44335288147;5861.531077513874;5865.3254875689845;6169.753209871555;6282.110229294576;6298.748050077946;6309.179806625109;6326.652034138075;5826.300843898759;5836;5848.766049358063;5870.354261031283;5897.734601942923;3273.361694469603;3278.67213278675;3293.945937300089;3296.901092967215;3311.784733992283;6311.558190926683;6515.967420162869;6528.347165283529;6606.471482281406;6607.339266073354;6450.41946224842;6468.191476065492;6498.122753428322;6500.3174666659315;6501.869962600722;6342.651154186564;6568.540202185801;6593.307702691341;6650.800475985729;6672.5996440212775;6350.031490238041;6355.5551111421755;6367.739452494297;6384.265809431789;6388.233411990591;6009.888170688437;6213.782517611862;6244.968775156095;6301.495880329471;6310.463610592968;6557.573757705924;6567.474602031922;6583.111279977334;6601.570897891622;6605.603663780189;4333.761643109533;4337.24098282793;4338.566143385636;4341.327094300388;4350.673699472489;6227.532935029801;6357.841053973502;6374.235091789015;6383.489320854228;6386.521010924106;6082.422169893853;6138.232720909887;6153.13856060143;6153.261608606996;6162.198914141133;5868.413158684098;6076.756929722762;6132.754689812357;6150.446459818638;6162.829062478115;6138.88694574645;6149.631022138686;6170.691465426621;6184.042212983784;6187.628742275478;6023.939760602513;6178.536609754196;6205.906911396423;6208;6230.638553012818;5992.850178745566;6047.637141771508;6048.758049677964;6052;6067.362926892612 20:22:45 INFO - PID 30698 | |5;yui.html;856.6362292287819;873.6854732296372;883.7613844262054;885.1458342699294;892.7455675132586;15637.687246255082;16155.676886462294;16279.430219942304;16297.511074667764;16299.51101466955;16486.75269870953;16981.15094245289;17030.659386812255;17121.57196070099;17125.229364678587;985.4727720669443;997.4912794474798;1014.5941623350682;1020.34187948773;1031.9071283584476;1035.0736091198373;1038.6728180623118;1039.4023436523992;1039.9584016639326;1050.2910535388621;1058.4707646176912;1066.5147357952112;1066.9253152279343;1067.3275836223168;1080.6595922284494;1062.5590379992293;1064.2922456566373;1065.6163781038858;1066.6586692258481;1080.1089101491261;774.5546310871272;779.5868189859384;782.8943092682472;786.288408989865;795.0300633227454;17103;17334.306627734877;17501.912490437593;17697.115144242736;17982.91008544949;18149.7277540837;18436.53908652281;18844.246230150777;19090.713639295423;19112.139953702117;13945.372458239404;14397.568072957829;14509.274536273144;14542.781858272134;14574.271286435636;3406.693397594204;3425.5889293284717;3441.9483707744403;3449.499822525745;3546.5921419036627;84022;85912.57043714804;85979.57010214908;86410;87863.12136878613;12297.692557686129;12562.120651554485;12563.748725025449;12597.622071337875;12607.243565386107;22734.317970460914;22814.771852281265;23168.18911338095;23333.533329333317;23376.64935025976;8185.549794761227;8339.791505212419;8344.165583441607;8360.790980225544;8374.916250837414;4000.6399424051974;4070.1859628074503;4079.265732168179;4080.7959602019782;4106.630403263721;4183.058811767328;4262.424572682648;4289;4347.891302717458;4350.543192964757;757.0763668324635;776.6699152860012;782.7573452229714;784.0238902566227;787.7872974296907;711.5446114486732;717.4081382859162;719.4496210399049;719.521518190408;729.0522320982701;11551.76896462066;11979.520819167135;12429.440675169639;12540.686482838002;12583.937080314723;726.4007194064917;728.6356821589205;739.94450416219;749.2245525880796;752.2815710995985;5457.449463438982;5545.584081193927;5636.633618814764;5787.479126878517;5847.736851841677;78343.60828195937;78934.60532697415;80434.5978270105;80587.59706201432;83080;72746;72841.27158728451;74299.62850185823;74374.6281268601;75246.62376688082;39660.40509392361;62033.689831551455;62439;62982.37017629765;63009;12335.321557314433;13091.869081309445;13113.754193351617;13120.540781072617;13191.538296159588;33882;33911.491327629614;33953.32093358169;34262.82868585641;35226.647733523365;40067.79966100151;40475.3928691064;41316.1736765269;41700.79149604232;41790;15204.315805788987;15210.239488025776;15359.001664891746;15486.612834679223;15614.063156210665;18827.6234475307;18944.62110757805;19138.7129193065;19191.90404047971;19358.70961935544;18133;18311.90844045771;18507.16717747678;18980.335688250845;19406.708899366804;15922.522324330288;16693.33226670968;16791.832081679026;16813.831861681225;17122.914385427994;15575.221238938235;16770.916145419196;16908;18454.630907382045;18879.528011799815;12662.683432914251;12950.093493455368;12961.740765184455;13234.205947643171;13635.454581816617;13503.932480337535;13599.184048957095;13999.44002239899;14006.43974241019;14061.929690351892 20:22:45 INFO - PID 30698 | __end_tp_report 20:22:45 INFO - PID 30698 | __start_cc_report 20:22:45 INFO - PID 30698 | _x_x_mozilla_cycle_collect,1945 20:22:45 INFO - PID 30698 | __end_cc_report 20:22:45 INFO - PID 30698 | __startTimestamp1494559365625__endTimestamp 20:22:45 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | ------- Summary: start ------- 20:22:45 INFO - PID 30698 | Number of tests: 6 20:22:45 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | [#0] dojo.html Cycles:165 Average:5737.95 Median:5940.23 stddev:672.40 (11.3%) stddev-sans-first:645.95 20:22:45 INFO - PID 30698 | Values: 3268.2 3281.4 3287.6 3308.9 3330.8 5599.5 5750.2 5752.5 5778.8 5788.0 5713.5 5748.3 5748.7 5750.5 5751.2 5128.1 5136.7 5162.1 5193.1 5202.9 5239.4 5254.5 5255.1 5262.9 5267.4 5100.4 5199.7 5225.3 5258.8 5317.2 5040.7 5079.5 5195.5 5208.8 5267.9 5064.4 5110.6 5146.5 5170.9 5172.5 5735.1 5756.5 5785.2 5794.1 5800.2 6067.2 6263.8 6266.0 6269.1 6269.6 6141.3 6158.2 6178.6 6198.5 6258.8 5836.2 5836.8 5840.6 5841.7 5859.0 6391.3 6393.4 6401.9 6404.1 6405.9 5977.8 6046.5 6057.2 6071.7 6102.2 5961.8 6032.8 6039.6 6119.8 6198.3 6201.8 6225.7 6232.7 6240.6 6243.0 6165.5 6187.3 6199.5 6201.9 6237.6 4626.6 4636.5 4679.0 4705.3 4757.9 4210.9 4222.8 4242.4 4258.6 4287.3 5827.9 5831.1 5839.4 5845.6 5896.6 6075.4 6144.0 6218.8 6253.3 6276.4 5767.3 5853.5 5887.5 5889.6 5900.4 5337.4 5346.2 5371.9 5395.2 5428.2 6231.6 6422.0 6482.4 6485.9 6488.4 6116.6 6126.3 6227.0 6229.8 6234.5 6471.8 6481.0 6483.9 6492.9 6497.5 6161.9 6163.4 6166.7 6170.5 6171.0 6071.7 6148.4 6157.2 6207.8 6241.2 6078.5 6100.4 6100.8 6103.9 6130.2 5872.3 5940.2 6058.9 6117.9 6120.9 5924.6 5980.3 6002.5 6005.2 6007.9 6047.0 6051.2 6053.3 6054.7 6059.7 5828.8 5888.3 5890.4 5891.3 5893.8 20:22:45 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | [#1] ext.html Cycles:180 Average:38737.85 Median:33828.58 stddev:60344.60 (178.4%) stddev-sans-first:60446.29 20:22:45 INFO - PID 30698 | Values: 698.5 779.5 800.3 1135.4 1158.1 28698.7 32839.5 35332.5 35367.3 35535.0 38205.6 38478.2 38549.6 38589.4 38612.6 5561.6 7169.2 7310.8 7311.2 7316.9 5684.5 7125.8 7306.8 7310.3 7312.7 7388.9 7432.3 7443.2 7444.9 7449.7 5608.6 7324.1 7383.8 7389.0 7389.2 5696.3 7052.7 7236.5 7245.0 7250.2 34570.0 34631.0 34874.5 34878.5 34981.5 3436.6 3457.3 3465.4 3480.4 3481.7 27112.0 27182.5 27201.7 27243.3 27445.6 3748.9 3777.9 3794.1 3795.5 3836.2 187807.0 187920.0 188594.0 188604.0 189079.0 44498.3 44828.0 44840.0 44917.6 44980.6 45996.0 46241.8 46286.3 46377.3 46405.0 15187.2 15251.5 15253.7 15350.8 15352.6 11206.9 11411.0 12513.6 12552.4 12622.4 12450.1 12670.4 12672.8 12783.2 12803.8 5304.9 5355.7 5377.0 5481.8 5516.4 1070.8 1087.2 1110.4 1111.9 1113.4 24650.4 24878.0 25040.9 25205.9 25481.0 1189.6 1193.6 1197.2 1199.6 1218.1 12778.9 12915.0 13111.6 13335.3 13436.9 255734.0 257473.0 260368.0 261997.0 262238.0 49332.0 49594.5 49660.8 49802.0 49833.8 1486.2 1532.3 1540.1 1546.9 1553.4 23764.5 24690.0 24750.6 24764.6 24801.9 36539.5 46442.5 47483.5 47506.0 47690.0 239233.0 241776.0 241783.0 241976.0 242837.0 28811.3 28869.9 33951.2 34144.3 34282.0 39270.6 39276.8 41044.0 41059.0 41121.6 31057.4 31411.7 31544.0 31940.8 32677.0 32242.4 32376.5 32924.2 33335.7 33706.0 36023.3 36057.8 37152.4 37326.8 37338.4 30383.2 30672.7 30709.2 31177.5 31659.2 24292.9 25050.4 25064.6 25483.0 25506.6 20:22:45 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | [#2] jquery.html Cycles:180 Average:32631.04 Median:2238.63 stddev:87243.02 (3897.2%) stddev-sans-first:87454.24 20:22:45 INFO - PID 30698 | Values: 422.6 434.4 435.8 454.6 458.2 18891.7 19908.2 20403.3 20624.8 20639.0 21224.7 23218.0 23417.8 23564.0 23786.8 5479.2 5711.0 5715.6 5723.4 5723.6 5411.4 5463.4 5615.2 5615.6 5623.2 5551.9 5560.3 5564.7 5568.2 5578.9 5475.8 5537.8 5566.2 5574.0 5576.2 5009.1 5042.3 5048.8 5049.4 5050.1 25686.6 26496.2 26593.2 26593.7 26788.5 2105.4 2147.9 2189.1 2195.2 2197.9 16986.9 17019.1 17121.5 17212.6 17395.0 2179.8 2234.3 2254.4 2257.2 2283.4 109969.0 112508.4 114218.0 114272.9 115990.0 12332.6 12514.9 12606.9 12614.2 12802.2 17831.6 17872.9 17886.4 17907.7 17914.0 8912.2 9225.8 9330.9 9340.9 9392.1 8592.4 8600.2 8674.9 8850.0 8886.2 7779.9 7990.3 8118.6 8151.2 8174.8 2197.8 2203.4 2213.6 2243.0 2307.4 1038.8 1062.7 1067.8 1072.1 1083.6 23610.5 25708.9 25900.2 26307.7 26600.5 1075.3 1086.8 1088.5 1090.5 1094.5 11089.7 11587.6 11666.7 11754.2 11791.4 502184.0 502551.0 514637.0 551121.0 556034.8 96577.5 99650.5 104104.5 104596.5 104969.0 1224.2 1241.4 1291.2 1295.2 1296.0 20420.7 20754.4 21057.4 21314.1 21378.6 45052.8 45399.5 45604.3 45964.3 46585.5 60930.0 61134.7 61993.7 62004.0 62273.7 9605.8 9799.7 9824.3 9854.3 9931.8 14676.9 14883.6 15242.5 15540.8 15680.8 12738.9 12758.0 12785.0 12798.7 13157.8 12318.2 12501.3 12567.1 12659.6 13031.0 13071.7 13417.5 13852.9 13883.4 14550.7 9583.0 9618.1 9840.0 10071.2 10092.7 12807.6 13185.9 13444.8 13542.5 13766.1 20:22:45 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | [#3] mootools.html Cycles:180 Average:7109.43 Median:3962.57 stddev:4509.89 (113.8%) stddev-sans-first:4500.90 20:22:45 INFO - PID 30698 | Values: 1230.5 1361.4 1411.7 1419.4 1438.0 9238.5 10767.2 11481.2 11519.7 11520.3 11138.7 11251.0 11258.3 11261.9 11267.9 1953.0 2344.7 2386.7 2387.7 2388.6 2048.0 2061.9 2063.0 2295.5 2396.2 2270.7 2276.7 2278.8 2281.1 2284.5 2230.0 2234.7 2257.9 2259.1 2259.1 2188.9 2206.1 2242.4 2263.9 2291.1 10414.5 10489.5 10501.8 10867.2 10961.5 6085.7 6279.7 6281.2 6297.2 6298.4 3681.8 3835.6 3891.7 3954.2 3971.0 1235.9 1349.6 1392.4 1434.3 1443.1 16608.2 16632.1 16635.4 16645.9 16676.2 5192.4 5305.6 5563.4 5565.6 5605.8 13698.2 13728.7 13733.9 13751.7 13755.2 6384.3 6389.5 6434.5 6437.2 6439.9 5826.2 5851.8 5889.0 5914.6 5947.3 3993.6 4113.5 4418.6 4571.7 4604.9 1363.2 1394.4 1394.8 1415.3 1416.7 876.6 887.5 899.6 910.1 910.8 6483.5 6576.6 6608.8 6618.6 6638.4 939.6 954.4 959.1 974.8 978.4 4413.8 4597.2 4782.3 4963.9 5082.4 14052.6 14767.6 14794.2 14867.8 15060.7 14231.4 14444.5 14727.0 14731.3 14754.2 9047.1 9273.5 9274.4 9277.0 9312.8 6863.8 6918.6 6946.7 6975.1 7194.1 12887.9 13024.7 13083.2 13300.2 13318.7 13378.7 13532.9 13645.0 13675.3 13861.2 9211.1 9241.5 9265.2 9380.1 9391.7 9427.5 9704.6 10432.3 10583.6 10963.5 9447.6 9574.4 9575.5 9852.2 9968.6 9413.7 9513.4 9518.5 9538.1 9577.6 7991.9 8039.4 8102.5 8112.4 8141.0 6320.2 6331.1 6342.7 6494.9 6522.5 6385.6 6465.0 6483.3 6708.0 6716.4 20:22:45 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | [#4] prototype.html Cycles:180 Average:5168.41 Median:5844.80 stddev:1534.09 (26.2%) stddev-sans-first:1495.99 20:22:45 INFO - PID 30698 | Values: 396.3 397.2 403.5 406.1 410.9 5750.6 5834.7 5835.5 5843.3 5846.3 5548.3 5675.3 5742.3 5777.7 5792.5 4438.5 4453.1 4474.1 4487.1 4488.1 4491.6 4492.6 4493.7 4494.8 4496.7 4412.0 4413.7 4440.5 4451.2 4468.5 4427.0 4432.6 4440.9 4443.8 4462.9 3965.7 3974.2 3975.8 3985.9 3986.1 5535.0 5608.9 5621.4 5637.2 5663.3 5231.1 5242.1 5245.5 5247.6 5271.5 5922.2 6124.8 6130.0 6132.5 6139.9 4436.4 4474.7 4485.7 4486.3 4492.8 6127.5 6320.2 6341.1 6344.9 6376.2 4646.7 4719.4 4721.5 4735.3 4735.8 4771.3 4790.4 4801.2 4824.8 4835.4 4891.9 5017.7 5052.5 5356.4 5372.0 6097.7 6144.0 6144.2 6151.9 6155.9 1496.2 1496.3 1497.2 1506.4 1507.3 966.3 1003.7 1004.5 1006.1 1018.4 5839.2 5852.4 5859.4 5861.5 5865.3 6169.8 6282.1 6298.7 6309.2 6326.7 5826.3 5836.0 5848.8 5870.4 5897.7 3273.4 3278.7 3293.9 3296.9 3311.8 6311.6 6516.0 6528.3 6606.5 6607.3 6450.4 6468.2 6498.1 6500.3 6501.9 6342.7 6568.5 6593.3 6650.8 6672.6 6350.0 6355.6 6367.7 6384.3 6388.2 6009.9 6213.8 6245.0 6301.5 6310.5 6557.6 6567.5 6583.1 6601.6 6605.6 4333.8 4337.2 4338.6 4341.3 4350.7 6227.5 6357.8 6374.2 6383.5 6386.5 6082.4 6138.2 6153.1 6153.3 6162.2 5868.4 6076.8 6132.8 6150.4 6162.8 6138.9 6149.6 6170.7 6184.0 6187.6 6023.9 6178.5 6205.9 6208.0 6230.6 5992.9 6047.6 6048.8 6052.0 6067.4 20:22:45 INFO - PID 30698 | 20:22:45 INFO - PID 30698 | [#5] yui.html Cycles:180 Average:18499.92 Median:19275.31 stddev:22280.66 (115.6%) stddev-sans-first:22303.77 20:22:45 INFO - PID 30698 | Values: 856.6 873.7 883.8 885.1 892.7 15637.7 16155.7 16279.4 16297.5 16299.5 16486.8 16981.2 17030.7 17121.6 17125.2 985.5 997.5 1014.6 1020.3 1031.9 1035.1 1038.7 1039.4 1040.0 1050.3 1058.5 1066.5 1066.9 1067.3 1080.7 1062.6 1064.3 1065.6 1066.7 1080.1 774.6 779.6 782.9 786.3 795.0 17103.0 17334.3 17501.9 17697.1 17982.9 18149.7 18436.5 18844.2 19090.7 19112.1 13945.4 14397.6 14509.3 14542.8 14574.3 3406.7 3425.6 3441.9 3449.5 3546.6 84022.0 85912.6 85979.6 86410.0 87863.1 12297.7 12562.1 12563.7 12597.6 12607.2 22734.3 22814.8 23168.2 23333.5 23376.6 8185.5 8339.8 8344.2 8360.8 8374.9 4000.6 4070.2 4079.3 4080.8 4106.6 4183.1 4262.4 4289.0 4347.9 4350.5 757.1 776.7 782.8 784.0 787.8 711.5 717.4 719.4 719.5 729.1 11551.8 11979.5 12429.4 12540.7 12583.9 726.4 728.6 739.9 749.2 752.3 5457.4 5545.6 5636.6 5787.5 5847.7 78343.6 78934.6 80434.6 80587.6 83080.0 72746.0 72841.3 74299.6 74374.6 75246.6 39660.4 62033.7 62439.0 62982.4 63009.0 12335.3 13091.9 13113.8 13120.5 13191.5 33882.0 33911.5 33953.3 34262.8 35226.6 40067.8 40475.4 41316.2 41700.8 41790.0 15204.3 15210.2 15359.0 15486.6 15614.1 18827.6 18944.6 19138.7 19191.9 19358.7 18133.0 18311.9 18507.2 18980.3 19406.7 15922.5 16693.3 16791.8 16813.8 17122.9 15575.2 16770.9 16908.0 18454.6 18879.5 12662.7 12950.1 12961.7 13234.2 13635.5 13503.9 13599.2 13999.4 14006.4 14061.9 20:22:45 INFO - PID 30698 | -------- Summary: end -------- 20:22:45 INFO - PID 30698 | 20:22:46 INFO - TEST-INFO | 30698: exit 0 20:22:46 INFO - TEST-OK | dromaeo_css | took 1115137ms 20:22:46 INFO - TEST-START | kraken 20:22:46 INFO - operating with platform_type : linux_ 20:22:46 INFO - Initialising browser for kraken test... 20:22:46 INFO - TEST-INFO | started process 31031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfetxw/profile http://localhost:36532/getInfo.html) 20:22:50 INFO - PID 31031 | __metrics Screen width/height:1600/1200 20:22:50 INFO - PID 31031 | colorDepth:24 20:22:50 INFO - PID 31031 | Browser inner width/height: 1024/695 20:22:50 INFO - PID 31031 | __metrics 20:22:51 INFO - PID 31031 | 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" 20:22:51 INFO - PID 31031 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:22:52 INFO - TEST-INFO | 31031: exit 0 20:22:52 INFO - Browser initialized. 20:22:52 INFO - Running cycle 1/1 for kraken test... 20:22:52 INFO - TEST-INFO | started process 31129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfetxw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:04 INFO - PID 31129 | RSS: Main: 144134144 20:23:04 INFO - PID 31129 | 20:23:06 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36532/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:07 INFO - PID 31129 | RSS: Main: 217890816 20:23:07 INFO - PID 31129 | 20:23:10 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36532/tests/kraken/driver.html?testName=audio-dft) 20:23:10 INFO - PID 31129 | RSS: Main: 178720768 20:23:10 INFO - PID 31129 | 20:23:13 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36532/tests/kraken/driver.html?testName=audio-fft) 20:23:14 INFO - PID 31129 | RSS: Main: 259104768 20:23:14 INFO - PID 31129 | 20:23:16 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36532/tests/kraken/driver.html?testName=audio-oscillator) 20:23:16 INFO - PID 31129 | RSS: Main: 170999808 20:23:16 INFO - PID 31129 | 20:23:18 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:23:19 INFO - PID 31129 | RSS: Main: 174034944 20:23:19 INFO - PID 31129 | 20:23:22 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36532/tests/kraken/driver.html?testName=imaging-darkroom) 20:23:22 INFO - PID 31129 | RSS: Main: 230465536 20:23:22 INFO - PID 31129 | 20:23:26 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36532/tests/kraken/driver.html?testName=imaging-desaturate) 20:23:26 INFO - PID 31129 | RSS: Main: 249569280 20:23:26 INFO - PID 31129 | 20:23:29 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36532/tests/kraken/driver.html?testName=json-parse-financial) 20:23:30 INFO - PID 31129 | RSS: Main: 264257536 20:23:30 INFO - PID 31129 | 20:23:31 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:32 INFO - PID 31129 | RSS: Main: 198430720 20:23:32 INFO - PID 31129 | 20:23:33 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36532/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:23:34 INFO - PID 31129 | RSS: Main: 202059776 20:23:34 INFO - PID 31129 | 20:23:36 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:37 INFO - PID 31129 | RSS: Main: 211451904 20:23:37 INFO - PID 31129 | 20:23:39 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:40 INFO - PID 31129 | RSS: Main: 221876224 20:23:40 INFO - PID 31129 | 20:23:43 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:43 INFO - PID 31129 | RSS: Main: 217165824 20:23:43 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | Cycle 1(1): loaded http://localhost:36532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36532/tests/kraken/driver.html?testName=ai-astar) 20:23:45 INFO - PID 31129 | RSS: Main: 266407936 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | __start_tp_report 20:23:45 INFO - PID 31129 | _x_x_mozilla_page_load 20:23:45 INFO - PID 31129 | _x_x_mozilla_page_load_details 20:23:45 INFO - PID 31129 | |i|pagename|runs| 20:23:45 INFO - PID 31129 | |0;ai-astar;108;110;111;110;110;110;110;110;109;112 20:23:45 INFO - PID 31129 | |1;audio-beat-detection;146;117;119;174;119;124;117;119;141;118 20:23:45 INFO - PID 31129 | |2;audio-dft;162;160;161;162;162;160;162;159;161;161 20:23:45 INFO - PID 31129 | |3;audio-fft;74;74;75;108;73;75;74;76;97;77 20:23:45 INFO - PID 31129 | |4;audio-oscillator;84;81;110;82;82;81;92;82;82;101 20:23:45 INFO - PID 31129 | |5;imaging-gaussian-blur;114;114;113;113;113;112;112;113;112;113 20:23:45 INFO - PID 31129 | |6;imaging-darkroom;147;146;146;147;146;146;148;147;146;147 20:23:45 INFO - PID 31129 | |7;imaging-desaturate;94;94;94;93;94;94;94;94;94;93 20:23:45 INFO - PID 31129 | |8;json-parse-financial;47;46;45;46;46;46;52;46;47;46 20:23:45 INFO - PID 31129 | |9;json-stringify-tinderbox;55;54;54;54;54;55;54;54;54;54 20:23:45 INFO - PID 31129 | |10;stanford-crypto-aes;79;77;80;79;80;78;86;79;78;79 20:23:45 INFO - PID 31129 | |11;stanford-crypto-ccm;133;124;124;123;127;128;125;122;166;130 20:23:45 INFO - PID 31129 | |12;stanford-crypto-pbkdf2;179;177;179;184;195;186;184;196;193;181 20:23:45 INFO - PID 31129 | |13;stanford-crypto-sha256-iterative;71;66;66;66;65;66;65;65;64;65 20:23:45 INFO - PID 31129 | __end_tp_report 20:23:45 INFO - PID 31129 | __start_cc_report 20:23:45 INFO - PID 31129 | _x_x_mozilla_cycle_collect,1682 20:23:45 INFO - PID 31129 | __end_cc_report 20:23:45 INFO - PID 31129 | __startTimestamp1494559425790__endTimestamp 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | ------- Summary: start ------- 20:23:45 INFO - PID 31129 | Number of tests: 14 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.05 (1.0%) stddev-sans-first:0.83 20:23:45 INFO - PID 31129 | Values: 108.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 109.0 112.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:121.50 stddev:18.83 (15.5%) stddev-sans-first:18.99 20:23:45 INFO - PID 31129 | Values: 146.0 117.0 119.0 174.0 119.0 124.0 117.0 119.0 141.0 118.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.05 20:23:45 INFO - PID 31129 | Values: 162.0 160.0 161.0 162.0 162.0 160.0 162.0 159.0 161.0 161.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:12.04 (16.0%) stddev-sans-first:12.55 20:23:45 INFO - PID 31129 | Values: 74.0 74.0 75.0 108.0 73.0 75.0 74.0 76.0 97.0 77.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:82.00 stddev:10.14 (12.4%) stddev-sans-first:10.67 20:23:45 INFO - PID 31129 | Values: 84.0 81.0 110.0 82.0 82.0 81.0 92.0 82.0 82.0 101.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 20:23:45 INFO - PID 31129 | Values: 114.0 114.0 113.0 113.0 113.0 112.0 112.0 113.0 112.0 113.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 20:23:45 INFO - PID 31129 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 148.0 147.0 146.0 147.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:23:45 INFO - PID 31129 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 93.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:46.00 stddev:1.95 (4.2%) stddev-sans-first:2.06 20:23:45 INFO - PID 31129 | Values: 47.0 46.0 45.0 46.0 46.0 46.0 52.0 46.0 47.0 46.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 20:23:45 INFO - PID 31129 | Values: 55.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 54.0 54.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.46 (3.1%) stddev-sans-first:2.60 20:23:45 INFO - PID 31129 | Values: 79.0 77.0 80.0 79.0 80.0 78.0 86.0 79.0 78.0 79.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:127.50 stddev:13.03 (10.2%) stddev-sans-first:13.78 20:23:45 INFO - PID 31129 | Values: 133.0 124.0 124.0 123.0 127.0 128.0 125.0 122.0 166.0 130.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:185.00 stddev:6.98 (3.8%) stddev-sans-first:7.01 20:23:45 INFO - PID 31129 | Values: 179.0 177.0 179.0 184.0 195.0 186.0 184.0 196.0 193.0 181.0 20:23:45 INFO - PID 31129 | 20:23:45 INFO - PID 31129 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.91 (2.9%) stddev-sans-first:0.71 20:23:45 INFO - PID 31129 | Values: 71.0 66.0 66.0 66.0 65.0 66.0 65.0 65.0 64.0 65.0 20:23:45 INFO - PID 31129 | -------- Summary: end -------- 20:23:45 INFO - PID 31129 | 20:23:46 INFO - TEST-INFO | 31129: exit 0 20:23:46 INFO - TEST-OK | kraken | took 60427ms 20:23:46 INFO - SUITE-END | took 1175s 20:23:46 INFO - Completed test suite (00:19:35) 20:23:46 INFO - javascript benchmark 20:23:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7675.934929670926, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.150280926957, 3281.3601347737185, 3287.5726155599777, 3308.8841890533836, 3330.78349907256, 5599.524040456556, 5750.1949727038245, 5752.511036561892, 5778.76884924603, 5788.0, 5713.542916566675, 5748.310202775673, 5748.741306641201, 5750.453706897838, 5751.223584816049, 5128.102582048136, 5136.691798492084, 5162.096633089213, 5193.065248255312, 5202.947970520303, 5239.3712754469325, 5254.500822421864, 5255.0803609368395, 5262.894742105155, 5267.446918073604, 5100.438951715309, 5199.714015729133, 5225.294585231002, 5258.789648414059, 5317.175837745136, 5040.697558146523, 5079.492050794928, 5195.5324020837925, 5208.765605547722, 5267.894642107156, 5064.366954130734, 5110.591152707774, 5146.511081447256, 5170.922436163461, 5172.456892026321, 5735.139729040678, 5756.481916627482, 5785.190073389686, 5794.1308803679785, 5800.187973683645, 6067.24159480065, 6263.843403914893, 6265.968670156665, 6269.059641053833, 6269.592476489013, 6141.332587233735, 6158.1686472326555, 6178.567500274982, 6198.504119670415, 6258.843528911768, 5836.241288632451, 5836.795712150054, 5840.649561026352, 5841.7371218295275, 5859.0, 6391.265004524539, 6393.392627700361, 6401.9039714404325, 6404.135441715402, 6405.871882562323, 5977.790777322773, 6046.486048685823, 6057.242844644419, 6071.726772295257, 6102.186302349175, 5961.821145365646, 6032.788852390146, 6039.63762174271, 6119.816953237485, 6198.2871969723155, 6201.7519299228425, 6225.688715564294, 6232.657203853832, 6240.594361366497, 6243.0, 6165.537584681167, 6187.257529096537, 6199.504039676815, 6201.937980620226, 6237.625742455467, 4626.606738427271, 4636.466806317249, 4678.95321046792, 4705.294205869079, 4757.9286310705365, 4210.894727631834, 4222.809973551198, 4242.406063151161, 4258.574142585717, 4287.292596721569, 5827.883442331215, 5831.06702927538, 5839.416058394211, 5845.561582881301, 5896.587238893322, 6075.362086980804, 6144.047672610753, 6218.844528886723, 6253.312135665074, 6276.403741644536, 5767.250257466502, 5853.5317174625925, 5887.470127688529, 5889.587728858939, 5900.439458251545, 5337.412884582693, 5346.1713434417725, 5371.946280537223, 5395.244665746799, 5428.212909128154, 6231.563790534619, 6422.03669449577, 6482.416582507597, 6485.902711459237, 6488.351164883474, 6116.579253789288, 6126.334466362847, 6226.968865155645, 6229.781957631461, 6234.501239900887, 6471.838204044937, 6480.967595161994, 6483.935160648522, 6492.902606461002, 6497.545171837926, 6161.876762464815, 6163.35284795108, 6166.722497487534, 6170.475509581735, 6170.969145154425, 6071.666058366833, 6148.354422785722, 6157.168782214523, 6207.751689932533, 6241.188645476059, 6078.483328916915, 6100.420460056288, 6100.847478813065, 6103.877922441615, 6130.172426722514, 5872.324682661549, 5940.227770389822, 6058.878822423439, 6117.908231376444, 6120.908186377297, 5924.6149000314845, 5980.312264089685, 6002.459778619946, 6005.189299444519, 6007.90988135187, 6046.97201475759, 6051.152838602511, 6053.273607166992, 6054.7275372607455, 6059.697015149137, 5828.766849326149, 5888.293404791452, 5890.352061273342, 5891.263592050994, 5893.823185304448], "value": 5691.119797334026, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.4935921456944, 779.485539543901, 800.3157300508066, 1135.3698697223042, 1158.073541167067, 28698.713012869892, 32839.50740738891, 35332.47001294982, 35367.2926541469, 35535.0, 38205.61794382055, 38478.23043539128, 38549.61450385495, 38589.42115868264, 38612.61387386125, 5561.5828812839, 7169.211386747466, 7310.81722956925, 7311.195768465464, 7316.853662926738, 5684.5452363811, 7125.8218544536285, 7306.780796576111, 7310.2689731027, 7312.670929808145, 7388.852222955537, 7432.256774322578, 7443.181250062489, 7444.8883266751045, 7449.702011919544, 5608.5793565482345, 7324.121105467325, 7383.778486645409, 7389.0, 7389.2241314662, 5696.344920334173, 7052.717891284343, 7236.49344545882, 7245.0, 7250.2024777274455, 34570.0, 34631.0, 34874.47688284678, 34878.476822847675, 34981.47527787085, 3436.621971583124, 3457.3258214648154, 3465.42820434628, 3480.4083305838067, 3481.721462283011, 27112.0, 27182.45635087287, 27201.727982720116, 27243.318917027034, 27445.58831617527, 3748.8687895923513, 3777.924441511182, 3794.1083845296334, 3795.4686343911876, 3836.2135762168687, 187807.0, 187920.0, 188594.0, 188604.0, 189079.0, 44498.327675593595, 44828.0, 44840.0, 44917.55082449199, 44980.55019449829, 45996.0, 46241.7687911565, 46286.305705414445, 46377.30434043492, 46405.0, 15187.240637968278, 15251.542453726406, 15253.694926101416, 15350.769738453931, 15352.616184595474, 11206.887931120747, 11411.0, 12513.562025329253, 12552.435140418704, 12622.431990560446, 12450.128491005542, 12670.36648167588, 12672.80990785139, 12783.233006019482, 12803.807942880865, 5304.92042619361, 5355.678659280456, 5377.0, 5481.835544933659, 5516.448355164452, 1070.7590792071878, 1087.211771465681, 1110.3948348150277, 1111.8721347045032, 1113.3709454158375, 24650.383740406276, 24878.0, 25040.874795625907, 25205.87397063003, 25481.0, 1189.6371606660052, 1193.6359410379744, 1197.161986609377, 1199.6161228406827, 1218.0742635596832, 12778.936105319413, 12915.0, 13111.582873695383, 13335.333233338488, 13436.932815336057, 255734.0, 257473.0, 260368.0, 261997.0, 262238.0, 49332.0, 49594.50405495899, 49660.751696241285, 49802.0, 49833.75083124561, 1486.1751727790963, 1532.348751780511, 1540.106738091904, 1546.9226538673022, 1553.4252326639216, 23764.52470950606, 24690.01239950382, 24750.628740568547, 24764.628530572416, 24801.87599061993, 36539.451908220864, 46442.535574645175, 47483.52516474929, 47506.0, 47690.04619907652, 239233.0, 241776.0, 241783.0, 241976.0, 242837.0, 28811.254536910066, 28869.855650722453, 33951.15122121967, 34144.317113658086, 34282.0, 39270.60729392784, 39276.803615981735, 41044.0, 41059.0, 41121.58878411297, 31057.378852423277, 31411.685883140875, 31544.0, 31940.84029579837, 32677.0, 32242.35515289634, 32376.514352285205, 32924.1768955778, 33335.66664333326, 33706.0, 36023.27953440969, 36057.819710901276, 37152.44271335878, 37326.81336593408, 37338.43992340063, 30383.24041898882, 30672.693273067875, 30709.23226919345, 31177.53233701451, 31659.20851978719, 24292.878535607917, 25050.37374065663, 25064.62403063992, 25483.0, 25506.617400738633], "value": 16729.34569488277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.64920116303455, 434.3961892968772, 435.7821089455271, 454.5954100850244, 458.22559873813253, 18891.716624250646, 19908.203671853127, 20403.285884994028, 20624.793752062476, 20639.0, 21224.681629775565, 23218.0, 23417.765822341815, 23564.0, 23786.76213237867, 5479.1781232815, 5711.0, 5715.571332150084, 5723.370429252779, 5723.627964182315, 5411.350637923435, 5463.426340234278, 5615.185798059279, 5615.5507559395355, 5623.184638227475, 5551.8889622207535, 5560.277163968678, 5564.666120032791, 5568.248286481314, 5578.888422231553, 5475.780968761244, 5537.8061767838135, 5566.192902029183, 5574.0, 5576.219329293902, 5009.073321435546, 5042.294078828967, 5048.7980480780725, 5049.394072711299, 5050.116229659831, 25686.614700779504, 26496.205113846423, 26593.202203933914, 26593.734062659318, 26788.464230715275, 2105.357865850915, 2147.892605369741, 2189.1243502599086, 2195.242641288769, 2197.9340619781433, 16986.915065424717, 17019.149042547822, 17121.486355409357, 17212.56968575783, 17395.0, 2179.8256139508803, 2234.2850287907877, 2254.357508110197, 2257.164849005862, 2283.394900351408, 109969.0, 112508.43745781301, 114218.0, 114272.85727142706, 115990.0, 12332.568360107532, 12514.937425312815, 12606.936965315115, 12614.243145411305, 12802.16785908913, 17831.554211144827, 17872.91063544674, 17886.373976910745, 17907.73138402925, 17914.0, 8912.153345432174, 9225.815483690423, 9330.860037099314, 9340.859887101698, 9392.107749763762, 8592.355573332025, 8600.182982616641, 8674.91325086741, 8850.026497085315, 8886.24466920306, 7779.922200778033, 7990.3208227300165, 8118.553479558563, 8151.225633564802, 8174.7956301092945, 2197.791209835063, 2203.3720389689183, 2213.557288542298, 2242.977570224277, 2307.4346785037774, 1038.8182068138046, 1062.6875808376649, 1067.829147336438, 1072.104792498257, 1083.5990683447017, 23610.52778944446, 25708.871455642602, 25900.22299331023, 26307.736922630913, 26600.467990640467, 1075.2688172042929, 1086.8261078227445, 1088.5373716170755, 1090.536521978156, 1094.5348227003492, 11089.667309980714, 11587.59443419493, 11666.70833229176, 11754.177207595387, 11791.410429478492, 502184.0, 502551.0, 514637.0, 551121.0, 556034.8146037371, 96577.51711241399, 99650.5017474908, 104104.47947760213, 104596.47701761442, 104969.0, 1224.2370985780447, 1241.366902879538, 1291.2446218962014, 1295.242283264301, 1295.9805602915965, 20420.651625062714, 20754.377368678965, 21057.368278951657, 21314.147434102462, 21378.57242855103, 45052.774736126106, 45399.546004540854, 45604.315935261664, 45964.31053534133, 46585.53414465812, 60930.0, 61134.694326528086, 61993.69003154955, 62004.0, 62273.68863155655, 9605.807883842424, 9799.657012004545, 9824.263180261652, 9854.310198286052, 9931.751706207402, 14676.853231467549, 14883.553493395215, 15242.542723718307, 15540.84459155394, 15680.76478852841, 12738.872611274139, 12758.0, 12785.0, 12798.68003299925, 13157.802632960322, 12318.199317044364, 12501.312427816194, 12567.120301578801, 12659.620211393672, 13031.0, 13071.738565228452, 13417.463301467831, 13852.861471385157, 13883.375248114062, 14550.708985820436, 9582.952085239529, 9618.134367906921, 9839.950800245953, 10071.244656650633, 10092.747681308027, 12807.551735689207, 13185.868141318464, 13444.798328025283, 13542.458301668217, 13766.105203161762], "value": 10452.781143053095, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.5262473947528, 1361.3737680666893, 1411.6823714664201, 1419.3754747910918, 1438.0077746355014, 9238.491882946444, 10767.24629275951, 11481.196316257865, 11519.712007199803, 11520.251183673055, 11138.665840024812, 11251.0, 11258.268212566198, 11261.887381126186, 11267.943660281708, 1952.9707054394196, 2344.7303560090554, 2386.72552656445, 2387.6776635154206, 2388.6058800298015, 2048.0169518631064, 2061.8556701030934, 2062.979370206294, 2295.5064661097863, 2396.18529699902, 2270.693456383392, 2276.726792784868, 2278.8290878184202, 2281.121768119278, 2284.463151159476, 2230.0, 2234.720659917502, 2257.8871056447274, 2259.1189436119926, 2259.141526220042, 2188.89055547222, 2206.0844749428966, 2242.4169715873827, 2263.898124584381, 2291.0950174681075, 10414.479276036243, 10489.475526223658, 10501.789964200749, 10867.184961127869, 10961.506732197071, 6085.726142323606, 6279.748810047593, 6281.214848143982, 6297.2128483939505, 6298.433141017331, 3681.7790932544135, 3835.5780864104927, 3891.727579069438, 3954.169624378884, 3970.980145099285, 1235.8516977962613, 1349.601867449105, 1392.3873495661876, 1434.2756907761618, 1443.0547991065869, 16608.169591520375, 16632.085235312054, 16635.41776037845, 16645.916770416192, 16676.16619169037, 5192.350956130484, 5305.62860599762, 5563.415841336682, 5565.638233514808, 5605.80379686709, 13698.178109313472, 13728.65678358049, 13733.862661373458, 13751.656208594664, 13755.243461609507, 6384.265809431975, 6389.488840892717, 6434.517411194179, 6437.227532696106, 6439.903401448982, 5826.2134611827705, 5851.795187168429, 5889.0, 5914.556408269397, 5947.31605865331, 3993.6206060424215, 4113.506379234451, 4418.646508279394, 4571.702839315434, 4604.907901841944, 1363.1820907455447, 1394.414345974693, 1394.7838085096826, 1415.3064998151037, 1416.6529200345776, 876.5660997806, 887.5207388010531, 899.6131663384676, 910.139917777707, 910.8406028945041, 6483.546151769331, 6576.605403675699, 6608.801735947929, 6618.569792963442, 6638.402543771083, 939.6194541210821, 954.4321128928416, 959.0553304994575, 974.7806743482802, 978.3738407419257, 4413.7793110344355, 4597.241455159928, 4782.258749893772, 4963.90072198554, 5082.440931497532, 14052.578422647337, 14767.630809229855, 14794.186319752302, 14867.776983345042, 15060.698786024219, 14231.430742770173, 14444.494442694666, 14727.0, 14731.263436828116, 14754.188519631309, 9047.095290470901, 9273.536323183815, 9274.44353338802, 9277.0, 9312.767180820534, 6863.794086177422, 6918.619475928872, 6946.680130775137, 6975.093237879246, 7194.100737407824, 12887.871121289043, 13024.739505210033, 13083.215007099605, 13300.201987880759, 13318.667033324244, 13378.665533361354, 13532.93233533826, 13645.0, 13675.316234188052, 13861.168329900238, 9211.078892110736, 9241.537923103953, 9265.166135047608, 9380.108889655472, 9391.671291505038, 9427.528623568931, 9704.563294651898, 10432.321899076536, 10583.62957296491, 10963.50664220096, 9447.574859131219, 9574.425534467955, 9575.473348965874, 9852.211823053995, 9968.55141518619, 9413.717588472357, 9513.429194248367, 9518.476483793458, 9538.093881081286, 9577.569009394454, 7991.880121798294, 8039.437239393186, 8102.513849169069, 8112.43212975086, 8141.0, 6320.241571011508, 6331.0819931110655, 6342.746290148342, 6494.870102598016, 6522.543421960418, 6385.584936979081, 6464.967675161594, 6483.2544257411, 6708.021133765454, 6716.395524402632], "value": 5371.518874587839, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.26492855752576, 397.24126917587415, 403.5097356711595, 406.0721251939318, 410.8562003298844, 5750.6262092963925, 5834.745529711111, 5835.503982161511, 5843.276233511114, 5846.327672317685, 5548.335896036907, 5675.34733505647, 5742.28221472316, 5777.711114444282, 5792.536597072235, 4438.511763705989, 4453.131639330332, 4474.060447306069, 4487.080148569552, 4488.147252022105, 4491.6182124519455, 4492.618127459154, 4493.662975276851, 4494.775261236941, 4496.707713998596, 4412.0, 4413.6910416270875, 4440.4893437254805, 4451.221036318648, 4468.530804265554, 4426.955730442686, 4432.623227025707, 4440.86677399677, 4443.822247110112, 4462.866114016585, 3965.7422267552806, 3974.225026119908, 3975.8210880510446, 3985.900352491211, 3986.063275130342, 5534.976029434527, 5608.943910560883, 5621.409751976024, 5637.210790489294, 5663.32040155184, 5231.110711179109, 5242.1088414969545, 5245.527902488794, 5247.632665713401, 5271.472852714698, 5922.170896074553, 6124.755009799603, 6130.0, 6132.478739307119, 6139.938600613981, 4436.423264975532, 4474.709143905636, 4485.663575231838, 4486.259767138418, 4492.820287188509, 6127.479164270998, 6320.178376811031, 6341.143945567382, 6344.936550634481, 6376.234851817811, 4646.721196728207, 4719.3628860103445, 4721.457032441244, 4735.289706543977, 4735.763211839394, 4771.284307353924, 4790.4251489820745, 4801.18379875422, 4824.782884770194, 4835.443923948791, 4891.926621100686, 5017.724025178577, 5052.469490703496, 5356.384015838151, 5371.973140134352, 6097.664628445478, 6144.0, 6144.201253836973, 6151.907721384183, 6155.876882462326, 1496.1621491964534, 1496.3266530061517, 1497.2407421279952, 1506.367325723199, 1507.3217052326497, 966.3042609321277, 1003.6500906281041, 1004.4927311707687, 1006.0945149365483, 1018.3635227982511, 5839.240898683144, 5852.4440178183, 5859.44335288147, 5861.531077513874, 5865.3254875689845, 6169.753209871555, 6282.110229294576, 6298.748050077946, 6309.179806625109, 6326.652034138075, 5826.300843898759, 5836.0, 5848.766049358063, 5870.354261031283, 5897.734601942923, 3273.361694469603, 3278.67213278675, 3293.945937300089, 3296.901092967215, 3311.784733992283, 6311.558190926683, 6515.967420162869, 6528.347165283529, 6606.471482281406, 6607.339266073354, 6450.41946224842, 6468.191476065492, 6498.122753428322, 6500.3174666659315, 6501.869962600722, 6342.651154186564, 6568.540202185801, 6593.307702691341, 6650.800475985729, 6672.5996440212775, 6350.031490238041, 6355.5551111421755, 6367.739452494297, 6384.265809431789, 6388.233411990591, 6009.888170688437, 6213.782517611862, 6244.968775156095, 6301.495880329471, 6310.463610592968, 6557.573757705924, 6567.474602031922, 6583.111279977334, 6601.570897891622, 6605.603663780189, 4333.761643109533, 4337.24098282793, 4338.566143385636, 4341.327094300388, 4350.673699472489, 6227.532935029801, 6357.841053973502, 6374.235091789015, 6383.489320854228, 6386.521010924106, 6082.422169893853, 6138.232720909887, 6153.13856060143, 6153.261608606996, 6162.198914141133, 5868.413158684098, 6076.756929722762, 6132.754689812357, 6150.446459818638, 6162.829062478115, 6138.88694574645, 6149.631022138686, 6170.691465426621, 6184.042212983784, 6187.628742275478, 6023.939760602513, 6178.536609754196, 6205.906911396423, 6208.0, 6230.638553012818, 5992.850178745566, 6047.637141771508, 6048.758049677964, 6052.0, 6067.362926892612], "value": 4683.6793338827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.6362292287819, 873.6854732296372, 883.7613844262054, 885.1458342699294, 892.7455675132586, 15637.687246255082, 16155.676886462294, 16279.430219942304, 16297.511074667764, 16299.51101466955, 16486.75269870953, 16981.15094245289, 17030.659386812255, 17121.57196070099, 17125.229364678587, 985.4727720669443, 997.4912794474798, 1014.5941623350682, 1020.34187948773, 1031.9071283584476, 1035.0736091198373, 1038.6728180623118, 1039.4023436523992, 1039.9584016639326, 1050.2910535388621, 1058.4707646176912, 1066.5147357952112, 1066.9253152279343, 1067.3275836223168, 1080.6595922284494, 1062.5590379992293, 1064.2922456566373, 1065.6163781038858, 1066.6586692258481, 1080.1089101491261, 774.5546310871272, 779.5868189859384, 782.8943092682472, 786.288408989865, 795.0300633227454, 17103.0, 17334.306627734877, 17501.912490437593, 17697.115144242736, 17982.91008544949, 18149.7277540837, 18436.53908652281, 18844.246230150777, 19090.713639295423, 19112.139953702117, 13945.372458239404, 14397.568072957829, 14509.274536273144, 14542.781858272134, 14574.271286435636, 3406.693397594204, 3425.5889293284717, 3441.9483707744403, 3449.499822525745, 3546.5921419036627, 84022.0, 85912.57043714804, 85979.57010214908, 86410.0, 87863.12136878613, 12297.692557686129, 12562.120651554485, 12563.748725025449, 12597.622071337875, 12607.243565386107, 22734.317970460914, 22814.771852281265, 23168.18911338095, 23333.533329333317, 23376.64935025976, 8185.549794761227, 8339.791505212419, 8344.165583441607, 8360.790980225544, 8374.916250837414, 4000.6399424051974, 4070.1859628074503, 4079.265732168179, 4080.7959602019782, 4106.630403263721, 4183.058811767328, 4262.424572682648, 4289.0, 4347.891302717458, 4350.543192964757, 757.0763668324635, 776.6699152860012, 782.7573452229714, 784.0238902566227, 787.7872974296907, 711.5446114486732, 717.4081382859162, 719.4496210399049, 719.521518190408, 729.0522320982701, 11551.76896462066, 11979.520819167135, 12429.440675169639, 12540.686482838002, 12583.937080314723, 726.4007194064917, 728.6356821589205, 739.94450416219, 749.2245525880796, 752.2815710995985, 5457.449463438982, 5545.584081193927, 5636.633618814764, 5787.479126878517, 5847.736851841677, 78343.60828195937, 78934.60532697415, 80434.5978270105, 80587.59706201432, 83080.0, 72746.0, 72841.27158728451, 74299.62850185823, 74374.6281268601, 75246.62376688082, 39660.40509392361, 62033.689831551455, 62439.0, 62982.37017629765, 63009.0, 12335.321557314433, 13091.869081309445, 13113.754193351617, 13120.540781072617, 13191.538296159588, 33882.0, 33911.491327629614, 33953.32093358169, 34262.82868585641, 35226.647733523365, 40067.79966100151, 40475.3928691064, 41316.1736765269, 41700.79149604232, 41790.0, 15204.315805788987, 15210.239488025776, 15359.001664891746, 15486.612834679223, 15614.063156210665, 18827.6234475307, 18944.62110757805, 19138.7129193065, 19191.90404047971, 19358.70961935544, 18133.0, 18311.90844045771, 18507.16717747678, 18980.335688250845, 19406.708899366804, 15922.522324330288, 16693.33226670968, 16791.832081679026, 16813.831861681225, 17122.914385427994, 15575.221238938235, 16770.916145419196, 16908.0, 18454.630907382045, 18879.528011799815, 12662.683432914251, 12950.093493455368, 12961.740765184455, 13234.205947643171, 13635.454581816617, 13503.932480337535, 13599.184048957095, 13999.44002239899, 14006.43974241019, 14061.929690351892], "value": 8168.904654410373, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 119.0, 174.0, 119.0, 124.0, 117.0, 119.0, 141.0, 118.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 162.0, 162.0, 160.0, 162.0, 159.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 108.0, 73.0, 75.0, 74.0, 76.0, 97.0, 77.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 110.0, 82.0, 82.0, 81.0, 92.0, 82.0, 82.0, 101.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 46.0, 45.0, 46.0, 46.0, 46.0, 52.0, 46.0, 47.0, 46.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 80.0, 79.0, 80.0, 78.0, 86.0, 79.0, 78.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 124.0, 124.0, 123.0, 127.0, 128.0, 125.0, 122.0, 166.0, 130.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 179.0, 184.0, 195.0, 186.0, 184.0, 196.0, 193.0, 181.0], "value": 185.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 65.9, "unit": "score"}]}]} 20:23:47 INFO - Return code: 0 20:23:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:23:47 INFO - # TBPL SUCCESS # 20:23:47 INFO - Running post-action listener: _resource_record_post_action 20:23:47 INFO - [mozharness: 2017-05-12 03:23:47.129242Z] Finished run-tests step (success) 20:23:47 INFO - Running post-run listener: _resource_record_post_run 20:23:47 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 378310656; Read time: 8; Write time: 359008 20:23:47 INFO - TinderboxPrint: CPU usage
12.9% 20:23:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:23:47 INFO - TinderboxPrint: I/O write bytes / time
378,310,656 / 359,008 20:23:47 INFO - TinderboxPrint: CPU idle
8,296.1 (87.1%) 20:23:47 INFO - TinderboxPrint: CPU user
1,180.9 (12.4%) 20:23:47 INFO - TinderboxPrint: Swap in / out
0 / 0 20:23:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112087040; Read time: 0; Write time: 146204 20:23:47 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 266223616; Read time: 0; Write time: 212804 20:23:47 INFO - Running post-run listener: _upload_blobber_files 20:23:47 INFO - Blob upload gear active. 20:23:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:23:47 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 20:23:47 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'] 20:23:47 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 20:23:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:23:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:23:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:23:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:49 INFO - (blobuploader) - INFO - Done attempting. 20:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:50 INFO - (blobuploader) - INFO - Done attempting. 20:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:53 INFO - (blobuploader) - INFO - Done attempting. 20:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:53 INFO - (blobuploader) - INFO - Done attempting. 20:23:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:23:53 INFO - Return code: 0 20:23:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:23:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:23:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/058ecfb1a13beddc5aef5d2f9b52681bcc5baa5508c0e3253e2fa283995b68b68a24a9fcebf26d85361a33ba908c2b65103fbd2c68ca11dbbcdb7efb53c76e7f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a24afd821542c1fde3e363e904c809c464c7ea38f7160b0f432b139633e236138ef9c019ecb94468d39b0c25989f14066eae275883418ddbcb6fc3bea8248263", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab944292ea563ed1b40600ecf8e79a1b35ca6f702ea9966eced0c83df70be5f83a8e1b2769ac1efeb14c12afc63cbea35e36c25660304b3931e8660c76c25003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dfc3992d7b797656ae13052e8c3b69eae664935c1c1b13131fd0bbbbed450fb6fc458ba9e628c26d97ea0a42830c5b2a52c040574e638ea3ba665f30be60d99"} 20:23:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:23:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:23:53 INFO - Contents: 20:23:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/058ecfb1a13beddc5aef5d2f9b52681bcc5baa5508c0e3253e2fa283995b68b68a24a9fcebf26d85361a33ba908c2b65103fbd2c68ca11dbbcdb7efb53c76e7f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a24afd821542c1fde3e363e904c809c464c7ea38f7160b0f432b139633e236138ef9c019ecb94468d39b0c25989f14066eae275883418ddbcb6fc3bea8248263", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab944292ea563ed1b40600ecf8e79a1b35ca6f702ea9966eced0c83df70be5f83a8e1b2769ac1efeb14c12afc63cbea35e36c25660304b3931e8660c76c25003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dfc3992d7b797656ae13052e8c3b69eae664935c1c1b13131fd0bbbbed450fb6fc458ba9e628c26d97ea0a42830c5b2a52c040574e638ea3ba665f30be60d99"} 20:23:53 INFO - Running post-run listener: copy_logs_to_upload_dir 20:23:53 INFO - Copying logs to upload dir... 20:23:53 INFO - mkdir: /builds/slave/test/build/upload/logs 20:23:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.344491 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-11 20:23:53.190727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 20:23:53.193870) ========= 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=1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/058ecfb1a13beddc5aef5d2f9b52681bcc5baa5508c0e3253e2fa283995b68b68a24a9fcebf26d85361a33ba908c2b65103fbd2c68ca11dbbcdb7efb53c76e7f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a24afd821542c1fde3e363e904c809c464c7ea38f7160b0f432b139633e236138ef9c019ecb94468d39b0c25989f14066eae275883418ddbcb6fc3bea8248263", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab944292ea563ed1b40600ecf8e79a1b35ca6f702ea9966eced0c83df70be5f83a8e1b2769ac1efeb14c12afc63cbea35e36c25660304b3931e8660c76c25003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dfc3992d7b797656ae13052e8c3b69eae664935c1c1b13131fd0bbbbed450fb6fc458ba9e628c26d97ea0a42830c5b2a52c040574e638ea3ba665f30be60d99"} build_url:https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/BKFRYa33Sp28ywOhxvTeGg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/058ecfb1a13beddc5aef5d2f9b52681bcc5baa5508c0e3253e2fa283995b68b68a24a9fcebf26d85361a33ba908c2b65103fbd2c68ca11dbbcdb7efb53c76e7f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a24afd821542c1fde3e363e904c809c464c7ea38f7160b0f432b139633e236138ef9c019ecb94468d39b0c25989f14066eae275883418ddbcb6fc3bea8248263", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab944292ea563ed1b40600ecf8e79a1b35ca6f702ea9966eced0c83df70be5f83a8e1b2769ac1efeb14c12afc63cbea35e36c25660304b3931e8660c76c25003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dfc3992d7b797656ae13052e8c3b69eae664935c1c1b13131fd0bbbbed450fb6fc458ba9e628c26d97ea0a42830c5b2a52c040574e638ea3ba665f30be60d99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 20:23:53.220026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 20:23:53.220416) ========= 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=1258088b6da462a47ba2cd90000001a2-1494558181.665882-1052980116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 20:23:53.306547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 20:23:53.306941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 20:23:53.307425) ========= ========= Total master_lag: 0.16 =========