builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1494932505.5 results: success (0) revision: 5e81f95116344b68975ac5aba30a8bb9eeae6b32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:45.502899) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:45.503320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:45.503628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:45.515190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:45.515468) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 04:01:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.6M=0.001s 2017-05-16 04:01:46 (16.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:45.657625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:45.657930) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018246 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:45.714596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 04:01:45.714936) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e81f95116344b68975ac5aba30a8bb9eeae6b32 --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 5e81f95116344b68975ac5aba30a8bb9eeae6b32 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 04:01:46,658 truncating revision to first 12 chars 2017-05-16 04:01:46,658 Setting DEBUG logging. 2017-05-16 04:01:46,658 attempt 1/10 2017-05-16 04:01:46,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e81f9511634?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 04:01:47,552 unpacking tar archive at: mozilla-central-5e81f9511634/testing/mozharness/ program finished with exit code 0 elapsedTime=1.201424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 04:01:46.931803) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:46.932130) ========= script_repo_revision: 5e81f95116344b68975ac5aba30a8bb9eeae6b32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:46.932502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:46.932783) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 04:01:46.944427) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-16 04:01:46.944808) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:47 INFO - MultiFileLogger online at 20170516 04:01:47 in /builds/slave/test 04:01:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:01:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:47 INFO - {'append_to_log': False, 04:01:47 INFO - 'base_work_dir': '/builds/slave/test', 04:01:47 INFO - 'blob_upload_branch': 'Firefox', 04:01:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:47 INFO - 'branch': 'Firefox', 04:01:47 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:47 INFO - 'config_files': ('talos/linux_config.py',), 04:01:47 INFO - 'default_actions': ('clobber', 04:01:47 INFO - 'read-buildbot-config', 04:01:47 INFO - 'download-and-extract', 04:01:47 INFO - 'populate-webroot', 04:01:47 INFO - 'create-virtualenv', 04:01:47 INFO - 'install', 04:01:47 INFO - 'run-tests'), 04:01:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:47 INFO - 'download_minidump_stackwalk': True, 04:01:47 INFO - 'download_symbols': 'ondemand', 04:01:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:47 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:47 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:47 INFO - 'gecko_profile': False, 04:01:47 INFO - 'gecko_profile_interval': 0, 04:01:47 INFO - 'installer_path': 'installer.exe', 04:01:47 INFO - 'log_level': 'info', 04:01:47 INFO - 'log_name': 'talos', 04:01:47 INFO - 'log_to_console': True, 04:01:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:47 INFO - 'opt_config_files': (), 04:01:47 INFO - 'pip_index': False, 04:01:47 INFO - 'suite': 'dromaeojs-e10s', 04:01:47 INFO - 'system_bits': '32', 04:01:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:47 INFO - 'title': 'talos-linux64-ix-069', 04:01:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:47 INFO - 'use_talos_json': True, 04:01:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:47 INFO - 'work_dir': 'build'} 04:01:47 INFO - [mozharness: 2017-05-16 11:01:47.994692Z] Running clobber step. 04:01:47 INFO - Running pre-action listener: _resource_record_pre_action 04:01:47 INFO - Running main action method: clobber 04:01:47 INFO - rmtree: /builds/slave/test/build 04:01:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:49 INFO - Running post-action listener: _resource_record_post_action 04:01:49 INFO - [mozharness: 2017-05-16 11:01:49.526724Z] Finished clobber step (success) 04:01:49 INFO - [mozharness: 2017-05-16 11:01:49.526825Z] Running read-buildbot-config step. 04:01:49 INFO - Running pre-action listener: _resource_record_pre_action 04:01:49 INFO - Running main action method: read_buildbot_config 04:01:49 INFO - Using buildbot properties: 04:01:49 INFO - { 04:01:49 INFO - "project": "", 04:01:49 INFO - "product": "firefox", 04:01:49 INFO - "who": "cbook@mozilla.com", 04:01:49 INFO - "installer_path": "public/build/target.tar.bz2", 04:01:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 04:01:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:01:49 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 04:01:49 INFO - "stage_platform": "linux64-stylo", 04:01:49 INFO - "basedir": "/builds/slave/test", 04:01:49 INFO - "buildnumber": 95, 04:01:49 INFO - "platform": "ubuntu64_hw_stylo", 04:01:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:01:49 INFO - "slavebuilddir": "test", 04:01:49 INFO - "taskId": "RTtGEm94Q_6omzfIhoI5Lw", 04:01:49 INFO - "branch": "mozilla-central", 04:01:49 INFO - "script_repo_revision": "production", 04:01:49 INFO - "revision": "5e81f95116344b68975ac5aba30a8bb9eeae6b32", 04:01:49 INFO - "slavename": "talos-linux64-ix-069", 04:01:49 INFO - "repo_path": "mozilla-central" 04:01:49 INFO - } 04:01:49 INFO - Finding installer, test and symbols from parent task. 04:01:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RTtGEm94Q_6omzfIhoI5Lw'}, attempt #1 04:01:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RTtGEm94Q_6omzfIhoI5Lw'}, attempt #1 04:01:50 INFO - Task dependencies: KbojJVZXTseTNqyB-IpQHQ 04:01:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ'}, attempt #1 04:01:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.tar.bz2 04:01:50 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/test_packages.json 04:01:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.crashreporter-symbols.zip 04:01:50 INFO - Running post-action listener: _resource_record_post_action 04:01:50 INFO - [mozharness: 2017-05-16 11:01:50.871896Z] Finished read-buildbot-config step (success) 04:01:50 INFO - [mozharness: 2017-05-16 11:01:50.872116Z] Running download-and-extract step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: download_and_extract 04:01:50 INFO - mkdir: /builds/slave/test/build/tests 04:01: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')]} 04:01:50 INFO - trying https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.test_packages.json 04:01:50 INFO - Downloading https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:01:51 INFO - Downloaded 986 bytes. 04:01:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:01:51 INFO - Using the following test package requirements: 04:01:51 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:01:51 INFO - u'common': [u'target.common.tests.zip'], 04:01:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:01:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:01:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:01:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:01:51 INFO - u'mozbase': [u'target.common.tests.zip'], 04:01:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:01:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:01:51 INFO - u'web-platform': [u'target.common.tests.zip', 04:01:51 INFO - u'target.web-platform.tests.zip'], 04:01:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:01:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:01:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.common.tests.zip 04:01:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:01:51 INFO - Fetch https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.common.tests.zip into memory 04:01:52 INFO - Content-Length response header: 62449481 04:01:52 INFO - Bytes received: 62449481 04:02:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:02:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.common.tests.zip 04:02:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:02:03 INFO - Fetch https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.common.tests.zip into memory 04:02:04 INFO - Content-Length response header: 62449481 04:02:04 INFO - Bytes received: 62449481 04:02:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.talos.tests.zip 04:02:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:02:16 INFO - Fetch https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.talos.tests.zip into memory 04:02:17 INFO - Content-Length response header: 14410013 04:02:17 INFO - Bytes received: 14410013 04:02:17 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')]} 04:02:17 INFO - trying https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.tar.bz2 04:02:17 INFO - Downloading https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:02:19 INFO - Downloaded 64933902 bytes. 04:02:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.tar.bz2 04:02:19 INFO - mkdir: /builds/slave/test/properties 04:02:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:02:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:02:19 INFO - Contents: 04:02:19 INFO - build_url:https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.tar.bz2 04:02:19 INFO - Running post-action listener: _resource_record_post_action 04:02:19 INFO - Running post-action listener: set_extra_try_arguments 04:02:19 INFO - [mozharness: 2017-05-16 11:02:19.049870Z] Finished download-and-extract step (success) 04:02:19 INFO - [mozharness: 2017-05-16 11:02:19.049968Z] Running populate-webroot step. 04:02:19 INFO - Running pre-action listener: _resource_record_pre_action 04:02:19 INFO - Running main action method: populate_webroot 04:02:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:02:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:02:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:02:19 INFO - '--tppagecycles', 04:02:19 INFO - '7'], 04:02:19 INFO - 'tests': ['tsvgm']}}, 04:02:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:02:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:02:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:02:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:02:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:02:19 INFO - 'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:02:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:02:19 INFO - 'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['damp', 'tps']}, 04:02:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:02:19 INFO - 'tests': ['damp', 'tps']}, 04:02:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['dromaeo_dom']}, 04:02:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:02:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:02:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:02:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['a11yr', 04:02:19 INFO - 'ts_paint', 04:02:19 INFO - 'tpaint', 04:02:19 INFO - 'sessionrestore', 04:02:19 INFO - 'sessionrestore_no_auto_restore', 04:02:19 INFO - 'tabpaint']}, 04:02:19 INFO - 'other-e10s': {'tests': ['a11yr', 04:02:19 INFO - 'ts_paint', 04:02:19 INFO - 'tpaint', 04:02:19 INFO - 'sessionrestore', 04:02:19 INFO - 'sessionrestore_no_auto_restore', 04:02:19 INFO - 'tabpaint']}, 04:02:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:02:19 INFO - 'ts_paint', 04:02:19 INFO - 'tpaint', 04:02:19 INFO - 'sessionrestore', 04:02:19 INFO - 'sessionrestore_no_auto_restore', 04:02:19 INFO - 'tabpaint']}, 04:02:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:02:19 INFO - 'ts_paint', 04:02:19 INFO - 'tpaint', 04:02:19 INFO - 'sessionrestore', 04:02:19 INFO - 'sessionrestore_no_auto_restore', 04:02:19 INFO - 'tabpaint']}, 04:02:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['a11yr', 04:02:19 INFO - 'ts_paint', 04:02:19 INFO - 'tpaint', 04:02:19 INFO - 'sessionrestore', 04:02:19 INFO - 'sessionrestore_no_auto_restore', 04:02:19 INFO - 'tabpaint']}, 04:02:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['a11yr', 04:02:19 INFO - 'ts_paint', 04:02:19 INFO - 'tpaint', 04:02:19 INFO - 'sessionrestore', 04:02:19 INFO - 'sessionrestore_no_auto_restore', 04:02:19 INFO - 'tabpaint']}, 04:02:19 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:02:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:02:19 INFO - 'bloom_basic_ref']}, 04:02:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['tsvgx', 04:02:19 INFO - 'tsvgr_opacity', 04:02:19 INFO - 'tart', 04:02:19 INFO - 'tscrollx', 04:02:19 INFO - 'cart', 04:02:19 INFO - 'tsvg_static']}, 04:02:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:02:19 INFO - 'tsvgr_opacity', 04:02:19 INFO - 'tart', 04:02:19 INFO - 'tscrollx', 04:02:19 INFO - 'cart', 04:02:19 INFO - 'tsvg_static']}, 04:02:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:02:19 INFO - 'talos_options': ['--disable-e10s'], 04:02:19 INFO - 'tests': ['tp5o']}, 04:02:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:02:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:02:19 INFO - 'talos_options': ['--disable-e10s', 04:02:19 INFO - '--xperf_path', 04:02:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:19 INFO - 'tests': ['tp5n']}, 04:02:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:02:19 INFO - 'talos_options': ['--xperf_path', 04:02:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:19 INFO - 'tests': ['tp5n']}}, 04:02:19 INFO - 'talos.zip': {'path': '', 04:02:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:02:19 INFO - Running post-action listener: _resource_record_post_action 04:02:19 INFO - [mozharness: 2017-05-16 11:02:19.063628Z] Finished populate-webroot step (success) 04:02:19 INFO - [mozharness: 2017-05-16 11:02:19.063716Z] Running create-virtualenv step. 04:02:19 INFO - Running pre-action listener: _resource_record_pre_action 04:02:19 INFO - Running main action method: create_virtualenv 04:02:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:02:19 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 04:02:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:02:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:02:19 INFO - Using real prefix '/usr' 04:02:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:02:19 INFO - Installing distribute.............................................................................................................................................................................................done. 04:02:21 INFO - Installing pip.................done. 04:02:21 INFO - Return code: 0 04:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:02:21 INFO - Reading from file tmpfile_stdout 04:02:21 INFO - Output received: 04:02:21 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) 04:02:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:02:21 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')]} 04:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:21 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')]} 04:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:21 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:21 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 04:02:21 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 04:02:21 INFO - Using env: {'DISPLAY': ':0', 04:02:21 INFO - 'HOME': '/home/cltbld', 04:02:21 INFO - 'LANG': 'en_US.UTF-8', 04:02:21 INFO - 'LANGUAGE': 'en_US:en', 04:02:21 INFO - 'LOGNAME': 'cltbld', 04:02:21 INFO - 'MAIL': '/var/mail/cltbld', 04:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:21 INFO - 'MOZ_NO_REMOTE': '1', 04:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:21 INFO - 'NO_EM_RESTART': '1', 04:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:21 INFO - 'PWD': '/builds/slave/test', 04:02:21 INFO - 'SHELL': '/bin/bash', 04:02:21 INFO - 'SHLVL': '1', 04:02:21 INFO - 'TERM': 'linux', 04:02:21 INFO - 'TMOUT': '86400', 04:02:21 INFO - 'USER': 'cltbld', 04:02:21 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:21 INFO - '_': '/tools/buildbot/bin/python'} 04:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:22 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 04:02:22 INFO - Cleaning up... 04:02:22 INFO - Return code: 0 04:02:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:02:22 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')]} 04:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:22 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')]} 04:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:22 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 04:02:22 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 04:02:22 INFO - Using env: {'DISPLAY': ':0', 04:02:22 INFO - 'HOME': '/home/cltbld', 04:02:22 INFO - 'LANG': 'en_US.UTF-8', 04:02:22 INFO - 'LANGUAGE': 'en_US:en', 04:02:22 INFO - 'LOGNAME': 'cltbld', 04:02:22 INFO - 'MAIL': '/var/mail/cltbld', 04:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:22 INFO - 'MOZ_NO_REMOTE': '1', 04:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:22 INFO - 'NO_EM_RESTART': '1', 04:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:22 INFO - 'PWD': '/builds/slave/test', 04:02:22 INFO - 'SHELL': '/bin/bash', 04:02:22 INFO - 'SHLVL': '1', 04:02:22 INFO - 'TERM': 'linux', 04:02:22 INFO - 'TMOUT': '86400', 04:02:22 INFO - 'USER': 'cltbld', 04:02:22 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:22 INFO - '_': '/tools/buildbot/bin/python'} 04:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:22 INFO - Downloading/unpacking psutil>=3.1.1 04:02:22 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 04:02:22 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 04:02:22 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 04:02:22 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 04:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:02:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:23 INFO - Installing collected packages: psutil 04:02:23 INFO - Running setup.py install for psutil 04:02:23 INFO - building 'psutil._psutil_linux' extension 04:02:23 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 04:02:23 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 04:02:23 INFO - building 'psutil._psutil_posix' extension 04:02:23 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 04:02:23 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 04:02:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:23 INFO - Successfully installed psutil 04:02:23 INFO - Cleaning up... 04:02:23 INFO - Return code: 0 04:02:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:02:23 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')]} 04:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:24 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')]} 04:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:24 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:24 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 04:02:24 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 04:02:24 INFO - Using env: {'DISPLAY': ':0', 04:02:24 INFO - 'HOME': '/home/cltbld', 04:02:24 INFO - 'LANG': 'en_US.UTF-8', 04:02:24 INFO - 'LANGUAGE': 'en_US:en', 04:02:24 INFO - 'LOGNAME': 'cltbld', 04:02:24 INFO - 'MAIL': '/var/mail/cltbld', 04:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:24 INFO - 'MOZ_NO_REMOTE': '1', 04:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:24 INFO - 'NO_EM_RESTART': '1', 04:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:24 INFO - 'PWD': '/builds/slave/test', 04:02:24 INFO - 'SHELL': '/bin/bash', 04:02:24 INFO - 'SHLVL': '1', 04:02:24 INFO - 'TERM': 'linux', 04:02:24 INFO - 'TMOUT': '86400', 04:02:24 INFO - 'USER': 'cltbld', 04:02:24 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:24 INFO - '_': '/tools/buildbot/bin/python'} 04:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:02:24 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 04:02:24 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 04:02:24 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 04:02:24 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 04:02:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:02:25 INFO - Installing collected packages: mozsystemmonitor 04:02:25 INFO - Running setup.py install for mozsystemmonitor 04:02:25 INFO - Successfully installed mozsystemmonitor 04:02:25 INFO - Cleaning up... 04:02:25 INFO - Return code: 0 04:02:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:02:25 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')]} 04:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:25 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')]} 04:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:25 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:25 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 04:02:25 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 04:02:25 INFO - Using env: {'DISPLAY': ':0', 04:02:25 INFO - 'HOME': '/home/cltbld', 04:02:25 INFO - 'LANG': 'en_US.UTF-8', 04:02:25 INFO - 'LANGUAGE': 'en_US:en', 04:02:25 INFO - 'LOGNAME': 'cltbld', 04:02:25 INFO - 'MAIL': '/var/mail/cltbld', 04:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:25 INFO - 'MOZ_NO_REMOTE': '1', 04:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:25 INFO - 'NO_EM_RESTART': '1', 04:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:25 INFO - 'PWD': '/builds/slave/test', 04:02:25 INFO - 'SHELL': '/bin/bash', 04:02:25 INFO - 'SHLVL': '1', 04:02:25 INFO - 'TERM': 'linux', 04:02:25 INFO - 'TMOUT': '86400', 04:02:25 INFO - 'USER': 'cltbld', 04:02:25 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:25 INFO - '_': '/tools/buildbot/bin/python'} 04:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:02:25 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 04:02:25 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 04:02:25 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 04:02:25 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 04:02:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:02:26 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 04:02:26 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 04:02:26 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 04:02:26 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 04:02:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:26 INFO - warning: no files found matching '*.txt' 04:02:26 INFO - no previously-included directories found matching 'build' 04:02:26 INFO - no previously-included directories found matching 'dist' 04:02:26 INFO - no previously-included directories found matching '.git*' 04:02:26 INFO - Installing collected packages: jsonschema, functools32 04:02:27 INFO - Running setup.py install for functools32 04:02:27 INFO - warning: no files found matching '*.txt' 04:02:27 INFO - no previously-included directories found matching 'build' 04:02:27 INFO - no previously-included directories found matching 'dist' 04:02:27 INFO - no previously-included directories found matching '.git*' 04:02:27 INFO - Successfully installed jsonschema functools32 04:02:27 INFO - Cleaning up... 04:02:27 INFO - Return code: 0 04:02:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:02:27 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')]} 04:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:27 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')]} 04:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:27 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:27 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 04:02:27 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 04:02:27 INFO - Using env: {'DISPLAY': ':0', 04:02:27 INFO - 'HOME': '/home/cltbld', 04:02:27 INFO - 'LANG': 'en_US.UTF-8', 04:02:27 INFO - 'LANGUAGE': 'en_US:en', 04:02:27 INFO - 'LOGNAME': 'cltbld', 04:02:27 INFO - 'MAIL': '/var/mail/cltbld', 04:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:27 INFO - 'MOZ_NO_REMOTE': '1', 04:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:27 INFO - 'NO_EM_RESTART': '1', 04:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:27 INFO - 'PWD': '/builds/slave/test', 04:02:27 INFO - 'SHELL': '/bin/bash', 04:02:27 INFO - 'SHLVL': '1', 04:02:27 INFO - 'TERM': 'linux', 04:02:27 INFO - 'TMOUT': '86400', 04:02:27 INFO - 'USER': 'cltbld', 04:02:27 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:27 INFO - '_': '/tools/buildbot/bin/python'} 04:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:02:27 INFO - Cleaning up... 04:02:27 INFO - Return code: 0 04:02:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02:27 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')]} 04:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:27 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')]} 04:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:27 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:27 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 04:02:27 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 04:02:27 INFO - Using env: {'DISPLAY': ':0', 04:02:27 INFO - 'HOME': '/home/cltbld', 04:02:27 INFO - 'LANG': 'en_US.UTF-8', 04:02:27 INFO - 'LANGUAGE': 'en_US:en', 04:02:27 INFO - 'LOGNAME': 'cltbld', 04:02:27 INFO - 'MAIL': '/var/mail/cltbld', 04:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:27 INFO - 'MOZ_NO_REMOTE': '1', 04:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:27 INFO - 'NO_EM_RESTART': '1', 04:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:27 INFO - 'PWD': '/builds/slave/test', 04:02:27 INFO - 'SHELL': '/bin/bash', 04:02:27 INFO - 'SHLVL': '1', 04:02:27 INFO - 'TERM': 'linux', 04:02:27 INFO - 'TMOUT': '86400', 04:02:27 INFO - 'USER': 'cltbld', 04:02:27 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:27 INFO - '_': '/tools/buildbot/bin/python'} 04:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:27 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 04:02:27 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 04:02:27 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 04:02:27 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 04:02:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02:28 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 04:02:28 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 04:02:28 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 04:02:28 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 04:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02:29 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 04:02:29 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 04:02:29 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 04:02:29 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 04:02:29 INFO - Downloading docopt-0.6.1.tar.gz 04:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:29 INFO - Running setup.py install for blobuploader 04:02:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:29 INFO - Running setup.py install for requests 04:02:29 INFO - Running setup.py install for docopt 04:02:29 INFO - Successfully installed blobuploader requests docopt 04:02:29 INFO - Cleaning up... 04:02:29 INFO - Return code: 0 04:02:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:29 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')]} 04:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:29 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')]} 04:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:29 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:29 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 04:02:29 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 04:02:29 INFO - Using env: {'DISPLAY': ':0', 04:02:29 INFO - 'HOME': '/home/cltbld', 04:02:29 INFO - 'LANG': 'en_US.UTF-8', 04:02:29 INFO - 'LANGUAGE': 'en_US:en', 04:02:29 INFO - 'LOGNAME': 'cltbld', 04:02:29 INFO - 'MAIL': '/var/mail/cltbld', 04:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:29 INFO - 'MOZ_NO_REMOTE': '1', 04:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:29 INFO - 'NO_EM_RESTART': '1', 04:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:29 INFO - 'PWD': '/builds/slave/test', 04:02:29 INFO - 'SHELL': '/bin/bash', 04:02:29 INFO - 'SHLVL': '1', 04:02:29 INFO - 'TERM': 'linux', 04:02:29 INFO - 'TMOUT': '86400', 04:02:29 INFO - 'USER': 'cltbld', 04:02:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:29 INFO - '_': '/tools/buildbot/bin/python'} 04:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:30 INFO - Running setup.py (path:/tmp/pip-8Htdn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:30 INFO - Running setup.py (path:/tmp/pip-ACN1uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:30 INFO - Running setup.py (path:/tmp/pip-DwSNic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:30 INFO - Running setup.py (path:/tmp/pip-QC6WAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:30 INFO - Running setup.py (path:/tmp/pip-44EQcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:30 INFO - Running setup.py (path:/tmp/pip-84ifKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:30 INFO - Running setup.py (path:/tmp/pip-Mf6_od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:30 INFO - Running setup.py (path:/tmp/pip-4cVNwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:30 INFO - Running setup.py (path:/tmp/pip-hKHo6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:30 INFO - Running setup.py (path:/tmp/pip-bWwU14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:30 INFO - Running setup.py (path:/tmp/pip-vbDBml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:30 INFO - Running setup.py (path:/tmp/pip-qvAY_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:30 INFO - Running setup.py (path:/tmp/pip-CWWRNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:30 INFO - Running setup.py (path:/tmp/pip-DRgpiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:31 INFO - Running setup.py (path:/tmp/pip-3iCVBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:31 INFO - Running setup.py (path:/tmp/pip-_RuReQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:31 INFO - Running setup.py (path:/tmp/pip-3h9G1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:31 INFO - Running setup.py install for manifestparser 04:02:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:31 INFO - Running setup.py install for mozcrash 04:02:31 INFO - Running setup.py install for mozdebug 04:02:31 INFO - Running setup.py install for mozdevice 04:02:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:31 INFO - Running setup.py install for mozfile 04:02:31 INFO - Running setup.py install for mozhttpd 04:02:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:31 INFO - Running setup.py install for mozinfo 04:02:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:31 INFO - Running setup.py install for mozInstall 04:02:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Running setup.py install for mozleak 04:02:32 INFO - Running setup.py install for mozlog 04:02:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Running setup.py install for moznetwork 04:02:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Running setup.py install for mozprocess 04:02:32 INFO - Running setup.py install for mozprofile 04:02:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Running setup.py install for mozrunner 04:02:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:32 INFO - Running setup.py install for mozscreenshot 04:02:32 INFO - Running setup.py install for moztest 04:02:32 INFO - Running setup.py install for mozversion 04:02:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:33 INFO - Cleaning up... 04:02:33 INFO - Return code: 0 04:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:33 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')]} 04:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:33 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')]} 04:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:33 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:33 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 04:02:33 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 04:02:33 INFO - Using env: {'DISPLAY': ':0', 04:02:33 INFO - 'HOME': '/home/cltbld', 04:02:33 INFO - 'LANG': 'en_US.UTF-8', 04:02:33 INFO - 'LANGUAGE': 'en_US:en', 04:02:33 INFO - 'LOGNAME': 'cltbld', 04:02:33 INFO - 'MAIL': '/var/mail/cltbld', 04:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:33 INFO - 'MOZ_NO_REMOTE': '1', 04:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:33 INFO - 'NO_EM_RESTART': '1', 04:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:33 INFO - 'PWD': '/builds/slave/test', 04:02:33 INFO - 'SHELL': '/bin/bash', 04:02:33 INFO - 'SHLVL': '1', 04:02:33 INFO - 'TERM': 'linux', 04:02:33 INFO - 'TMOUT': '86400', 04:02:33 INFO - 'USER': 'cltbld', 04:02:33 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:33 INFO - '_': '/tools/buildbot/bin/python'} 04:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:33 INFO - Running setup.py (path:/tmp/pip-n7ZUPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:33 INFO - Running setup.py (path:/tmp/pip-7rDoqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:33 INFO - Running setup.py (path:/tmp/pip-6C6qns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:33 INFO - Running setup.py (path:/tmp/pip-PBq0u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:33 INFO - Running setup.py (path:/tmp/pip-Rb5g7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:33 INFO - Running setup.py (path:/tmp/pip-vbTja9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:33 INFO - Running setup.py (path:/tmp/pip-OEATEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:33 INFO - Running setup.py (path:/tmp/pip-z6Bopu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:33 INFO - Running setup.py (path:/tmp/pip-8sN30u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:33 INFO - Running setup.py (path:/tmp/pip-BwIsba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:33 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)) 04:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:33 INFO - Running setup.py (path:/tmp/pip-QfnMC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:34 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)) 04:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:34 INFO - Running setup.py (path:/tmp/pip-oRB2Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:34 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)) 04:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:34 INFO - Running setup.py (path:/tmp/pip-LRLgyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:34 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)) 04:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:34 INFO - Running setup.py (path:/tmp/pip-PLj56g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:34 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)) 04:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:34 INFO - Running setup.py (path:/tmp/pip-YPQWFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:34 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)) 04:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:34 INFO - Running setup.py (path:/tmp/pip-a4CqJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:34 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)) 04:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:34 INFO - Running setup.py (path:/tmp/pip-l8r38J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:34 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)) 04:02:34 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)) 04:02:34 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)) 04:02:34 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)) 04:02:34 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)) 04:02:34 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)) 04:02:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:34 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 04:02:34 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 04:02:34 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 04:02:34 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 04:02:35 INFO - Downloading blessings-1.6.tar.gz 04:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:35 INFO - Installing collected packages: blessings 04:02:35 INFO - Running setup.py install for blessings 04:02:35 INFO - Successfully installed blessings 04:02:35 INFO - Cleaning up... 04:02:35 INFO - Return code: 0 04:02:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:36 INFO - Reading from file tmpfile_stdout 04:02:36 INFO - Current package versions: 04:02:36 INFO - argparse == 1.2.1 04:02:36 INFO - blessings == 1.6 04:02:36 INFO - blobuploader == 1.2.4 04:02:36 INFO - docopt == 0.6.1 04:02:36 INFO - functools32 == 3.2.3-2 04:02:36 INFO - jsonschema == 2.5.1 04:02:36 INFO - manifestparser == 1.1 04:02:36 INFO - mozInstall == 1.12 04:02:36 INFO - mozcrash == 1.0 04:02:36 INFO - mozdebug == 0.1 04:02:36 INFO - mozdevice == 0.50 04:02:36 INFO - mozfile == 1.2 04:02:36 INFO - mozhttpd == 0.7 04:02:36 INFO - mozinfo == 0.9 04:02:36 INFO - mozleak == 0.1 04:02:36 INFO - mozlog == 3.4 04:02:36 INFO - moznetwork == 0.27 04:02:36 INFO - mozprocess == 0.25 04:02:36 INFO - mozprofile == 0.28 04:02:36 INFO - mozrunner == 6.13 04:02:36 INFO - mozscreenshot == 0.1 04:02:36 INFO - mozsystemmonitor == 0.3 04:02:36 INFO - moztest == 0.8 04:02:36 INFO - mozversion == 1.4 04:02:36 INFO - psutil == 3.1.1 04:02:36 INFO - requests == 1.2.3 04:02:36 INFO - wsgiref == 0.1.2 04:02:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:36 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')]} 04:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:36 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')]} 04:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:36 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:36 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 04:02:36 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 04:02:36 INFO - Using env: {'DISPLAY': ':0', 04:02:36 INFO - 'HOME': '/home/cltbld', 04:02:36 INFO - 'LANG': 'en_US.UTF-8', 04:02:36 INFO - 'LANGUAGE': 'en_US:en', 04:02:36 INFO - 'LOGNAME': 'cltbld', 04:02:36 INFO - 'MAIL': '/var/mail/cltbld', 04:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:36 INFO - 'MOZ_NO_REMOTE': '1', 04:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:36 INFO - 'NO_EM_RESTART': '1', 04:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:36 INFO - 'PWD': '/builds/slave/test', 04:02:36 INFO - 'SHELL': '/bin/bash', 04:02:36 INFO - 'SHLVL': '1', 04:02:36 INFO - 'TERM': 'linux', 04:02:36 INFO - 'TMOUT': '86400', 04:02:36 INFO - 'USER': 'cltbld', 04:02:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:36 INFO - '_': '/tools/buildbot/bin/python'} 04:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 INFO - Cleaning up... 04:02:36 INFO - Return code: 0 04:02:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:36 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')]} 04:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:36 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')]} 04:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:36 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 0x1f061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', '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 04:02:36 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 04:02:36 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 04:02:36 INFO - Using env: {'DISPLAY': ':0', 04:02:36 INFO - 'HOME': '/home/cltbld', 04:02:36 INFO - 'LANG': 'en_US.UTF-8', 04:02:36 INFO - 'LANGUAGE': 'en_US:en', 04:02:36 INFO - 'LOGNAME': 'cltbld', 04:02:36 INFO - 'MAIL': '/var/mail/cltbld', 04:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:36 INFO - 'MOZ_NO_REMOTE': '1', 04:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:36 INFO - 'NO_EM_RESTART': '1', 04:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:36 INFO - 'PWD': '/builds/slave/test', 04:02:36 INFO - 'SHELL': '/bin/bash', 04:02:36 INFO - 'SHLVL': '1', 04:02:36 INFO - 'TERM': 'linux', 04:02:36 INFO - 'TMOUT': '86400', 04:02:36 INFO - 'USER': 'cltbld', 04:02:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:36 INFO - '_': '/tools/buildbot/bin/python'} 04:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:02:36 INFO - Cleaning up... 04:02:36 INFO - Return code: 0 04:02:36 INFO - Running post-action listener: _resource_record_post_action 04:02:36 INFO - Running post-action listener: _start_resource_monitoring 04:02:36 INFO - Starting resource monitoring. 04:02:36 INFO - [mozharness: 2017-05-16 11:02:36.532193Z] Finished create-virtualenv step (success) 04:02:36 INFO - [mozharness: 2017-05-16 11:02:36.532767Z] Running install step. 04:02:36 INFO - Running pre-action listener: _resource_record_pre_action 04:02:36 INFO - Running main action method: install 04:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:36 INFO - Reading from file tmpfile_stdout 04:02:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:36 INFO - Reading from file tmpfile_stdout 04:02:36 INFO - Output received: 04:02:36 INFO - Usage: mozinstall [options] installer 04:02:36 INFO - Options: 04:02:36 INFO - -h, --help show this help message and exit 04:02:36 INFO - -d DEST, --destination=DEST 04:02:36 INFO - Directory to install application into. [default: 04:02:36 INFO - "/builds/slave/test"] 04:02:36 INFO - --app=APP Application being installed. [default: firefox] 04:02:36 INFO - mkdir: /builds/slave/test/build/application 04:02:36 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'] 04:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:02:53 INFO - Reading from file tmpfile_stdout 04:02:54 INFO - Output received: 04:02:54 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:54 INFO - Running post-action listener: _resource_record_post_action 04:02:54 INFO - [mozharness: 2017-05-16 11:02:54.078082Z] Finished install step (success) 04:02:54 INFO - [mozharness: 2017-05-16 11:02:54.078362Z] Running run-tests step. 04:02:54 INFO - Running pre-action listener: _resource_record_pre_action 04:02:54 INFO - Running main action method: run_tests 04:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:54 INFO - Python 2.7.3 04:02:54 INFO - Return code: 0 04:02:54 INFO - grabbing minidump binary from tooltool 04:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:54 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 0x22767a0>, '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 0x22776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:54 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 04:02:54 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 04:02:54 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 04:02:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:54 INFO - Return code: 0 04:02:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:54 INFO - ENV: RUST_BACKTRACE is now 1 04:02:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:02:54 INFO - Using env: {'DISPLAY': ':0', 04:02:54 INFO - 'HOME': '/home/cltbld', 04:02:54 INFO - 'LANG': 'en_US.UTF-8', 04:02:54 INFO - 'LANGUAGE': 'en_US:en', 04:02:54 INFO - 'LOGNAME': 'cltbld', 04:02:54 INFO - 'MAIL': '/var/mail/cltbld', 04:02:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:54 INFO - 'MOZ_NO_REMOTE': '1', 04:02:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:54 INFO - 'NO_EM_RESTART': '1', 04:02:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:54 INFO - 'PWD': '/builds/slave/test', 04:02:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:54 INFO - 'RUST_BACKTRACE': '1', 04:02:54 INFO - 'SHELL': '/bin/bash', 04:02:54 INFO - 'SHLVL': '1', 04:02:54 INFO - 'TERM': 'linux', 04:02:54 INFO - 'TMOUT': '86400', 04:02:54 INFO - 'USER': 'cltbld', 04:02:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876', 04:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:54 INFO - '_': '/tools/buildbot/bin/python'} 04:02:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:02:54 INFO - mozversion application_buildid: 20170516101906 04:02:54 INFO - mozversion application_changeset: 5e81f95116344b68975ac5aba30a8bb9eeae6b32 04:02:54 INFO - mozversion application_display_name: Nightly 04:02:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:54 INFO - mozversion application_name: Firefox 04:02:54 INFO - mozversion application_remotingname: firefox 04:02:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:02:54 INFO - mozversion application_vendor: Mozilla 04:02:54 INFO - mozversion application_version: 55.0a1 04:02:54 INFO - mozversion platform_buildid: 20170516101906 04:02:54 INFO - mozversion platform_changeset: 5e81f95116344b68975ac5aba30a8bb9eeae6b32 04:02:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:02:54 INFO - mozversion platform_version: 55.0a1 04:02:54 INFO - using testdate: 1494932574 04:02:54 INFO - actual date: 1494932574 04:02:54 INFO - starting webserver on 'localhost:42877' 04:02:54 INFO - SUITE-START | Running 2 tests 04:02:54 INFO - TEST-START | dromaeo_css 04:02:54 INFO - operating with platform_type : linux_ 04:02:54 INFO - Initialising browser for dromaeo_css test... 04:02:54 INFO - TEST-INFO | started process 28109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXcGtbT/profile http://localhost:42877/getInfo.html) 04:02:54 INFO - PID 28109 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:02:58 INFO - PID 28109 | __metrics Screen width/height:1600/1200 04:02:58 INFO - PID 28109 | colorDepth:24 04:02:58 INFO - PID 28109 | Browser inner width/height: 1024/695 04:02:58 INFO - PID 28109 | __metrics 04:03:00 INFO - TEST-INFO | 28109: exit 0 04:03:00 INFO - Browser initialized. 04:03:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:00 INFO - TEST-INFO | started process 28298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXcGtbT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:12 INFO - PID 28298 | RSS: Main: 165195776 04:03:12 INFO - PID 28298 | 04:06:18 INFO - PID 28298 | Cycle 1(1): loaded http://localhost:42877/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42877/tests/dromaeo/cssquery-ext.html) 04:06:19 INFO - PID 28298 | RSS: Main: 170942464 04:06:19 INFO - PID 28298 | 04:09:21 INFO - PID 28298 | Cycle 1(1): loaded http://localhost:42877/tests/dromaeo/cssquery-ext.html (next: http://localhost:42877/tests/dromaeo/cssquery-jquery.html) 04:09:22 INFO - PID 28298 | RSS: Main: 170713088 04:09:22 INFO - PID 28298 | 04:12:23 INFO - PID 28298 | Cycle 1(1): loaded http://localhost:42877/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42877/tests/dromaeo/cssquery-mootools.html) 04:12:24 INFO - PID 28298 | RSS: Main: 172380160 04:12:24 INFO - PID 28298 | 04:15:26 INFO - PID 28298 | Cycle 1(1): loaded http://localhost:42877/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42877/tests/dromaeo/cssquery-prototype.html) 04:15:26 INFO - PID 28298 | RSS: Main: 169668608 04:15:26 INFO - PID 28298 | 04:18:29 INFO - PID 28298 | Cycle 1(1): loaded http://localhost:42877/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42877/tests/dromaeo/cssquery-yui.html) 04:18:30 INFO - PID 28298 | RSS: Main: 171057152 04:18:30 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | Cycle 1(1): loaded http://localhost:42877/tests/dromaeo/cssquery-yui.html (next: http://localhost:42877/tests/dromaeo/cssquery-dojo.html) 04:21:32 INFO - PID 28298 | RSS: Main: 176828416 04:21:32 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | __start_tp_report 04:21:32 INFO - PID 28298 | _x_x_mozilla_page_load 04:21:32 INFO - PID 28298 | _x_x_mozilla_page_load_details 04:21:32 INFO - PID 28298 | |i|pagename|runs| 04:21:32 INFO - PID 28298 | |0;dojo.html;2692.717264687209;2700.257429206968;2729.0993971989233;2740.3149212696812;2741.1776467059885;5080.060188865063;5150.286897836623;5190.403103643082;5190.688558686482;5259.552938000265;5141.331626888508;5210.452902445246;5211.609129315298;5232.110541208004;5250.894982100355;4583;4586.97706511467;4623.0984957933215;4666.323383109447;4673.485916549177;4628.398308219927;4665.9066818663605;4672.4393072831135;4724;4775;4520.751358675271;4651.674382793206;4693.037927224927;4694.108119457293;4699.248120300753;4559.794809233593;4613.653975951817;4650.7442090685;4674.368960190365;4683.976580117112;4560.657950653715;4613.123506533781;4619.653525985531;4624.028953919647;4700.707305490983;5164.431912489623;5176.974115129438;5215.113430716788;5231.816886408996;5243.737813109329;5456.699881506515;5559.58303127263;5578.944210557924;5674.120511320752;5675.716214189274;5645.943540564583;5661.5187709044785;5663.9716801415725;5678.233438485793;5724.656520608777;5198.636095473356;5202.8959420812125;5247.501487358695;5266.0257852297445;5314.92027619586;5688.687122208318;5737.827865164052;5761;5763;5784.537237021028;5363.383210930715;5412.539934105566;5470.398256191816;5470.863228419242;5474.835754927359;5529.391766905637;5539.806106786243;5580.91628625571;5590.217369568264;5593.188987596775;5644.096944488862;5662.207290979266;5668.319801623831;5672.461116193955;5673.971630141906;5625.184348269478;5635.943640563624;5641.379448260688;5661.745221465044;5688.288963879515;4718.693284936537;4734.07685501324;4735.668503204812;4740.976295118502;4774.140654682121;4005.879823605238;4043.838246470108;4089.7750623715983;4096.873359826012;4112.712110152321;4758;4838.443578988391;4845.733484658307;4848.17581011229;4850.563449289581;5673.3475650299915;5690;5695.829125126253;5711.029125048752;5738.942610573924;4791.257355109963;4797.424309082932;4801.51984801517;4802.975985120052;4847.80608775652;4926.088673595396;4997.9500204997485;5002.649814513022;5020.899582008339;5029.1450453423;5177;5187.144121220107;5188.455212202815;5188.558972487381;5192.5586325162785;5606.747696353756;5613.438656134354;5618.325800903917;5618.634788738719;5619.409961953936;5176.301199338041;5179.015986962465;5226.738663066907;5274.7890084396195;5279.656822306538;5538.363088244742;5589.189567512769;5590.217369568182;5607.859803504945;5608.691521966331;5476.397596264328;5565.63823351497;5640.520555752807;5653.462921022497;5713.542916566747;5406.810761623325;5410.729463526886;5452.263944367618;5478.260434841405;5480.451954804487;5379.300690910157;5380.569554435558;5381.677099373894;5391.16436952273;5398.46015398457;5144.922826157535;5296.708681022581;5321.122014867504;5378.300820893259;5381.784728610812;5418.593605479526;5479.75341109659;5491.835244942658;5512.641678290898;5538.390777014606;5344.091504444176;5365.865853353697;5367.490088441592;5367.597430192673;5414.729263536886 04:21:32 INFO - PID 28298 | |1;ext.html;692.3837784371907;736.6059158350283;760.5778792770012;1031.649239258652;1049.6168898352093;31518.52722209166;32445.188870278256;32490.837545812297;32501.51247731286;32569.348613027756;34574.481382779275;34878.476822847675;34903.47644785324;35139.12152196196;35211.119722006966;6871.931280687179;6951.0616066830835;7028.262032486592;7046.189688185873;7055.188653304885;7003.789886303419;7063.187733410647;7083.539569927938;7084.57492550446;7096.716131354739;7035.296470352975;7091.645417729119;7096.53872498286;7107.076080109604;7109.0758201434;7043.295670432942;7076.681549330241;7087;7097.21930587635;7106.898430743217;6960.199577048654;6973.3375329344135;6980.755673551452;6991.126109236346;7026.894596581055;31825.204369890707;31968.840155799073;31971.52042719361;32068.679313207034;32078.6792132078;3064.2952121012067;3080.3223290876194;3081.3529158876663;3086.6141732283463;3112.004158669227;24225.394365140837;24257.757422425904;24340.634890476656;24395.390115247083;24509.754902450924;2880.2367372646268;2883.308006078547;2889.3498962733215;2893.3345330574084;2897.5508796136633;136972.31513842466;137102.31448842792;144315;145385.99999999895;146001;38175.6182438172;38248.8087559566;38354.80822595869;38385.23229535449;38452;40211.39682904759;40495.293511895085;40524.79737601293;40542.79728601338;40572;11813.763724725457;11904.107191960638;11907.52369905194;11914.702132446584;11917.821232681517;9459.24326053914;9506.334556580972;9510.857337139949;9518.476483793458;9534.90465095354;12537.122401431812;12668.11323207385;12672.303023333805;12689.873101269053;12873.485060597659;5258.868528286824;5395.109806881899;5471.124620060771;5498.147787093007;5502.779888804403;832.8625776746769;900.7297810656777;906.2161230535539;911.5351170902754;913.584319134792;20653.380398588066;21225.469363266042;21276.680849787266;21310.010721518338;21593.460163495725;959.8128364968765;962.9744322296732;991.7520619845038;992.2359782967075;994.7562847102506;10880.292780969212;11141.387223702612;11371.204015718986;11390.316581005167;11477.966982971573;172630;173234.13382933257;173452;173806;173978.1301093512;40102.79948600238;40275.59724402777;40344;40501.79749101236;40527.79736101301;1223.6329101269762;1240.5347994502063;1247.2267194339568;1247.7130260040242;1248.2136254160002;19773.505662358555;19813.801861981196;20075.598488029864;21090.57818843645;21222.893885530473;29048.7095129046;29107.272318192216;29114.7088529112;29165.416691666473;29172.854135729187;143787;144352;144689.27655362076;144692;145512;28144.29639259035;28413.584845287554;28978.218593931764;29939.251518712208;30090;34982.47526287159;35066.47400288947;35130.47304290387;35159.47260791039;35258.29483410369;25775.484490310464;26986.730132698423;27040.1887943362;27829.304267393476;28173;26447.206583802516;26866.731332686424;27360.452790943673;28342.291442714097;28559.14322570326;29223;29594.852025739732;29782.851085744434;30101.69898300989;30461.84769076229;25617;25778.35554111162;26398.07606733755;26638.600420993313;27701.30746731348;19686.507837304183;21801.236956706438;21860.781392185876;21889.562208756055;22224 04:21:32 INFO - PID 28298 | |2;jquery.html;391.6086689270913;403.1010845813837;409.2408582080242;420.08840815430517;427.25444100045405;13041.869581304209;17125.400610978617;17681.64636707265;17891.73162402565;17957.191926363314;15892.920535397307;16073.91963040186;16153.676926461463;17483.562910927234;17729.202185901635;5210.1403268460845;5221.738913054361;5391.973040134813;5416.160495123262;5482.369527504328;5445.047116754572;5478.58910581706;5499.257600223978;5516.117421212607;5528.917066244009;5289.603279754015;5391.272178255944;5428.61999660024;5451.37309209442;5490.505854473096;5384.219288203209;5430.891382172374;5449.455054494559;5451.182322651594;5454.372747134091;4752.859313764706;4800.903981920377;4835;4855.417349917997;4877.3903262092235;21346.893265533574;21749.2387766429;21778.237761678425;21778.455538611503;21828.781712182994;1607.477569789823;1638.6476907464953;1641.253229780447;1641.3844808196927;1648.752687096933;14262.429502819978;15030.323635436322;15271.083734975937;15277;15419.306131224123;1997.1611922992233;2001.0795034284247;2054.3528788431595;2059.938201853947;2063.1128614695676;83011;83681;84121.57939210265;84613;85836.14163858345;10488.842667359995;10492.685219443429;10572.418516981486;10651.467426628638;10659;14311.06800581929;14480.85519144795;14487.710245795026;14504.854951450561;14524.128552286897;7270.436856075863;7371.262873712586;7434.516756410816;7476.626168691544;7555.962220188974;6755.324467553205;6765.154355705537;7006.299370062953;7007.614581198083;7038.085048943604;6374.808755737336;6626.966865165643;6655.201375834931;6677.866442671217;6813.897791533131;1935.777385600674;1952.588553136875;1975.6641370966684;1979.8713083649516;1992.511834600503;852.654674856684;895.4582477601087;896.6413434626071;904.5341649050744;918.3204428722697;16827;16951;17427.651446971242;17744.46766597004;17786.46640600784;875.5140896802209;893.2139717049085;895.4224525181352;908.927285817133;919.4942781470164;9270.814583708288;9395.671151509665;9579;9706.805863882682;9761.755956101013;340470;344256;344591;346865;364195;77642.22357776349;77662;78294;79466.20533794588;80086.59956700295;1083.4636854756789;1125.0886781706843;1137.2721458266717;1139.9373034483017;1140.3272069479046;17056.57358566046;17849;18289.725654114933;18387.632247355246;18446.723299150253;38852;38894.4165837507;39079.41380879346;39248.80375598104;39291.80354098211;49287.50712492829;49876.75061624669;50278.245826311904;50407.49592504028;50469.49530504648;7685.193054729397;7865.252800983897;7918.841623167619;7932.841343172989;8041.236082572146;12369.319687417279;12374.010079193822;12497.18768280059;12528.436220369922;12701.87298127007;10811.405372704578;10842.24104312722;10866.945665271624;10873.673789786319;11034.724131896766;9874.753131171778;10512.842307365549;10562.207834412297;10568.154547636017;10730.356178628996;10657.14742820557;10954.342739435659;11043.337399756041;11119.666410007712;11130.217445638591;7938.880916786137;8019.839603207786;8030.919690803017;8085.919140808516;8204.753857384288;10658.573657053632;10820.080293174853;10918.18113641496;10943.179261555257;11275.323480590863 04:21:32 INFO - PID 28298 | |3;mootools.html;1220.3776074202158;1256.6104507602638;1256.6104507602645;1264.6079715288256;1284.08188145476;9859.802803943916;10230.181585473154;10361.948190259047;10424.687259382212;10632.415217163052;10340.948295258531;10516.158707303417;10529.52617132229;10534;10568.78862422751;2244.6969659096058;2270.3416009357265;2273.6134857074335;2273.874936878471;2277.1119263487253;2136.2309568555306;2174.021690239391;2181.6618424144285;2184.2464349799375;2187.8030977212047;2183.967240491394;2194.1771835561663;2209.933701988943;2234.229190929127;2236.1502629000956;2171.35944896256;2214.435318993654;2256.537409830981;2262.8189744820374;2268.6370180771078;2116.6401711709045;2172.478605134772;2173.174193806359;2189.0696454006984;2250.0999600160067;10172.186225101974;10324.948375258151;10332.431716255604;10338.172946164288;10347.275690701654;5354.9196762048605;5518.696471694056;5534.557235421197;5541.778328866841;5542.806001789918;3297.950530742041;3465.1683595936793;3475.6350583188905;3525.9774665347018;3551.786892786441;1093.5680406239492;1168.6377223060792;1173.4895320535595;1183.8993685536739;1196.6290449960452;14531;14667.413303467849;14705.26473676312;14712.852871471363;14747.926260368737;4622.705642420127;4714.504976977437;4918.458969513351;4929.75351232437;4974.527419895104;10199.796004079877;10216.693499194887;10236.027577380137;10238.59045638181;10246;5359.758810853521;5370.946290537123;5374.462553744673;5376.220448035013;5379.569634429236;4654;4710.62315014798;4782.115308667908;4922.90154196914;4986.750662466862;3660;3707.758995665327;3741.4387841823946;3751.8874433767032;3790.995386222653;1125.3416751200639;1146.043054049861;1146.306484576819;1160.158884808507;1162.0935670177275;684.7295318349323;712.6401167410424;723.2586598736232;731.9707211711578;740.8703476891523;5331.3868905076415;5410.215518749759;5425.186222066643;5571.609987300931;5637.7181140942785;530.1967519208403;546.8168163665138;549.0720682047328;549.3188446326526;550.5513006899364;4112.300908845504;4136.669066474675;4165.729227600196;4171.436856024458;4184.3932629768515;12868.22790632565;12880.162789418659;12944.870551294554;12950.611481655566;13020;12693.936530317475;12965.22208667483;12973.805392919114;12975.740485190432;13354.532591359255;6512.316206798313;6725.361090696376;6753.08833307507;6799.7280108796085;6817.420519255819;5668.7165641718575;5826.504747096375;5928.851778705567;5974.731137098928;6084.056971169476;11936.820947685965;12197.390130493262;12315.69210769738;12317.384130793604;12321.93839030799;12234.694132646755;12240.387980600755;12342.691432714253;12405.62783116508;12637.494500219887;7367.263273672805;7502.962485187539;7544.660490277841;7587.203343649058;7612.391008719178;9568.425894446076;9870.506474676382;9871.160951319218;9883.406995580288;9921.057499537532;8161.714339998071;8212.507249565046;8286.212809783061;8316.293115085044;8708.738737837875;7692.615369231404;8099.959500202697;8114.878276825734;8137.877931831145;8141.674333026613;7429.517081389692;7486.363659089038;7549.471536992577;7625.656845442079;7641;5251.973740131275;5300.098983172793;5341.305630268041;5343.866403339792;5630.8029218977135;5087.745612719275;5245.659032162897;5245.763940622757;5254.054270231395;5445.1832225166545 04:21:32 INFO - PID 28298 | |4;prototype.html;378.06806222661135;388.0589570292042;392.5642536784167;393.6378531750789;398.9421533877587;5339.252504649343;5421.972890135554;5456.972715136424;5490.56075513959;5518.503334699882;5247.212918062292;5310.230016647583;5310.8406747797535;5324.440933701963;5348.652337598053;4015.6586690131303;4022.034711669208;4024.7786371749544;4032.4354590357225;4037.2934736421157;3868.535775706919;3993.98003009986;4033.455483509718;4044.251813414513;4047.291723948312;3987.2424239394422;3991.1020020495303;3992.361222204448;3996.300647386696;4003.2994226010333;3989.920201595981;3998;4007.5572793794213;4010.9598904010877;4012.9197416051807;3507.368673638744;3513.877014304487;3516.876909308162;3528.576570811493;3533.116720819795;5197.194434862602;5219.181641913362;5256.26412302278;5266.289050978107;5269.104252277084;4699.318598803155;4704.200285951397;4717.504662010508;4740.549647783455;4741.739204343759;5530;5649.830505084854;5651.124075768263;5669.376368599492;5679.182661548306;3924.4309575111733;3929.98035009826;3938.5076865391825;3942.4086387041884;3960.960390396117;5817.923684118409;5943.613665111754;5960.821175364746;5968.373320801296;6060.272767267912;3881.049142959993;3902.902427439337;3904.4338570907057;3916.6670832979516;3953.548799744177;3976.8011599419915;3995;3998.7200895937585;4005.2189822984237;4010.7994600270454;4554.86128467883;4645.326427667969;4655.464621568495;4656.976715116402;4695.835645752382;5675.971620141873;5708.9153060919125;5710.314762228559;5717.37108918027;5732;1378.910370825893;1379.0002248369851;1380.9033367664367;1380.951666691681;1381.730562540295;886.3972498700816;922.3820040572832;944.5182956692137;946.5267366316841;950.254050570299;4821.842757738117;4852.539008794159;4864.173090574611;4871.732054736953;4884.3161957326;5888.941110588925;5920.5559583031445;5922.792702255487;5924.881502369928;5941.910871336933;4841.685290456109;4883.291922671193;4913.631477639191;4918.90162196754;4954.801807927643;3074;3105.6739042400673;3109.595752552154;3123.8906638267554;3132.63974642919;5346.4118946915805;5393.950298886477;5415.236410694608;5435.211894275308;5441.809536666197;5886.352501224862;5986.132010858401;6053.545984051214;6055.515558755289;6062.363451837494;5410.862709229832;5420.268263784339;5435.211894275387;5447.210154527571;5463.72681365938;5729.4843464088435;5863.237779088691;5891.263592050994;5896.941030589811;5899.38056504078;5801.8549536261935;5809.448102430262;5812.593118481665;5821.505172060422;5836.766529338779;5311.256424100707;5442.455754424526;5451.836444906659;5454.563634909277;5469.617126801245;4005.5393629732953;4025;4040.6565441937764;4047.3928910663635;4056.5740597238046;5848.824535263949;5950.732217050329;5950.7917222896995;5954.940450595439;5973.790917317873;5728.276620196905;5756.769729210952;5759.366469688247;5775.758211984444;5783.103618939072;5692.474482786278;5693.316801983623;5712.971435142797;5716.8570785729025;5726.455986681259;5434.619576629598;5542.7782888685615;5581.413951535031;5621.297337832771;5621.606487545832;5722.113072473773;5758.827235182951;5759.539236860957;5762.279715035621;5767.250257466502;5506.476884695948;5601.971990140023;5605.635633683797;5607.971960140337;5632.493075623213 04:21:32 INFO - PID 28298 | |5;yui.html;730.2150188547312;731.0642377756474;747.3124725252767;754.9698012079517;760.7375455467861;12361.134720569564;12912.806307905388;13464.66338341542;14131.92934035331;14183.290835458225;13777.242251676154;14074.71850562988;14154.15075095495;14179.220142892136;14190;831.5592735850009;857;857.1214505132227;858.2061593026457;859.4843094143495;897.6633762339122;902.7111324376202;902.8510295801185;905.4748246017327;907.8320510705507;947.9573419196153;949.7340744591526;951.9524023798817;953.3517208298355;955.0878910640356;933.2533972821749;942.7737343037655;943.9764005899839;944.7401964459759;948.3172116076414;683.3951952522004;687.9690413931385;690.6305126757211;691.0394551573318;695.4054283587561;13510.459581616724;13633.795493067513;13812.93093534536;14736.263186840722;14919.627009324853;15277.847221527754;15304.770428443582;15576.065436073759;15765.290561924741;15796.368145274175;11963.820542691867;12270.38648067593;12406.441710123067;12539.937300313532;12559.434825432878;3004.1438190115714;3009.9398012039637;3023.712747289004;3025.2890570715863;3034.1656044587917;63359.6832015837;63576.36423635797;64399;64495;64773.3522664772;11473.082153427706;11834.171607987359;11905;11945.283283003047;11949;22115;22156.556868862855;22434.775652243596;22739.317820465083;22809.657855132187;6027.156198132265;6081.118237855486;6088.756449741961;6095.268567771807;6099.085137229451;2849.202223377458;2872.6840047594746;2899.7970142089853;2901.202169403431;2905.2301140197865;3443.466262729281;3470.670286322795;3482.5820901491984;3508.368493671164;3651.6713495785507;733.8899165125274;742.1391186223955;747.7270796159363;748.5658318175446;750.264740554249;560.4643277419922;587.665030932373;601.9668918209541;602.1509671363444;615.7721642992121;9459.479728614991;9829.705108846745;10074.647387341407;10126.139278161292;10326.896731032593;599.5323647554915;602.1239097113689;613.6256883301182;614.3365165621118;623.9812805615838;4590.403247577793;4737.3130896020575;4744.4069491313585;4746;4886.65793394459;65335.34664653388;67075.66462167658;67603.66198168977;68289.65855170692;69562;57943.420565794644;58348.416515835146;58719.41280587225;58824.70587647035;60939;52202;52991.735041324544;53198;53433.198502022504;53869.730651346494;9297.30482624134;9798.363106398061;9862.408255504406;9931.205503559553;9934.056264654846;27435.451290974466;27454.450910981268;27663.72336276692;28032.719672803825;28433.715662843933;32917.341653167285;33066.504002440466;33420.331593368486;33852.66147338594;33864.322713546084;10887.401192934465;11094.22340436194;11165.665030048787;11293.71765705864;11320.660380188607;14960;15560.144192069545;15842.366305347658;16074.598135046717;16185.919070404572;13197;13398.464061437433;13516.459341626225;13626.863731362955;13684.726305473636;14879.776803347742;14952.850471495145;15047.322870470636;15061.322240498985;15210.391584336945;13283;13612.455501780214;13873.236971966639;13964.581062568139;14170.149791012573;10718.624848130277;10995.835062474229;11065.391403472886;11648.825267620823;11733.296002239893;10403.167746580406;10855.40295283767;11066.502007409847;11118.722031949266;11171.329720216812 04:21:32 INFO - PID 28298 | __end_tp_report 04:21:32 INFO - PID 28298 | __start_cc_report 04:21:32 INFO - PID 28298 | _x_x_mozilla_cycle_collect,288 04:21:32 INFO - PID 28298 | __end_cc_report 04:21:32 INFO - PID 28298 | __startTimestamp1494933692643__endTimestamp 04:21:32 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | ------- Summary: start ------- 04:21:32 INFO - PID 28298 | Number of tests: 6 04:21:32 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | [#0] dojo.html Cycles:165 Average:5135.94 Median:5266.03 stddev:596.67 (11.3%) stddev-sans-first:566.89 04:21:32 INFO - PID 28298 | Values: 2692.7 2700.3 2729.1 2740.3 2741.2 5080.1 5150.3 5190.4 5190.7 5259.6 5141.3 5210.5 5211.6 5232.1 5250.9 4583.0 4587.0 4623.1 4666.3 4673.5 4628.4 4665.9 4672.4 4724.0 4775.0 4520.8 4651.7 4693.0 4694.1 4699.2 4559.8 4613.7 4650.7 4674.4 4684.0 4560.7 4613.1 4619.7 4624.0 4700.7 5164.4 5177.0 5215.1 5231.8 5243.7 5456.7 5559.6 5578.9 5674.1 5675.7 5645.9 5661.5 5664.0 5678.2 5724.7 5198.6 5202.9 5247.5 5266.0 5314.9 5688.7 5737.8 5761.0 5763.0 5784.5 5363.4 5412.5 5470.4 5470.9 5474.8 5529.4 5539.8 5580.9 5590.2 5593.2 5644.1 5662.2 5668.3 5672.5 5674.0 5625.2 5635.9 5641.4 5661.7 5688.3 4718.7 4734.1 4735.7 4741.0 4774.1 4005.9 4043.8 4089.8 4096.9 4112.7 4758.0 4838.4 4845.7 4848.2 4850.6 5673.3 5690.0 5695.8 5711.0 5738.9 4791.3 4797.4 4801.5 4803.0 4847.8 4926.1 4998.0 5002.6 5020.9 5029.1 5177.0 5187.1 5188.5 5188.6 5192.6 5606.7 5613.4 5618.3 5618.6 5619.4 5176.3 5179.0 5226.7 5274.8 5279.7 5538.4 5589.2 5590.2 5607.9 5608.7 5476.4 5565.6 5640.5 5653.5 5713.5 5406.8 5410.7 5452.3 5478.3 5480.5 5379.3 5380.6 5381.7 5391.2 5398.5 5144.9 5296.7 5321.1 5378.3 5381.8 5418.6 5479.8 5491.8 5512.6 5538.4 5344.1 5365.9 5367.5 5367.6 5414.7 04:21:32 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | [#1] ext.html Cycles:180 Average:29611.34 Median:30281.77 stddev:39679.49 (131.0%) stddev-sans-first:39731.38 04:21:32 INFO - PID 28298 | Values: 692.4 736.6 760.6 1031.6 1049.6 31518.5 32445.2 32490.8 32501.5 32569.3 34574.5 34878.5 34903.5 35139.1 35211.1 6871.9 6951.1 7028.3 7046.2 7055.2 7003.8 7063.2 7083.5 7084.6 7096.7 7035.3 7091.6 7096.5 7107.1 7109.1 7043.3 7076.7 7087.0 7097.2 7106.9 6960.2 6973.3 6980.8 6991.1 7026.9 31825.2 31968.8 31971.5 32068.7 32078.7 3064.3 3080.3 3081.4 3086.6 3112.0 24225.4 24257.8 24340.6 24395.4 24509.8 2880.2 2883.3 2889.3 2893.3 2897.6 136972.3 137102.3 144315.0 145386.0 146001.0 38175.6 38248.8 38354.8 38385.2 38452.0 40211.4 40495.3 40524.8 40542.8 40572.0 11813.8 11904.1 11907.5 11914.7 11917.8 9459.2 9506.3 9510.9 9518.5 9534.9 12537.1 12668.1 12672.3 12689.9 12873.5 5258.9 5395.1 5471.1 5498.1 5502.8 832.9 900.7 906.2 911.5 913.6 20653.4 21225.5 21276.7 21310.0 21593.5 959.8 963.0 991.8 992.2 994.8 10880.3 11141.4 11371.2 11390.3 11478.0 172630.0 173234.1 173452.0 173806.0 173978.1 40102.8 40275.6 40344.0 40501.8 40527.8 1223.6 1240.5 1247.2 1247.7 1248.2 19773.5 19813.8 20075.6 21090.6 21222.9 29048.7 29107.3 29114.7 29165.4 29172.9 143787.0 144352.0 144689.3 144692.0 145512.0 28144.3 28413.6 28978.2 29939.3 30090.0 34982.5 35066.5 35130.5 35159.5 35258.3 25775.5 26986.7 27040.2 27829.3 28173.0 26447.2 26866.7 27360.5 28342.3 28559.1 29223.0 29594.9 29782.9 30101.7 30461.8 25617.0 25778.4 26398.1 26638.6 27701.3 19686.5 21801.2 21860.8 21889.6 22224.0 04:21:32 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | [#2] jquery.html Cycles:180 Average:24119.36 Median:38986.92 stddev:58124.55 (149.1%) stddev-sans-first:58260.30 04:21:32 INFO - PID 28298 | Values: 391.6 403.1 409.2 420.1 427.3 13041.9 17125.4 17681.6 17891.7 17957.2 15892.9 16073.9 16153.7 17483.6 17729.2 5210.1 5221.7 5392.0 5416.2 5482.4 5445.0 5478.6 5499.3 5516.1 5528.9 5289.6 5391.3 5428.6 5451.4 5490.5 5384.2 5430.9 5449.5 5451.2 5454.4 4752.9 4800.9 4835.0 4855.4 4877.4 21346.9 21749.2 21778.2 21778.5 21828.8 1607.5 1638.6 1641.3 1641.4 1648.8 14262.4 15030.3 15271.1 15277.0 15419.3 1997.2 2001.1 2054.4 2059.9 2063.1 83011.0 83681.0 84121.6 84613.0 85836.1 10488.8 10492.7 10572.4 10651.5 10659.0 14311.1 14480.9 14487.7 14504.9 14524.1 7270.4 7371.3 7434.5 7476.6 7556.0 6755.3 6765.2 7006.3 7007.6 7038.1 6374.8 6627.0 6655.2 6677.9 6813.9 1935.8 1952.6 1975.7 1979.9 1992.5 852.7 895.5 896.6 904.5 918.3 16827.0 16951.0 17427.7 17744.5 17786.5 875.5 893.2 895.4 908.9 919.5 9270.8 9395.7 9579.0 9706.8 9761.8 340470.0 344256.0 344591.0 346865.0 364195.0 77642.2 77662.0 78294.0 79466.2 80086.6 1083.5 1125.1 1137.3 1139.9 1140.3 17056.6 17849.0 18289.7 18387.6 18446.7 38852.0 38894.4 39079.4 39248.8 39291.8 49287.5 49876.8 50278.2 50407.5 50469.5 7685.2 7865.3 7918.8 7932.8 8041.2 12369.3 12374.0 12497.2 12528.4 12701.9 10811.4 10842.2 10866.9 10873.7 11034.7 9874.8 10512.8 10562.2 10568.2 10730.4 10657.1 10954.3 11043.3 11119.7 11130.2 7938.9 8019.8 8030.9 8085.9 8204.8 10658.6 10820.1 10918.2 10943.2 11275.3 04:21:32 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | [#3] mootools.html Cycles:180 Average:6229.69 Median:3724.60 stddev:4000.56 (107.4%) stddev-sans-first:3994.07 04:21:32 INFO - PID 28298 | Values: 1220.4 1256.6 1256.6 1264.6 1284.1 9859.8 10230.2 10361.9 10424.7 10632.4 10340.9 10516.2 10529.5 10534.0 10568.8 2244.7 2270.3 2273.6 2273.9 2277.1 2136.2 2174.0 2181.7 2184.2 2187.8 2184.0 2194.2 2209.9 2234.2 2236.2 2171.4 2214.4 2256.5 2262.8 2268.6 2116.6 2172.5 2173.2 2189.1 2250.1 10172.2 10324.9 10332.4 10338.2 10347.3 5354.9 5518.7 5534.6 5541.8 5542.8 3298.0 3465.2 3475.6 3526.0 3551.8 1093.6 1168.6 1173.5 1183.9 1196.6 14531.0 14667.4 14705.3 14712.9 14747.9 4622.7 4714.5 4918.5 4929.8 4974.5 10199.8 10216.7 10236.0 10238.6 10246.0 5359.8 5370.9 5374.5 5376.2 5379.6 4654.0 4710.6 4782.1 4922.9 4986.8 3660.0 3707.8 3741.4 3751.9 3791.0 1125.3 1146.0 1146.3 1160.2 1162.1 684.7 712.6 723.3 732.0 740.9 5331.4 5410.2 5425.2 5571.6 5637.7 530.2 546.8 549.1 549.3 550.6 4112.3 4136.7 4165.7 4171.4 4184.4 12868.2 12880.2 12944.9 12950.6 13020.0 12693.9 12965.2 12973.8 12975.7 13354.5 6512.3 6725.4 6753.1 6799.7 6817.4 5668.7 5826.5 5928.9 5974.7 6084.1 11936.8 12197.4 12315.7 12317.4 12321.9 12234.7 12240.4 12342.7 12405.6 12637.5 7367.3 7503.0 7544.7 7587.2 7612.4 9568.4 9870.5 9871.2 9883.4 9921.1 8161.7 8212.5 8286.2 8316.3 8708.7 7692.6 8100.0 8114.9 8137.9 8141.7 7429.5 7486.4 7549.5 7625.7 7641.0 5252.0 5300.1 5341.3 5343.9 5630.8 5087.7 5245.7 5245.8 5254.1 5445.2 04:21:32 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | [#4] prototype.html Cycles:180 Average:4661.89 Median:5342.83 stddev:1400.37 (26.2%) stddev-sans-first:1366.89 04:21:32 INFO - PID 28298 | Values: 378.1 388.1 392.6 393.6 398.9 5339.3 5422.0 5457.0 5490.6 5518.5 5247.2 5310.2 5310.8 5324.4 5348.7 4015.7 4022.0 4024.8 4032.4 4037.3 3868.5 3994.0 4033.5 4044.3 4047.3 3987.2 3991.1 3992.4 3996.3 4003.3 3989.9 3998.0 4007.6 4011.0 4012.9 3507.4 3513.9 3516.9 3528.6 3533.1 5197.2 5219.2 5256.3 5266.3 5269.1 4699.3 4704.2 4717.5 4740.5 4741.7 5530.0 5649.8 5651.1 5669.4 5679.2 3924.4 3930.0 3938.5 3942.4 3961.0 5817.9 5943.6 5960.8 5968.4 6060.3 3881.0 3902.9 3904.4 3916.7 3953.5 3976.8 3995.0 3998.7 4005.2 4010.8 4554.9 4645.3 4655.5 4657.0 4695.8 5676.0 5708.9 5710.3 5717.4 5732.0 1378.9 1379.0 1380.9 1381.0 1381.7 886.4 922.4 944.5 946.5 950.3 4821.8 4852.5 4864.2 4871.7 4884.3 5888.9 5920.6 5922.8 5924.9 5941.9 4841.7 4883.3 4913.6 4918.9 4954.8 3074.0 3105.7 3109.6 3123.9 3132.6 5346.4 5394.0 5415.2 5435.2 5441.8 5886.4 5986.1 6053.5 6055.5 6062.4 5410.9 5420.3 5435.2 5447.2 5463.7 5729.5 5863.2 5891.3 5896.9 5899.4 5801.9 5809.4 5812.6 5821.5 5836.8 5311.3 5442.5 5451.8 5454.6 5469.6 4005.5 4025.0 4040.7 4047.4 4056.6 5848.8 5950.7 5950.8 5954.9 5973.8 5728.3 5756.8 5759.4 5775.8 5783.1 5692.5 5693.3 5713.0 5716.9 5726.5 5434.6 5542.8 5581.4 5621.3 5621.6 5722.1 5758.8 5759.5 5762.3 5767.3 5506.5 5602.0 5605.6 5608.0 5632.5 04:21:32 INFO - PID 28298 | 04:21:32 INFO - PID 28298 | [#5] yui.html Cycles:180 Average:15197.62 Median:33636.50 stddev:18060.83 (53.7%) stddev-sans-first:18078.81 04:21:32 INFO - PID 28298 | Values: 730.2 731.1 747.3 755.0 760.7 12361.1 12912.8 13464.7 14131.9 14183.3 13777.2 14074.7 14154.2 14179.2 14190.0 831.6 857.0 857.1 858.2 859.5 897.7 902.7 902.9 905.5 907.8 948.0 949.7 952.0 953.4 955.1 933.3 942.8 944.0 944.7 948.3 683.4 688.0 690.6 691.0 695.4 13510.5 13633.8 13812.9 14736.3 14919.6 15277.8 15304.8 15576.1 15765.3 15796.4 11963.8 12270.4 12406.4 12539.9 12559.4 3004.1 3009.9 3023.7 3025.3 3034.2 63359.7 63576.4 64399.0 64495.0 64773.4 11473.1 11834.2 11905.0 11945.3 11949.0 22115.0 22156.6 22434.8 22739.3 22809.7 6027.2 6081.1 6088.8 6095.3 6099.1 2849.2 2872.7 2899.8 2901.2 2905.2 3443.5 3470.7 3482.6 3508.4 3651.7 733.9 742.1 747.7 748.6 750.3 560.5 587.7 602.0 602.2 615.8 9459.5 9829.7 10074.6 10126.1 10326.9 599.5 602.1 613.6 614.3 624.0 4590.4 4737.3 4744.4 4746.0 4886.7 65335.3 67075.7 67603.7 68289.7 69562.0 57943.4 58348.4 58719.4 58824.7 60939.0 52202.0 52991.7 53198.0 53433.2 53869.7 9297.3 9798.4 9862.4 9931.2 9934.1 27435.5 27454.5 27663.7 28032.7 28433.7 32917.3 33066.5 33420.3 33852.7 33864.3 10887.4 11094.2 11165.7 11293.7 11320.7 14960.0 15560.1 15842.4 16074.6 16185.9 13197.0 13398.5 13516.5 13626.9 13684.7 14879.8 14952.9 15047.3 15061.3 15210.4 13283.0 13612.5 13873.2 13964.6 14170.1 10718.6 10995.8 11065.4 11648.8 11733.3 10403.2 10855.4 11066.5 11118.7 11171.3 04:21:32 INFO - PID 28298 | -------- Summary: end -------- 04:21:32 INFO - PID 28298 | 04:21:33 INFO - TEST-INFO | 28298: exit 0 04:21:33 INFO - TEST-OK | dromaeo_css | took 1119082ms 04:21:33 INFO - TEST-START | kraken 04:21:33 INFO - operating with platform_type : linux_ 04:21:33 INFO - Initialising browser for kraken test... 04:21:33 INFO - TEST-INFO | started process 28747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTUA_5/profile http://localhost:42877/getInfo.html) 04:21:33 INFO - PID 28747 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:21:37 INFO - PID 28747 | __metrics Screen width/height:1600/1200 04:21:37 INFO - PID 28747 | colorDepth:24 04:21:37 INFO - PID 28747 | Browser inner width/height: 1024/695 04:21:37 INFO - PID 28747 | __metrics 04:21:39 INFO - TEST-INFO | 28747: exit 0 04:21:39 INFO - Browser initialized. 04:21:39 INFO - Running cycle 1/1 for kraken test... 04:21:39 INFO - TEST-INFO | started process 28940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTUA_5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:50 INFO - PID 28940 | RSS: Main: 166219776 04:21:50 INFO - PID 28940 | 04:21:53 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42877/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:54 INFO - PID 28940 | RSS: Main: 170971136 04:21:54 INFO - PID 28940 | 04:21:57 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42877/tests/kraken/driver.html?testName=audio-dft) 04:21:57 INFO - PID 28940 | RSS: Main: 170586112 04:21:57 INFO - PID 28940 | 04:22:00 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42877/tests/kraken/driver.html?testName=audio-fft) 04:22:01 INFO - PID 28940 | RSS: Main: 166166528 04:22:01 INFO - PID 28940 | 04:22:03 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42877/tests/kraken/driver.html?testName=audio-oscillator) 04:22:04 INFO - PID 28940 | RSS: Main: 166313984 04:22:04 INFO - PID 28940 | 04:22:06 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42877/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:06 INFO - PID 28940 | RSS: Main: 166744064 04:22:06 INFO - PID 28940 | 04:22:10 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42877/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:10 INFO - PID 28940 | RSS: Main: 170274816 04:22:10 INFO - PID 28940 | 04:22:14 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42877/tests/kraken/driver.html?testName=imaging-desaturate) 04:22:14 INFO - PID 28940 | RSS: Main: 168226816 04:22:14 INFO - PID 28940 | 04:22:17 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42877/tests/kraken/driver.html?testName=json-parse-financial) 04:22:18 INFO - PID 28940 | RSS: Main: 169091072 04:22:18 INFO - PID 28940 | 04:22:20 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42877/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:22:20 INFO - PID 28940 | RSS: Main: 169230336 04:22:20 INFO - PID 28940 | 04:22:22 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42877/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:22:23 INFO - PID 28940 | RSS: Main: 168685568 04:22:23 INFO - PID 28940 | 04:22:25 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42877/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:25 INFO - PID 28940 | RSS: Main: 168792064 04:22:25 INFO - PID 28940 | 04:22:28 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:22:29 INFO - PID 28940 | RSS: Main: 169451520 04:22:29 INFO - PID 28940 | 04:22:32 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:22:33 INFO - PID 28940 | RSS: Main: 169324544 04:22:33 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | Cycle 1(1): loaded http://localhost:42877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42877/tests/kraken/driver.html?testName=ai-astar) 04:22:35 INFO - PID 28940 | RSS: Main: 170364928 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | __start_tp_report 04:22:35 INFO - PID 28940 | _x_x_mozilla_page_load 04:22:35 INFO - PID 28940 | _x_x_mozilla_page_load_details 04:22:35 INFO - PID 28940 | |i|pagename|runs| 04:22:35 INFO - PID 28940 | |0;ai-astar;107;112;112;111;113;111;113;118;118;117 04:22:35 INFO - PID 28940 | |1;audio-beat-detection;154;125;124;174;130;123;125;124;169;130 04:22:35 INFO - PID 28940 | |2;audio-dft;165;165;165;164;162;166;173;165;167;162 04:22:35 INFO - PID 28940 | |3;audio-fft;76;75;74;101;75;76;75;77;107;76 04:22:35 INFO - PID 28940 | |4;audio-oscillator;82;83;104;84;83;83;97;84;84;105 04:22:35 INFO - PID 28940 | |5;imaging-gaussian-blur;114;115;114;114;113;114;115;114;116;114 04:22:35 INFO - PID 28940 | |6;imaging-darkroom;151;150;155;150;151;150;149;150;150;150 04:22:35 INFO - PID 28940 | |7;imaging-desaturate;94;96;95;95;96;95;95;94;95;95 04:22:35 INFO - PID 28940 | |8;json-parse-financial;56;58;56;55;56;55;58;55;56;56 04:22:35 INFO - PID 28940 | |9;json-stringify-tinderbox;56;55;55;56;56;55;56;56;55;55 04:22:35 INFO - PID 28940 | |10;stanford-crypto-aes;83;82;83;84;82;82;83;83;87;93 04:22:35 INFO - PID 28940 | |11;stanford-crypto-ccm;137;135;132;141;135;135;133;133;191;139 04:22:35 INFO - PID 28940 | |12;stanford-crypto-pbkdf2;190;188;209;203;195;186;188;196;196;191 04:22:35 INFO - PID 28940 | |13;stanford-crypto-sha256-iterative;76;76;73;73;78;76;72;72;77;78 04:22:35 INFO - PID 28940 | __end_tp_report 04:22:35 INFO - PID 28940 | __start_cc_report 04:22:35 INFO - PID 28940 | _x_x_mozilla_cycle_collect,764 04:22:35 INFO - PID 28940 | __end_cc_report 04:22:35 INFO - PID 28940 | __startTimestamp1494933755346__endTimestamp 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | ------- Summary: start ------- 04:22:35 INFO - PID 28940 | Number of tests: 14 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:3.52 (3.1%) stddev-sans-first:2.93 04:22:35 INFO - PID 28940 | Values: 107.0 112.0 112.0 111.0 113.0 111.0 113.0 118.0 118.0 117.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:130.00 stddev:19.99 (15.4%) stddev-sans-first:20.32 04:22:35 INFO - PID 28940 | Values: 154.0 125.0 124.0 174.0 130.0 123.0 125.0 124.0 169.0 130.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:3.10 (1.9%) stddev-sans-first:3.28 04:22:35 INFO - PID 28940 | Values: 165.0 165.0 165.0 164.0 162.0 166.0 173.0 165.0 167.0 162.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:12.13 (16.1%) stddev-sans-first:12.72 04:22:35 INFO - PID 28940 | Values: 76.0 75.0 74.0 101.0 75.0 76.0 75.0 77.0 107.0 76.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:83.50 stddev:9.29 (11.1%) stddev-sans-first:9.51 04:22:35 INFO - PID 28940 | Values: 82.0 83.0 104.0 84.0 83.0 83.0 97.0 84.0 84.0 105.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 04:22:35 INFO - PID 28940 | Values: 114.0 115.0 114.0 114.0 113.0 114.0 115.0 114.0 116.0 114.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.00 stddev:1.65 (1.1%) stddev-sans-first:1.74 04:22:35 INFO - PID 28940 | Values: 151.0 150.0 155.0 150.0 151.0 150.0 149.0 150.0 150.0 150.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 04:22:35 INFO - PID 28940 | Values: 94.0 96.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.10 (2.0%) stddev-sans-first:1.17 04:22:35 INFO - PID 28940 | Values: 56.0 58.0 56.0 55.0 56.0 55.0 58.0 55.0 56.0 56.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 04:22:35 INFO - PID 28940 | Values: 56.0 55.0 55.0 56.0 56.0 55.0 56.0 56.0 55.0 55.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:3.43 (4.1%) stddev-sans-first:3.61 04:22:35 INFO - PID 28940 | Values: 83.0 82.0 83.0 84.0 82.0 82.0 83.0 83.0 87.0 93.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:136.00 stddev:17.75 (13.1%) stddev-sans-first:18.77 04:22:35 INFO - PID 28940 | Values: 137.0 135.0 132.0 141.0 135.0 135.0 133.0 133.0 191.0 139.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.20 Median:195.50 stddev:7.27 (3.7%) stddev-sans-first:7.55 04:22:35 INFO - PID 28940 | Values: 190.0 188.0 209.0 203.0 195.0 186.0 188.0 196.0 196.0 191.0 04:22:35 INFO - PID 28940 | 04:22:35 INFO - PID 28940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:76.00 stddev:2.38 (3.1%) stddev-sans-first:2.50 04:22:35 INFO - PID 28940 | Values: 76.0 76.0 73.0 73.0 78.0 76.0 72.0 72.0 77.0 78.0 04:22:35 INFO - PID 28940 | -------- Summary: end -------- 04:22:35 INFO - PID 28940 | 04:22:36 INFO - TEST-INFO | 28940: exit 0 04:22:36 INFO - TEST-OK | kraken | took 62984ms 04:22:36 INFO - SUITE-END | took 1182s 04:22:36 INFO - Completed test suite (00:19:42) 04:22:36 INFO - javascript benchmark 04:22:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6632.979300549631, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2692.717264687209, 2700.257429206968, 2729.0993971989233, 2740.3149212696812, 2741.1776467059885, 5080.060188865063, 5150.286897836623, 5190.403103643082, 5190.688558686482, 5259.552938000265, 5141.331626888508, 5210.452902445246, 5211.609129315298, 5232.110541208004, 5250.894982100355, 4583.0, 4586.97706511467, 4623.0984957933215, 4666.323383109447, 4673.485916549177, 4628.398308219927, 4665.9066818663605, 4672.4393072831135, 4724.0, 4775.0, 4520.751358675271, 4651.674382793206, 4693.037927224927, 4694.108119457293, 4699.248120300753, 4559.794809233593, 4613.653975951817, 4650.7442090685, 4674.368960190365, 4683.976580117112, 4560.657950653715, 4613.123506533781, 4619.653525985531, 4624.028953919647, 4700.707305490983, 5164.431912489623, 5176.974115129438, 5215.113430716788, 5231.816886408996, 5243.737813109329, 5456.699881506515, 5559.58303127263, 5578.944210557924, 5674.120511320752, 5675.716214189274, 5645.943540564583, 5661.5187709044785, 5663.9716801415725, 5678.233438485793, 5724.656520608777, 5198.636095473356, 5202.8959420812125, 5247.501487358695, 5266.0257852297445, 5314.92027619586, 5688.687122208318, 5737.827865164052, 5761.0, 5763.0, 5784.537237021028, 5363.383210930715, 5412.539934105566, 5470.398256191816, 5470.863228419242, 5474.835754927359, 5529.391766905637, 5539.806106786243, 5580.91628625571, 5590.217369568264, 5593.188987596775, 5644.096944488862, 5662.207290979266, 5668.319801623831, 5672.461116193955, 5673.971630141906, 5625.184348269478, 5635.943640563624, 5641.379448260688, 5661.745221465044, 5688.288963879515, 4718.693284936537, 4734.07685501324, 4735.668503204812, 4740.976295118502, 4774.140654682121, 4005.879823605238, 4043.838246470108, 4089.7750623715983, 4096.873359826012, 4112.712110152321, 4758.0, 4838.443578988391, 4845.733484658307, 4848.17581011229, 4850.563449289581, 5673.3475650299915, 5690.0, 5695.829125126253, 5711.029125048752, 5738.942610573924, 4791.257355109963, 4797.424309082932, 4801.51984801517, 4802.975985120052, 4847.80608775652, 4926.088673595396, 4997.9500204997485, 5002.649814513022, 5020.899582008339, 5029.1450453423, 5177.0, 5187.144121220107, 5188.455212202815, 5188.558972487381, 5192.5586325162785, 5606.747696353756, 5613.438656134354, 5618.325800903917, 5618.634788738719, 5619.409961953936, 5176.301199338041, 5179.015986962465, 5226.738663066907, 5274.7890084396195, 5279.656822306538, 5538.363088244742, 5589.189567512769, 5590.217369568182, 5607.859803504945, 5608.691521966331, 5476.397596264328, 5565.63823351497, 5640.520555752807, 5653.462921022497, 5713.542916566747, 5406.810761623325, 5410.729463526886, 5452.263944367618, 5478.260434841405, 5480.451954804487, 5379.300690910157, 5380.569554435558, 5381.677099373894, 5391.16436952273, 5398.46015398457, 5144.922826157535, 5296.708681022581, 5321.122014867504, 5378.300820893259, 5381.784728610812, 5418.593605479526, 5479.75341109659, 5491.835244942658, 5512.641678290898, 5538.390777014606, 5344.091504444176, 5365.865853353697, 5367.490088441592, 5367.597430192673, 5414.729263536886], "value": 5093.037165325487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.3837784371907, 736.6059158350283, 760.5778792770012, 1031.649239258652, 1049.6168898352093, 31518.52722209166, 32445.188870278256, 32490.837545812297, 32501.51247731286, 32569.348613027756, 34574.481382779275, 34878.476822847675, 34903.47644785324, 35139.12152196196, 35211.119722006966, 6871.931280687179, 6951.0616066830835, 7028.262032486592, 7046.189688185873, 7055.188653304885, 7003.789886303419, 7063.187733410647, 7083.539569927938, 7084.57492550446, 7096.716131354739, 7035.296470352975, 7091.645417729119, 7096.53872498286, 7107.076080109604, 7109.0758201434, 7043.295670432942, 7076.681549330241, 7087.0, 7097.21930587635, 7106.898430743217, 6960.199577048654, 6973.3375329344135, 6980.755673551452, 6991.126109236346, 7026.894596581055, 31825.204369890707, 31968.840155799073, 31971.52042719361, 32068.679313207034, 32078.6792132078, 3064.2952121012067, 3080.3223290876194, 3081.3529158876663, 3086.6141732283463, 3112.004158669227, 24225.394365140837, 24257.757422425904, 24340.634890476656, 24395.390115247083, 24509.754902450924, 2880.2367372646268, 2883.308006078547, 2889.3498962733215, 2893.3345330574084, 2897.5508796136633, 136972.31513842466, 137102.31448842792, 144315.0, 145385.99999999895, 146001.0, 38175.6182438172, 38248.8087559566, 38354.80822595869, 38385.23229535449, 38452.0, 40211.39682904759, 40495.293511895085, 40524.79737601293, 40542.79728601338, 40572.0, 11813.763724725457, 11904.107191960638, 11907.52369905194, 11914.702132446584, 11917.821232681517, 9459.24326053914, 9506.334556580972, 9510.857337139949, 9518.476483793458, 9534.90465095354, 12537.122401431812, 12668.11323207385, 12672.303023333805, 12689.873101269053, 12873.485060597659, 5258.868528286824, 5395.109806881899, 5471.124620060771, 5498.147787093007, 5502.779888804403, 832.8625776746769, 900.7297810656777, 906.2161230535539, 911.5351170902754, 913.584319134792, 20653.380398588066, 21225.469363266042, 21276.680849787266, 21310.010721518338, 21593.460163495725, 959.8128364968765, 962.9744322296732, 991.7520619845038, 992.2359782967075, 994.7562847102506, 10880.292780969212, 11141.387223702612, 11371.204015718986, 11390.316581005167, 11477.966982971573, 172630.0, 173234.13382933257, 173452.0, 173806.0, 173978.1301093512, 40102.79948600238, 40275.59724402777, 40344.0, 40501.79749101236, 40527.79736101301, 1223.6329101269762, 1240.5347994502063, 1247.2267194339568, 1247.7130260040242, 1248.2136254160002, 19773.505662358555, 19813.801861981196, 20075.598488029864, 21090.57818843645, 21222.893885530473, 29048.7095129046, 29107.272318192216, 29114.7088529112, 29165.416691666473, 29172.854135729187, 143787.0, 144352.0, 144689.27655362076, 144692.0, 145512.0, 28144.29639259035, 28413.584845287554, 28978.218593931764, 29939.251518712208, 30090.0, 34982.47526287159, 35066.47400288947, 35130.47304290387, 35159.47260791039, 35258.29483410369, 25775.484490310464, 26986.730132698423, 27040.1887943362, 27829.304267393476, 28173.0, 26447.206583802516, 26866.731332686424, 27360.452790943673, 28342.291442714097, 28559.14322570326, 29223.0, 29594.852025739732, 29782.851085744434, 30101.69898300989, 30461.84769076229, 25617.0, 25778.35554111162, 26398.07606733755, 26638.600420993313, 27701.30746731348, 19686.507837304183, 21801.236956706438, 21860.781392185876, 21889.562208756055, 22224.0], "value": 14311.527961635435, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.6086689270913, 403.1010845813837, 409.2408582080242, 420.08840815430517, 427.25444100045405, 13041.869581304209, 17125.400610978617, 17681.64636707265, 17891.73162402565, 17957.191926363314, 15892.920535397307, 16073.91963040186, 16153.676926461463, 17483.562910927234, 17729.202185901635, 5210.1403268460845, 5221.738913054361, 5391.973040134813, 5416.160495123262, 5482.369527504328, 5445.047116754572, 5478.58910581706, 5499.257600223978, 5516.117421212607, 5528.917066244009, 5289.603279754015, 5391.272178255944, 5428.61999660024, 5451.37309209442, 5490.505854473096, 5384.219288203209, 5430.891382172374, 5449.455054494559, 5451.182322651594, 5454.372747134091, 4752.859313764706, 4800.903981920377, 4835.0, 4855.417349917997, 4877.3903262092235, 21346.893265533574, 21749.2387766429, 21778.237761678425, 21778.455538611503, 21828.781712182994, 1607.477569789823, 1638.6476907464953, 1641.253229780447, 1641.3844808196927, 1648.752687096933, 14262.429502819978, 15030.323635436322, 15271.083734975937, 15277.0, 15419.306131224123, 1997.1611922992233, 2001.0795034284247, 2054.3528788431595, 2059.938201853947, 2063.1128614695676, 83011.0, 83681.0, 84121.57939210265, 84613.0, 85836.14163858345, 10488.842667359995, 10492.685219443429, 10572.418516981486, 10651.467426628638, 10659.0, 14311.06800581929, 14480.85519144795, 14487.710245795026, 14504.854951450561, 14524.128552286897, 7270.436856075863, 7371.262873712586, 7434.516756410816, 7476.626168691544, 7555.962220188974, 6755.324467553205, 6765.154355705537, 7006.299370062953, 7007.614581198083, 7038.085048943604, 6374.808755737336, 6626.966865165643, 6655.201375834931, 6677.866442671217, 6813.897791533131, 1935.777385600674, 1952.588553136875, 1975.6641370966684, 1979.8713083649516, 1992.511834600503, 852.654674856684, 895.4582477601087, 896.6413434626071, 904.5341649050744, 918.3204428722697, 16827.0, 16951.0, 17427.651446971242, 17744.46766597004, 17786.46640600784, 875.5140896802209, 893.2139717049085, 895.4224525181352, 908.927285817133, 919.4942781470164, 9270.814583708288, 9395.671151509665, 9579.0, 9706.805863882682, 9761.755956101013, 340470.0, 344256.0, 344591.0, 346865.0, 364195.0, 77642.22357776349, 77662.0, 78294.0, 79466.20533794588, 80086.59956700295, 1083.4636854756789, 1125.0886781706843, 1137.2721458266717, 1139.9373034483017, 1140.3272069479046, 17056.57358566046, 17849.0, 18289.725654114933, 18387.632247355246, 18446.723299150253, 38852.0, 38894.4165837507, 39079.41380879346, 39248.80375598104, 39291.80354098211, 49287.50712492829, 49876.75061624669, 50278.245826311904, 50407.49592504028, 50469.49530504648, 7685.193054729397, 7865.252800983897, 7918.841623167619, 7932.841343172989, 8041.236082572146, 12369.319687417279, 12374.010079193822, 12497.18768280059, 12528.436220369922, 12701.87298127007, 10811.405372704578, 10842.24104312722, 10866.945665271624, 10873.673789786319, 11034.724131896766, 9874.753131171778, 10512.842307365549, 10562.207834412297, 10568.154547636017, 10730.356178628996, 10657.14742820557, 10954.342739435659, 11043.337399756041, 11119.666410007712, 11130.217445638591, 7938.880916786137, 8019.839603207786, 8030.919690803017, 8085.919140808516, 8204.753857384288, 10658.573657053632, 10820.080293174853, 10918.18113641496, 10943.179261555257, 11275.323480590863], "value": 8713.088606025278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1220.3776074202158, 1256.6104507602638, 1256.6104507602645, 1264.6079715288256, 1284.08188145476, 9859.802803943916, 10230.181585473154, 10361.948190259047, 10424.687259382212, 10632.415217163052, 10340.948295258531, 10516.158707303417, 10529.52617132229, 10534.0, 10568.78862422751, 2244.6969659096058, 2270.3416009357265, 2273.6134857074335, 2273.874936878471, 2277.1119263487253, 2136.2309568555306, 2174.021690239391, 2181.6618424144285, 2184.2464349799375, 2187.8030977212047, 2183.967240491394, 2194.1771835561663, 2209.933701988943, 2234.229190929127, 2236.1502629000956, 2171.35944896256, 2214.435318993654, 2256.537409830981, 2262.8189744820374, 2268.6370180771078, 2116.6401711709045, 2172.478605134772, 2173.174193806359, 2189.0696454006984, 2250.0999600160067, 10172.186225101974, 10324.948375258151, 10332.431716255604, 10338.172946164288, 10347.275690701654, 5354.9196762048605, 5518.696471694056, 5534.557235421197, 5541.778328866841, 5542.806001789918, 3297.950530742041, 3465.1683595936793, 3475.6350583188905, 3525.9774665347018, 3551.786892786441, 1093.5680406239492, 1168.6377223060792, 1173.4895320535595, 1183.8993685536739, 1196.6290449960452, 14531.0, 14667.413303467849, 14705.26473676312, 14712.852871471363, 14747.926260368737, 4622.705642420127, 4714.504976977437, 4918.458969513351, 4929.75351232437, 4974.527419895104, 10199.796004079877, 10216.693499194887, 10236.027577380137, 10238.59045638181, 10246.0, 5359.758810853521, 5370.946290537123, 5374.462553744673, 5376.220448035013, 5379.569634429236, 4654.0, 4710.62315014798, 4782.115308667908, 4922.90154196914, 4986.750662466862, 3660.0, 3707.758995665327, 3741.4387841823946, 3751.8874433767032, 3790.995386222653, 1125.3416751200639, 1146.043054049861, 1146.306484576819, 1160.158884808507, 1162.0935670177275, 684.7295318349323, 712.6401167410424, 723.2586598736232, 731.9707211711578, 740.8703476891523, 5331.3868905076415, 5410.215518749759, 5425.186222066643, 5571.609987300931, 5637.7181140942785, 530.1967519208403, 546.8168163665138, 549.0720682047328, 549.3188446326526, 550.5513006899364, 4112.300908845504, 4136.669066474675, 4165.729227600196, 4171.436856024458, 4184.3932629768515, 12868.22790632565, 12880.162789418659, 12944.870551294554, 12950.611481655566, 13020.0, 12693.936530317475, 12965.22208667483, 12973.805392919114, 12975.740485190432, 13354.532591359255, 6512.316206798313, 6725.361090696376, 6753.08833307507, 6799.7280108796085, 6817.420519255819, 5668.7165641718575, 5826.504747096375, 5928.851778705567, 5974.731137098928, 6084.056971169476, 11936.820947685965, 12197.390130493262, 12315.69210769738, 12317.384130793604, 12321.93839030799, 12234.694132646755, 12240.387980600755, 12342.691432714253, 12405.62783116508, 12637.494500219887, 7367.263273672805, 7502.962485187539, 7544.660490277841, 7587.203343649058, 7612.391008719178, 9568.425894446076, 9870.506474676382, 9871.160951319218, 9883.406995580288, 9921.057499537532, 8161.714339998071, 8212.507249565046, 8286.212809783061, 8316.293115085044, 8708.738737837875, 7692.615369231404, 8099.959500202697, 8114.878276825734, 8137.877931831145, 8141.674333026613, 7429.517081389692, 7486.363659089038, 7549.471536992577, 7625.656845442079, 7641.0, 5251.973740131275, 5300.098983172793, 5341.305630268041, 5343.866403339792, 5630.8029218977135, 5087.745612719275, 5245.659032162897, 5245.763940622757, 5254.054270231395, 5445.1832225166545], "value": 4671.142499291992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.06806222661135, 388.0589570292042, 392.5642536784167, 393.6378531750789, 398.9421533877587, 5339.252504649343, 5421.972890135554, 5456.972715136424, 5490.56075513959, 5518.503334699882, 5247.212918062292, 5310.230016647583, 5310.8406747797535, 5324.440933701963, 5348.652337598053, 4015.6586690131303, 4022.034711669208, 4024.7786371749544, 4032.4354590357225, 4037.2934736421157, 3868.535775706919, 3993.98003009986, 4033.455483509718, 4044.251813414513, 4047.291723948312, 3987.2424239394422, 3991.1020020495303, 3992.361222204448, 3996.300647386696, 4003.2994226010333, 3989.920201595981, 3998.0, 4007.5572793794213, 4010.9598904010877, 4012.9197416051807, 3507.368673638744, 3513.877014304487, 3516.876909308162, 3528.576570811493, 3533.116720819795, 5197.194434862602, 5219.181641913362, 5256.26412302278, 5266.289050978107, 5269.104252277084, 4699.318598803155, 4704.200285951397, 4717.504662010508, 4740.549647783455, 4741.739204343759, 5530.0, 5649.830505084854, 5651.124075768263, 5669.376368599492, 5679.182661548306, 3924.4309575111733, 3929.98035009826, 3938.5076865391825, 3942.4086387041884, 3960.960390396117, 5817.923684118409, 5943.613665111754, 5960.821175364746, 5968.373320801296, 6060.272767267912, 3881.049142959993, 3902.902427439337, 3904.4338570907057, 3916.6670832979516, 3953.548799744177, 3976.8011599419915, 3995.0, 3998.7200895937585, 4005.2189822984237, 4010.7994600270454, 4554.86128467883, 4645.326427667969, 4655.464621568495, 4656.976715116402, 4695.835645752382, 5675.971620141873, 5708.9153060919125, 5710.314762228559, 5717.37108918027, 5732.0, 1378.910370825893, 1379.0002248369851, 1380.9033367664367, 1380.951666691681, 1381.730562540295, 886.3972498700816, 922.3820040572832, 944.5182956692137, 946.5267366316841, 950.254050570299, 4821.842757738117, 4852.539008794159, 4864.173090574611, 4871.732054736953, 4884.3161957326, 5888.941110588925, 5920.5559583031445, 5922.792702255487, 5924.881502369928, 5941.910871336933, 4841.685290456109, 4883.291922671193, 4913.631477639191, 4918.90162196754, 4954.801807927643, 3074.0, 3105.6739042400673, 3109.595752552154, 3123.8906638267554, 3132.63974642919, 5346.4118946915805, 5393.950298886477, 5415.236410694608, 5435.211894275308, 5441.809536666197, 5886.352501224862, 5986.132010858401, 6053.545984051214, 6055.515558755289, 6062.363451837494, 5410.862709229832, 5420.268263784339, 5435.211894275387, 5447.210154527571, 5463.72681365938, 5729.4843464088435, 5863.237779088691, 5891.263592050994, 5896.941030589811, 5899.38056504078, 5801.8549536261935, 5809.448102430262, 5812.593118481665, 5821.505172060422, 5836.766529338779, 5311.256424100707, 5442.455754424526, 5451.836444906659, 5454.563634909277, 5469.617126801245, 4005.5393629732953, 4025.0, 4040.6565441937764, 4047.3928910663635, 4056.5740597238046, 5848.824535263949, 5950.732217050329, 5950.7917222896995, 5954.940450595439, 5973.790917317873, 5728.276620196905, 5756.769729210952, 5759.366469688247, 5775.758211984444, 5783.103618939072, 5692.474482786278, 5693.316801983623, 5712.971435142797, 5716.8570785729025, 5726.455986681259, 5434.619576629598, 5542.7782888685615, 5581.413951535031, 5621.297337832771, 5621.606487545832, 5722.113072473773, 5758.827235182951, 5759.539236860957, 5762.279715035621, 5767.250257466502, 5506.476884695948, 5601.971990140023, 5605.635633683797, 5607.971960140337, 5632.493075623213], "value": 4231.905320187345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.2150188547312, 731.0642377756474, 747.3124725252767, 754.9698012079517, 760.7375455467861, 12361.134720569564, 12912.806307905388, 13464.66338341542, 14131.92934035331, 14183.290835458225, 13777.242251676154, 14074.71850562988, 14154.15075095495, 14179.220142892136, 14190.0, 831.5592735850009, 857.0, 857.1214505132227, 858.2061593026457, 859.4843094143495, 897.6633762339122, 902.7111324376202, 902.8510295801185, 905.4748246017327, 907.8320510705507, 947.9573419196153, 949.7340744591526, 951.9524023798817, 953.3517208298355, 955.0878910640356, 933.2533972821749, 942.7737343037655, 943.9764005899839, 944.7401964459759, 948.3172116076414, 683.3951952522004, 687.9690413931385, 690.6305126757211, 691.0394551573318, 695.4054283587561, 13510.459581616724, 13633.795493067513, 13812.93093534536, 14736.263186840722, 14919.627009324853, 15277.847221527754, 15304.770428443582, 15576.065436073759, 15765.290561924741, 15796.368145274175, 11963.820542691867, 12270.38648067593, 12406.441710123067, 12539.937300313532, 12559.434825432878, 3004.1438190115714, 3009.9398012039637, 3023.712747289004, 3025.2890570715863, 3034.1656044587917, 63359.6832015837, 63576.36423635797, 64399.0, 64495.0, 64773.3522664772, 11473.082153427706, 11834.171607987359, 11905.0, 11945.283283003047, 11949.0, 22115.0, 22156.556868862855, 22434.775652243596, 22739.317820465083, 22809.657855132187, 6027.156198132265, 6081.118237855486, 6088.756449741961, 6095.268567771807, 6099.085137229451, 2849.202223377458, 2872.6840047594746, 2899.7970142089853, 2901.202169403431, 2905.2301140197865, 3443.466262729281, 3470.670286322795, 3482.5820901491984, 3508.368493671164, 3651.6713495785507, 733.8899165125274, 742.1391186223955, 747.7270796159363, 748.5658318175446, 750.264740554249, 560.4643277419922, 587.665030932373, 601.9668918209541, 602.1509671363444, 615.7721642992121, 9459.479728614991, 9829.705108846745, 10074.647387341407, 10126.139278161292, 10326.896731032593, 599.5323647554915, 602.1239097113689, 613.6256883301182, 614.3365165621118, 623.9812805615838, 4590.403247577793, 4737.3130896020575, 4744.4069491313585, 4746.0, 4886.65793394459, 65335.34664653388, 67075.66462167658, 67603.66198168977, 68289.65855170692, 69562.0, 57943.420565794644, 58348.416515835146, 58719.41280587225, 58824.70587647035, 60939.0, 52202.0, 52991.735041324544, 53198.0, 53433.198502022504, 53869.730651346494, 9297.30482624134, 9798.363106398061, 9862.408255504406, 9931.205503559553, 9934.056264654846, 27435.451290974466, 27454.450910981268, 27663.72336276692, 28032.719672803825, 28433.715662843933, 32917.341653167285, 33066.504002440466, 33420.331593368486, 33852.66147338594, 33864.322713546084, 10887.401192934465, 11094.22340436194, 11165.665030048787, 11293.71765705864, 11320.660380188607, 14960.0, 15560.144192069545, 15842.366305347658, 16074.598135046717, 16185.919070404572, 13197.0, 13398.464061437433, 13516.459341626225, 13626.863731362955, 13684.726305473636, 14879.776803347742, 14952.850471495145, 15047.322870470636, 15061.322240498985, 15210.391584336945, 13283.0, 13612.455501780214, 13873.236971966639, 13964.581062568139, 14170.149791012573, 10718.624848130277, 10995.835062474229, 11065.391403472886, 11648.825267620823, 11733.296002239893, 10403.167746580406, 10855.40295283767, 11066.502007409847, 11118.722031949266, 11171.329720216812], "value": 6783.058886257207, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 112.0, 111.0, 113.0, 111.0, 113.0, 118.0, 118.0, 117.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 124.0, 174.0, 130.0, 123.0, 125.0, 124.0, 169.0, 130.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 164.0, 162.0, 166.0, 173.0, 165.0, 167.0, 162.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 101.0, 75.0, 76.0, 75.0, 77.0, 107.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 104.0, 84.0, 83.0, 83.0, 97.0, 84.0, 84.0, 105.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 116.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 155.0, 150.0, 151.0, 150.0, 149.0, 150.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 55.0, 56.0, 55.0, 58.0, 55.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 82.0, 82.0, 83.0, 83.0, 87.0, 93.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 132.0, 141.0, 135.0, 135.0, 133.0, 133.0, 191.0, 139.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 188.0, 209.0, 203.0, 195.0, 186.0, 188.0, 196.0, 196.0, 191.0], "value": 194.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 73.0, 73.0, 78.0, 76.0, 72.0, 72.0, 77.0, 78.0], "value": 75.1, "unit": "score"}]}]} 04:22:36 INFO - Return code: 0 04:22:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:22:36 INFO - # TBPL SUCCESS # 04:22:36 INFO - Running post-action listener: _resource_record_post_action 04:22:36 INFO - [mozharness: 2017-05-16 11:22:36.664877Z] Finished run-tests step (success) 04:22:36 INFO - Running post-run listener: _resource_record_post_run 04:22:36 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390807552; Read time: 20; Write time: 353428 04:22:36 INFO - TinderboxPrint: CPU usage
13.3% 04:22:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:22:36 INFO - TinderboxPrint: I/O write bytes / time
390,807,552 / 353,428 04:22:36 INFO - TinderboxPrint: CPU idle
8,298.7 (86.6%) 04:22:36 INFO - TinderboxPrint: CPU user
1,221.4 (12.8%) 04:22:36 INFO - TinderboxPrint: Swap in / out
0 / 0 04:22:36 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 68247552; Read time: 0; Write time: 29976 04:22:36 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 272101376; Read time: 0; Write time: 209484 04:22:37 INFO - Running post-run listener: _upload_blobber_files 04:22:37 INFO - Blob upload gear active. 04:22:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:37 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 04:22:37 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'] 04:22:37 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 04:22:37 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:22:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:22:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:38 INFO - (blobuploader) - INFO - Done attempting. 04:22:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:22:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:22:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:41 INFO - (blobuploader) - INFO - Done attempting. 04:22:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:22:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:22:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:42 INFO - (blobuploader) - INFO - Done attempting. 04:22:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:22:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:22:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:43 INFO - (blobuploader) - INFO - Done attempting. 04:22:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:43 INFO - Return code: 0 04:22:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da84b6aa17581ab0bc77cc9a2b7dc10b5bf294e3b68c669b3fb2e5c7cace3f7b24b69530ae35953907fea7c9c7372caefd3cc9ddfb65cc4ba9a0cf9945a5d5d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0dad74d3c654f5084d985bae66bbd6bef53bb504e9089e879c1d4ef98b659ebd086ff83d640de2b327978049125a166e37910708206322fff57e1139cc89b981", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/046e9b6774ab680be2e693782ad297fc305df26a98ec88e2659cf7d4313239c7d095e3cf5f080a3fd0dedd6d3bb9b3e6638494d888f2f83b172c1f2e8695edd5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d85b60f1dde7717b34a8ba8689d372d1069825e0d2ed723c23a096be100d7594051311926ecbfddbb191774db961c02398e809086c95afd7064eb371555b8a2a"} 04:22:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:43 INFO - Contents: 04:22:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da84b6aa17581ab0bc77cc9a2b7dc10b5bf294e3b68c669b3fb2e5c7cace3f7b24b69530ae35953907fea7c9c7372caefd3cc9ddfb65cc4ba9a0cf9945a5d5d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0dad74d3c654f5084d985bae66bbd6bef53bb504e9089e879c1d4ef98b659ebd086ff83d640de2b327978049125a166e37910708206322fff57e1139cc89b981", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/046e9b6774ab680be2e693782ad297fc305df26a98ec88e2659cf7d4313239c7d095e3cf5f080a3fd0dedd6d3bb9b3e6638494d888f2f83b172c1f2e8695edd5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d85b60f1dde7717b34a8ba8689d372d1069825e0d2ed723c23a096be100d7594051311926ecbfddbb191774db961c02398e809086c95afd7064eb371555b8a2a"} 04:22:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:43 INFO - Copying logs to upload dir... 04:22:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.464561 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-16 04:22:42.446089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 04:22:42.454051) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da84b6aa17581ab0bc77cc9a2b7dc10b5bf294e3b68c669b3fb2e5c7cace3f7b24b69530ae35953907fea7c9c7372caefd3cc9ddfb65cc4ba9a0cf9945a5d5d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0dad74d3c654f5084d985bae66bbd6bef53bb504e9089e879c1d4ef98b659ebd086ff83d640de2b327978049125a166e37910708206322fff57e1139cc89b981", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/046e9b6774ab680be2e693782ad297fc305df26a98ec88e2659cf7d4313239c7d095e3cf5f080a3fd0dedd6d3bb9b3e6638494d888f2f83b172c1f2e8695edd5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d85b60f1dde7717b34a8ba8689d372d1069825e0d2ed723c23a096be100d7594051311926ecbfddbb191774db961c02398e809086c95afd7064eb371555b8a2a"} build_url:https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/KbojJVZXTseTNqyB-IpQHQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da84b6aa17581ab0bc77cc9a2b7dc10b5bf294e3b68c669b3fb2e5c7cace3f7b24b69530ae35953907fea7c9c7372caefd3cc9ddfb65cc4ba9a0cf9945a5d5d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0dad74d3c654f5084d985bae66bbd6bef53bb504e9089e879c1d4ef98b659ebd086ff83d640de2b327978049125a166e37910708206322fff57e1139cc89b981", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/046e9b6774ab680be2e693782ad297fc305df26a98ec88e2659cf7d4313239c7d095e3cf5f080a3fd0dedd6d3bb9b3e6638494d888f2f83b172c1f2e8695edd5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d85b60f1dde7717b34a8ba8689d372d1069825e0d2ed723c23a096be100d7594051311926ecbfddbb191774db961c02398e809086c95afd7064eb371555b8a2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 04:22:42.482850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:22:42.483198) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1494932505.478429-1805758876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:22:42.563170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 04:22:42.563513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 04:22:42.566999) ========= ========= Total master_lag: 0.20 =========