builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1495386861.81 results: success (0) revision: b31a663614e8df7876563e03c4735aa5c8a38f5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:21.807670) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:21.808162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:21.808451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:21.825314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:21.825612) ========= 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=3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-21 10:14:21-- 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% 37.5M=0s 2017-05-21 10:14:22 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131721 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:21.970375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:21.970774) ========= 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=3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016465 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:22.022966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-21 10:14:22.023762) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b31a663614e8df7876563e03c4735aa5c8a38f5a --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 b31a663614e8df7876563e03c4735aa5c8a38f5a --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=3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-21 10:14:22,184 truncating revision to first 12 chars 2017-05-21 10:14:22,184 Setting DEBUG logging. 2017-05-21 10:14:22,184 attempt 1/10 2017-05-21 10:14:22,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b31a663614e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-21 10:14:23,431 unpacking tar archive at: mozilla-central-b31a663614e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.629601 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-21 10:14:23.692361) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:23.692684) ========= script_repo_revision: b31a663614e8df7876563e03c4735aa5c8a38f5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:23.693068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:23.693339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-21 10:14:23.701586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-21 10:14:23.701914) ========= /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=3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:23 INFO - MultiFileLogger online at 20170521 10:14:23 in /builds/slave/test 10:14:23 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 10:14:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:23 INFO - {'append_to_log': False, 10:14:23 INFO - 'base_work_dir': '/builds/slave/test', 10:14:23 INFO - 'blob_upload_branch': 'Firefox', 10:14:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:23 INFO - 'branch': 'Firefox', 10:14:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:23 INFO - 'config_files': ('talos/linux_config.py',), 10:14:23 INFO - 'default_actions': ('clobber', 10:14:23 INFO - 'read-buildbot-config', 10:14:23 INFO - 'download-and-extract', 10:14:23 INFO - 'populate-webroot', 10:14:23 INFO - 'create-virtualenv', 10:14:23 INFO - 'install', 10:14:23 INFO - 'run-tests'), 10:14:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:23 INFO - 'download_minidump_stackwalk': True, 10:14:23 INFO - 'download_symbols': 'ondemand', 10:14:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:23 INFO - 'gecko_profile': False, 10:14:23 INFO - 'gecko_profile_interval': 0, 10:14:23 INFO - 'installer_path': 'installer.exe', 10:14:23 INFO - 'log_level': 'info', 10:14:23 INFO - 'log_name': 'talos', 10:14:23 INFO - 'log_to_console': True, 10:14:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:23 INFO - 'opt_config_files': (), 10:14:23 INFO - 'pip_index': False, 10:14:23 INFO - 'suite': 'dromaeojs-e10s', 10:14:23 INFO - 'system_bits': '32', 10:14:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:23 INFO - 'title': 'talos-linux64-ix-030', 10:14:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:23 INFO - 'use_talos_json': True, 10:14:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:23 INFO - 'work_dir': 'build'} 10:14:23 INFO - [mozharness: 2017-05-21 17:14:23.933175Z] Running clobber step. 10:14:23 INFO - Running pre-action listener: _resource_record_pre_action 10:14:23 INFO - Running main action method: clobber 10:14:23 INFO - rmtree: /builds/slave/test/build 10:14:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:24 INFO - Running post-action listener: _resource_record_post_action 10:14:24 INFO - [mozharness: 2017-05-21 17:14:24.953656Z] Finished clobber step (success) 10:14:24 INFO - [mozharness: 2017-05-21 17:14:24.953758Z] Running read-buildbot-config step. 10:14:24 INFO - Running pre-action listener: _resource_record_pre_action 10:14:24 INFO - Running main action method: read_buildbot_config 10:14:24 INFO - Using buildbot properties: 10:14:24 INFO - { 10:14:24 INFO - "project": "", 10:14:24 INFO - "product": "firefox", 10:14:24 INFO - "who": "philringnalda@gmail.com", 10:14:24 INFO - "installer_path": "public/build/target.tar.bz2", 10:14:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 10:14:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:14:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 10:14:24 INFO - "stage_platform": "linux64-stylo", 10:14:24 INFO - "basedir": "/builds/slave/test", 10:14:24 INFO - "buildnumber": 102, 10:14:24 INFO - "platform": "ubuntu64_hw_stylo", 10:14:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:14:24 INFO - "slavebuilddir": "test", 10:14:24 INFO - "taskId": "AS37woCAQISl9ShljYJ08A", 10:14:24 INFO - "branch": "mozilla-central", 10:14:24 INFO - "script_repo_revision": "production", 10:14:24 INFO - "revision": "b31a663614e8df7876563e03c4735aa5c8a38f5a", 10:14:24 INFO - "slavename": "talos-linux64-ix-030", 10:14:24 INFO - "repo_path": "mozilla-central" 10:14:24 INFO - } 10:14:24 INFO - Finding installer, test and symbols from parent task. 10:14:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AS37woCAQISl9ShljYJ08A'}, attempt #1 10:14:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AS37woCAQISl9ShljYJ08A'}, attempt #1 10:14:25 INFO - Task dependencies: D3QdNzzWR_a9NWu79MqGHg 10:14:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg'}, attempt #1 10:14:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.tar.bz2 10:14:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/test_packages.json 10:14:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.crashreporter-symbols.zip 10:14:26 INFO - Running post-action listener: _resource_record_post_action 10:14:26 INFO - [mozharness: 2017-05-21 17:14:26.332580Z] Finished read-buildbot-config step (success) 10:14:26 INFO - [mozharness: 2017-05-21 17:14:26.332801Z] Running download-and-extract step. 10:14:26 INFO - Running pre-action listener: _resource_record_pre_action 10:14:26 INFO - Running main action method: download_and_extract 10:14:26 INFO - mkdir: /builds/slave/test/build/tests 10:14:26 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')]} 10:14:26 INFO - trying https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.test_packages.json 10:14:26 INFO - Downloading https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:14:26 INFO - Downloaded 986 bytes. 10:14:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:14:26 INFO - Using the following test package requirements: 10:14:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:14:26 INFO - u'common': [u'target.common.tests.zip'], 10:14:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:14:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:14:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:14:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:14:26 INFO - u'mozbase': [u'target.common.tests.zip'], 10:14:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:14:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:14:26 INFO - u'web-platform': [u'target.common.tests.zip', 10:14:26 INFO - u'target.web-platform.tests.zip'], 10:14:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:14:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:14:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.common.tests.zip 10:14:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:14:26 INFO - Fetch https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.common.tests.zip into memory 10:14:28 INFO - Content-Length response header: 63520797 10:14:28 INFO - Bytes received: 63520797 10:14:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:14:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.common.tests.zip 10:14:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:14:38 INFO - Fetch https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.common.tests.zip into memory 10:14:40 INFO - Content-Length response header: 63520797 10:14:40 INFO - Bytes received: 63520797 10:14:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.talos.tests.zip 10:14:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:14:52 INFO - Fetch https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.talos.tests.zip into memory 10:14:52 INFO - Content-Length response header: 14410000 10:14:52 INFO - Bytes received: 14410000 10:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:52 INFO - trying https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.tar.bz2 10:14:52 INFO - Downloading https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:14:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:14:54 INFO - Downloaded 56538274 bytes. 10:14:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.tar.bz2 10:14:54 INFO - mkdir: /builds/slave/test/properties 10:14:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:14:54 INFO - Writing to file /builds/slave/test/properties/build_url 10:14:54 INFO - Contents: 10:14:54 INFO - build_url:https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.tar.bz2 10:14:54 INFO - Running post-action listener: _resource_record_post_action 10:14:54 INFO - Running post-action listener: set_extra_try_arguments 10:14:54 INFO - [mozharness: 2017-05-21 17:14:54.010853Z] Finished download-and-extract step (success) 10:14:54 INFO - [mozharness: 2017-05-21 17:14:54.010950Z] Running populate-webroot step. 10:14:54 INFO - Running pre-action listener: _resource_record_pre_action 10:14:54 INFO - Running main action method: populate_webroot 10:14:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:54 INFO - '--tppagecycles', 10:14:54 INFO - '7'], 10:14:54 INFO - 'tests': ['tsvgm']}}, 10:14:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:14:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:14:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:14:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:14:54 INFO - 'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:14:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:14:54 INFO - 'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['damp', 'tps']}, 10:14:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:14:54 INFO - 'tests': ['damp', 'tps']}, 10:14:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['dromaeo_dom']}, 10:14:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:14:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:14:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:14:54 INFO - 'tests': ['ts_paint', 'tp5o']}, 10:14:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['a11yr', 10:14:54 INFO - 'ts_paint', 10:14:54 INFO - 'tpaint', 10:14:54 INFO - 'sessionrestore', 10:14:54 INFO - 'sessionrestore_no_auto_restore', 10:14:54 INFO - 'tabpaint']}, 10:14:54 INFO - 'other-e10s': {'tests': ['a11yr', 10:14:54 INFO - 'ts_paint', 10:14:54 INFO - 'tpaint', 10:14:54 INFO - 'sessionrestore', 10:14:54 INFO - 'sessionrestore_no_auto_restore', 10:14:54 INFO - 'tabpaint']}, 10:14:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:14:54 INFO - 'ts_paint', 10:14:54 INFO - 'tpaint', 10:14:54 INFO - 'sessionrestore', 10:14:54 INFO - 'sessionrestore_no_auto_restore', 10:14:54 INFO - 'tabpaint']}, 10:14:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:14:54 INFO - 'ts_paint', 10:14:54 INFO - 'tpaint', 10:14:54 INFO - 'sessionrestore', 10:14:54 INFO - 'sessionrestore_no_auto_restore', 10:14:54 INFO - 'tabpaint']}, 10:14:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['a11yr', 10:14:54 INFO - 'ts_paint', 10:14:54 INFO - 'tpaint', 10:14:54 INFO - 'sessionrestore', 10:14:54 INFO - 'sessionrestore_no_auto_restore', 10:14:54 INFO - 'tabpaint']}, 10:14:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['a11yr', 10:14:54 INFO - 'ts_paint', 10:14:54 INFO - 'tpaint', 10:14:54 INFO - 'sessionrestore', 10:14:54 INFO - 'sessionrestore_no_auto_restore', 10:14:54 INFO - 'tabpaint']}, 10:14:54 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:14:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:14:54 INFO - 'bloom_basic_ref']}, 10:14:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['tsvgx', 10:14:54 INFO - 'tsvgr_opacity', 10:14:54 INFO - 'tart', 10:14:54 INFO - 'tscrollx', 10:14:54 INFO - 'cart', 10:14:54 INFO - 'tsvg_static']}, 10:14:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:14:54 INFO - 'tsvgr_opacity', 10:14:54 INFO - 'tart', 10:14:54 INFO - 'tscrollx', 10:14:54 INFO - 'cart', 10:14:54 INFO - 'tsvg_static']}, 10:14:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:14:54 INFO - 'talos_options': ['--disable-e10s'], 10:14:54 INFO - 'tests': ['tp5o']}, 10:14:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:14:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:14:54 INFO - 'talos_options': ['--disable-e10s', 10:14:54 INFO - '--xperf_path', 10:14:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:54 INFO - 'tests': ['tp5n']}, 10:14:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:14:54 INFO - 'talos_options': ['--xperf_path', 10:14:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:54 INFO - 'tests': ['tp5n']}}, 10:14:54 INFO - 'talos.zip': {'path': '', 10:14:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:54 INFO - Running post-action listener: _resource_record_post_action 10:14:54 INFO - [mozharness: 2017-05-21 17:14:54.024855Z] Finished populate-webroot step (success) 10:14:54 INFO - [mozharness: 2017-05-21 17:14:54.024943Z] Running create-virtualenv step. 10:14:54 INFO - Running pre-action listener: _resource_record_pre_action 10:14:54 INFO - Running main action method: create_virtualenv 10:14:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:14:54 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 10:14:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:14:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:54 INFO - Using real prefix '/usr' 10:14:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:14:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:56 INFO - Installing pip.................done. 10:14:56 INFO - Return code: 0 10:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:14:56 INFO - Reading from file tmpfile_stdout 10:14:56 INFO - Output received: 10:14:56 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) 10:14:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:14:56 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')]} 10:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:56 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')]} 10:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:56 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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:14:56 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 10:14:56 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 10:14:56 INFO - Using env: {'DISPLAY': ':0', 10:14:56 INFO - 'HOME': '/home/cltbld', 10:14:56 INFO - 'LANG': 'en_US.UTF-8', 10:14:56 INFO - 'LANGUAGE': 'en_US:en', 10:14:56 INFO - 'LOGNAME': 'cltbld', 10:14:56 INFO - 'MAIL': '/var/mail/cltbld', 10:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:56 INFO - 'MOZ_NO_REMOTE': '1', 10:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:56 INFO - 'NO_EM_RESTART': '1', 10:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:56 INFO - 'PWD': '/builds/slave/test', 10:14:56 INFO - 'SHELL': '/bin/bash', 10:14:56 INFO - 'SHLVL': '1', 10:14:56 INFO - 'TERM': 'linux', 10:14:56 INFO - 'TMOUT': '86400', 10:14:56 INFO - 'USER': 'cltbld', 10:14:56 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:56 INFO - '_': '/tools/buildbot/bin/python'} 10:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:57 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 10:14:57 INFO - Cleaning up... 10:14:57 INFO - Return code: 0 10:14:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:14:57 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')]} 10:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:57 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')]} 10:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:57 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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:14:57 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 10:14:57 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 10:14:57 INFO - Using env: {'DISPLAY': ':0', 10:14:57 INFO - 'HOME': '/home/cltbld', 10:14:57 INFO - 'LANG': 'en_US.UTF-8', 10:14:57 INFO - 'LANGUAGE': 'en_US:en', 10:14:57 INFO - 'LOGNAME': 'cltbld', 10:14:57 INFO - 'MAIL': '/var/mail/cltbld', 10:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:57 INFO - 'MOZ_NO_REMOTE': '1', 10:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:57 INFO - 'NO_EM_RESTART': '1', 10:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:57 INFO - 'PWD': '/builds/slave/test', 10:14:57 INFO - 'SHELL': '/bin/bash', 10:14:57 INFO - 'SHLVL': '1', 10:14:57 INFO - 'TERM': 'linux', 10:14:57 INFO - 'TMOUT': '86400', 10:14:57 INFO - 'USER': 'cltbld', 10:14:57 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:57 INFO - '_': '/tools/buildbot/bin/python'} 10:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:57 INFO - Downloading/unpacking psutil>=3.1.1 10:14:57 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 10:14:57 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 10:14:57 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 10:14:57 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 10:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:58 INFO - Installing collected packages: psutil 10:14:58 INFO - Running setup.py install for psutil 10:14:58 INFO - building 'psutil._psutil_linux' extension 10:14:58 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 10:14:58 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 10:14:58 INFO - building 'psutil._psutil_posix' extension 10:14:58 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 10:14:58 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 10:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:58 INFO - Successfully installed psutil 10:14:58 INFO - Cleaning up... 10:14:58 INFO - Return code: 0 10:14:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:58 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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:14:58 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 10:14:58 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 10:14:58 INFO - Using env: {'DISPLAY': ':0', 10:14:58 INFO - 'HOME': '/home/cltbld', 10:14:58 INFO - 'LANG': 'en_US.UTF-8', 10:14:58 INFO - 'LANGUAGE': 'en_US:en', 10:14:58 INFO - 'LOGNAME': 'cltbld', 10:14:58 INFO - 'MAIL': '/var/mail/cltbld', 10:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:58 INFO - 'MOZ_NO_REMOTE': '1', 10:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:58 INFO - 'NO_EM_RESTART': '1', 10:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:58 INFO - 'PWD': '/builds/slave/test', 10:14:58 INFO - 'SHELL': '/bin/bash', 10:14:58 INFO - 'SHLVL': '1', 10:14:58 INFO - 'TERM': 'linux', 10:14:58 INFO - 'TMOUT': '86400', 10:14:58 INFO - 'USER': 'cltbld', 10:14:58 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:58 INFO - '_': '/tools/buildbot/bin/python'} 10:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:15:00 INFO - Installing collected packages: mozsystemmonitor 10:15:00 INFO - Running setup.py install for mozsystemmonitor 10:15:00 INFO - Successfully installed mozsystemmonitor 10:15:00 INFO - Cleaning up... 10:15:00 INFO - Return code: 0 10:15:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:15:00 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')]} 10:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:00 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')]} 10:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:00 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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:15:00 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 10:15:00 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 10:15:00 INFO - Using env: {'DISPLAY': ':0', 10:15:00 INFO - 'HOME': '/home/cltbld', 10:15:00 INFO - 'LANG': 'en_US.UTF-8', 10:15:00 INFO - 'LANGUAGE': 'en_US:en', 10:15:00 INFO - 'LOGNAME': 'cltbld', 10:15:00 INFO - 'MAIL': '/var/mail/cltbld', 10:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:00 INFO - 'MOZ_NO_REMOTE': '1', 10:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:00 INFO - 'NO_EM_RESTART': '1', 10:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:00 INFO - 'PWD': '/builds/slave/test', 10:15:00 INFO - 'SHELL': '/bin/bash', 10:15:00 INFO - 'SHLVL': '1', 10:15:00 INFO - 'TERM': 'linux', 10:15:00 INFO - 'TMOUT': '86400', 10:15:00 INFO - 'USER': 'cltbld', 10:15:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:00 INFO - '_': '/tools/buildbot/bin/python'} 10:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:00 INFO - Downloading/unpacking jsonschema==2.5.1 10:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:01 INFO - warning: no files found matching '*.txt' 10:15:01 INFO - no previously-included directories found matching 'build' 10:15:01 INFO - no previously-included directories found matching 'dist' 10:15:01 INFO - no previously-included directories found matching '.git*' 10:15:01 INFO - Installing collected packages: jsonschema, functools32 10:15:02 INFO - Running setup.py install for functools32 10:15:02 INFO - warning: no files found matching '*.txt' 10:15:02 INFO - no previously-included directories found matching 'build' 10:15:02 INFO - no previously-included directories found matching 'dist' 10:15:02 INFO - no previously-included directories found matching '.git*' 10:15:02 INFO - Successfully installed jsonschema functools32 10:15:02 INFO - Cleaning up... 10:15:02 INFO - Return code: 0 10:15:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:15:02 INFO - Using env: {'DISPLAY': ':0', 10:15:02 INFO - 'HOME': '/home/cltbld', 10:15:02 INFO - 'LANG': 'en_US.UTF-8', 10:15:02 INFO - 'LANGUAGE': 'en_US:en', 10:15:02 INFO - 'LOGNAME': 'cltbld', 10:15:02 INFO - 'MAIL': '/var/mail/cltbld', 10:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:02 INFO - 'MOZ_NO_REMOTE': '1', 10:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:02 INFO - 'NO_EM_RESTART': '1', 10:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:02 INFO - 'PWD': '/builds/slave/test', 10:15:02 INFO - 'SHELL': '/bin/bash', 10:15:02 INFO - 'SHLVL': '1', 10:15:02 INFO - 'TERM': 'linux', 10:15:02 INFO - 'TMOUT': '86400', 10:15:02 INFO - 'USER': 'cltbld', 10:15:02 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:02 INFO - '_': '/tools/buildbot/bin/python'} 10:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:15:02 INFO - Cleaning up... 10:15:02 INFO - Return code: 0 10:15:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:15:02 INFO - Using env: {'DISPLAY': ':0', 10:15:02 INFO - 'HOME': '/home/cltbld', 10:15:02 INFO - 'LANG': 'en_US.UTF-8', 10:15:02 INFO - 'LANGUAGE': 'en_US:en', 10:15:02 INFO - 'LOGNAME': 'cltbld', 10:15:02 INFO - 'MAIL': '/var/mail/cltbld', 10:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:02 INFO - 'MOZ_NO_REMOTE': '1', 10:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:02 INFO - 'NO_EM_RESTART': '1', 10:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:02 INFO - 'PWD': '/builds/slave/test', 10:15:02 INFO - 'SHELL': '/bin/bash', 10:15:02 INFO - 'SHLVL': '1', 10:15:02 INFO - 'TERM': 'linux', 10:15:02 INFO - 'TMOUT': '86400', 10:15:02 INFO - 'USER': 'cltbld', 10:15:02 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:02 INFO - '_': '/tools/buildbot/bin/python'} 10:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:02 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 10:15:02 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 10:15:02 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 10:15:02 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 10:15:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:04 INFO - Downloading docopt-0.6.1.tar.gz 10:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:04 INFO - Running setup.py install for blobuploader 10:15:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:04 INFO - Running setup.py install for requests 10:15:04 INFO - Running setup.py install for docopt 10:15:04 INFO - Successfully installed blobuploader requests docopt 10:15:04 INFO - Cleaning up... 10:15:04 INFO - Return code: 0 10:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:04 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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:15:04 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 10:15:04 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 10:15:04 INFO - Using env: {'DISPLAY': ':0', 10:15:04 INFO - 'HOME': '/home/cltbld', 10:15:04 INFO - 'LANG': 'en_US.UTF-8', 10:15:04 INFO - 'LANGUAGE': 'en_US:en', 10:15:04 INFO - 'LOGNAME': 'cltbld', 10:15:04 INFO - 'MAIL': '/var/mail/cltbld', 10:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:04 INFO - 'MOZ_NO_REMOTE': '1', 10:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:04 INFO - 'NO_EM_RESTART': '1', 10:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:04 INFO - 'PWD': '/builds/slave/test', 10:15:04 INFO - 'SHELL': '/bin/bash', 10:15:04 INFO - 'SHLVL': '1', 10:15:04 INFO - 'TERM': 'linux', 10:15:04 INFO - 'TMOUT': '86400', 10:15:04 INFO - 'USER': 'cltbld', 10:15:04 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:04 INFO - '_': '/tools/buildbot/bin/python'} 10:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:05 INFO - Running setup.py (path:/tmp/pip-wY9OHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:05 INFO - Running setup.py (path:/tmp/pip-G8N19b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:05 INFO - Running setup.py (path:/tmp/pip-pcaLdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:05 INFO - Running setup.py (path:/tmp/pip-_6WpEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:05 INFO - Running setup.py (path:/tmp/pip-mraQKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:05 INFO - Running setup.py (path:/tmp/pip-v3Qi97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:05 INFO - Running setup.py (path:/tmp/pip-6VIRZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:05 INFO - Running setup.py (path:/tmp/pip-rqwceP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:05 INFO - Running setup.py (path:/tmp/pip-wC4tSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:05 INFO - Running setup.py (path:/tmp/pip-6lVYlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:05 INFO - Running setup.py (path:/tmp/pip-laLWze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:05 INFO - Running setup.py (path:/tmp/pip-RI_TRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:05 INFO - Running setup.py (path:/tmp/pip-9T5Ws1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:06 INFO - Running setup.py (path:/tmp/pip-5au9g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:06 INFO - Running setup.py (path:/tmp/pip-OD9LiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:06 INFO - Running setup.py (path:/tmp/pip-JZOlU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:06 INFO - Running setup.py (path:/tmp/pip-2mfgeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:06 INFO - Running setup.py install for manifestparser 10:15:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:06 INFO - Running setup.py install for mozcrash 10:15:06 INFO - Running setup.py install for mozdebug 10:15:06 INFO - Running setup.py install for mozdevice 10:15:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:06 INFO - Running setup.py install for mozfile 10:15:06 INFO - Running setup.py install for mozhttpd 10:15:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:06 INFO - Running setup.py install for mozinfo 10:15:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Running setup.py install for mozInstall 10:15:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Running setup.py install for mozleak 10:15:07 INFO - Running setup.py install for mozlog 10:15:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Running setup.py install for moznetwork 10:15:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Running setup.py install for mozprocess 10:15:07 INFO - Running setup.py install for mozprofile 10:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Running setup.py install for mozrunner 10:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:07 INFO - Running setup.py install for mozscreenshot 10:15:07 INFO - Running setup.py install for moztest 10:15:07 INFO - Running setup.py install for mozversion 10:15:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:08 INFO - Cleaning up... 10:15:08 INFO - Return code: 0 10:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:08 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')]} 10:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:08 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')]} 10:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:08 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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:15:08 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 10:15:08 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 10:15:08 INFO - Using env: {'DISPLAY': ':0', 10:15:08 INFO - 'HOME': '/home/cltbld', 10:15:08 INFO - 'LANG': 'en_US.UTF-8', 10:15:08 INFO - 'LANGUAGE': 'en_US:en', 10:15:08 INFO - 'LOGNAME': 'cltbld', 10:15:08 INFO - 'MAIL': '/var/mail/cltbld', 10:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:08 INFO - 'MOZ_NO_REMOTE': '1', 10:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:08 INFO - 'NO_EM_RESTART': '1', 10:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:08 INFO - 'PWD': '/builds/slave/test', 10:15:08 INFO - 'SHELL': '/bin/bash', 10:15:08 INFO - 'SHLVL': '1', 10:15:08 INFO - 'TERM': 'linux', 10:15:08 INFO - 'TMOUT': '86400', 10:15:08 INFO - 'USER': 'cltbld', 10:15:08 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:08 INFO - '_': '/tools/buildbot/bin/python'} 10:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:08 INFO - Running setup.py (path:/tmp/pip-xI4fyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:08 INFO - Running setup.py (path:/tmp/pip-Po7f5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:08 INFO - Running setup.py (path:/tmp/pip-4iyHNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:08 INFO - Running setup.py (path:/tmp/pip-mqKwqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:08 INFO - Running setup.py (path:/tmp/pip-mLhDah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:08 INFO - Running setup.py (path:/tmp/pip-AVwNxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:08 INFO - Running setup.py (path:/tmp/pip-4T1Wds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:08 INFO - Running setup.py (path:/tmp/pip-hfizVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:08 INFO - Running setup.py (path:/tmp/pip-rn4DXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:08 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)) 10:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:08 INFO - Running setup.py (path:/tmp/pip-F8eVhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:09 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)) 10:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:09 INFO - Running setup.py (path:/tmp/pip-9aSGxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:09 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)) 10:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:09 INFO - Running setup.py (path:/tmp/pip-npJgvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:09 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)) 10:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:09 INFO - Running setup.py (path:/tmp/pip-hE5VCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:09 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)) 10:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:09 INFO - Running setup.py (path:/tmp/pip-_L0bXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:09 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)) 10:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:09 INFO - Running setup.py (path:/tmp/pip-u1aZZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:09 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)) 10:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:09 INFO - Running setup.py (path:/tmp/pip-mbVFtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:09 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)) 10:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:09 INFO - Running setup.py (path:/tmp/pip-O5_4Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:09 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)) 10:15:09 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)) 10:15:09 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)) 10:15:09 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)) 10:15:09 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)) 10:15:09 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)) 10:15:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:09 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 10:15:09 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 10:15:09 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 10:15:09 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 10:15:10 INFO - Downloading blessings-1.6.tar.gz 10:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:10 INFO - Installing collected packages: blessings 10:15:10 INFO - Running setup.py install for blessings 10:15:10 INFO - Successfully installed blessings 10:15:10 INFO - Cleaning up... 10:15:10 INFO - Return code: 0 10:15:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:11 INFO - Reading from file tmpfile_stdout 10:15:11 INFO - Current package versions: 10:15:11 INFO - argparse == 1.2.1 10:15:11 INFO - blessings == 1.6 10:15:11 INFO - blobuploader == 1.2.4 10:15:11 INFO - docopt == 0.6.1 10:15:11 INFO - functools32 == 3.2.3-2 10:15:11 INFO - jsonschema == 2.5.1 10:15:11 INFO - manifestparser == 1.1 10:15:11 INFO - mozInstall == 1.12 10:15:11 INFO - mozcrash == 1.0 10:15:11 INFO - mozdebug == 0.1 10:15:11 INFO - mozdevice == 0.50 10:15:11 INFO - mozfile == 1.2 10:15:11 INFO - mozhttpd == 0.7 10:15:11 INFO - mozinfo == 0.9 10:15:11 INFO - mozleak == 0.1 10:15:11 INFO - mozlog == 3.4 10:15:11 INFO - moznetwork == 0.27 10:15:11 INFO - mozprocess == 0.25 10:15:11 INFO - mozprofile == 0.28 10:15:11 INFO - mozrunner == 6.13 10:15:11 INFO - mozscreenshot == 0.1 10:15:11 INFO - mozsystemmonitor == 0.3 10:15:11 INFO - moztest == 0.8 10:15:11 INFO - mozversion == 1.4 10:15:11 INFO - psutil == 3.1.1 10:15:11 INFO - requests == 1.2.3 10:15:11 INFO - wsgiref == 0.1.2 10:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:11 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')]} 10:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:11 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')]} 10:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:11 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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:15:11 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 10:15:11 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 10:15:11 INFO - Using env: {'DISPLAY': ':0', 10:15:11 INFO - 'HOME': '/home/cltbld', 10:15:11 INFO - 'LANG': 'en_US.UTF-8', 10:15:11 INFO - 'LANGUAGE': 'en_US:en', 10:15:11 INFO - 'LOGNAME': 'cltbld', 10:15:11 INFO - 'MAIL': '/var/mail/cltbld', 10:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:11 INFO - 'MOZ_NO_REMOTE': '1', 10:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:11 INFO - 'NO_EM_RESTART': '1', 10:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:11 INFO - 'PWD': '/builds/slave/test', 10:15:11 INFO - 'SHELL': '/bin/bash', 10:15:11 INFO - 'SHLVL': '1', 10:15:11 INFO - 'TERM': 'linux', 10:15:11 INFO - 'TMOUT': '86400', 10:15:11 INFO - 'USER': 'cltbld', 10:15:11 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:11 INFO - '_': '/tools/buildbot/bin/python'} 10:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 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)) 10:15:11 INFO - Cleaning up... 10:15:11 INFO - Return code: 0 10:15:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15:11 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')]} 10:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:11 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')]} 10:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, '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': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', '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 10:15:11 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 10:15:11 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 10:15:11 INFO - Using env: {'DISPLAY': ':0', 10:15:11 INFO - 'HOME': '/home/cltbld', 10:15:11 INFO - 'LANG': 'en_US.UTF-8', 10:15:11 INFO - 'LANGUAGE': 'en_US:en', 10:15:11 INFO - 'LOGNAME': 'cltbld', 10:15:11 INFO - 'MAIL': '/var/mail/cltbld', 10:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:11 INFO - 'MOZ_NO_REMOTE': '1', 10:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:11 INFO - 'NO_EM_RESTART': '1', 10:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:11 INFO - 'PWD': '/builds/slave/test', 10:15:11 INFO - 'SHELL': '/bin/bash', 10:15:11 INFO - 'SHLVL': '1', 10:15:11 INFO - 'TERM': 'linux', 10:15:11 INFO - 'TMOUT': '86400', 10:15:11 INFO - 'USER': 'cltbld', 10:15:11 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:11 INFO - '_': '/tools/buildbot/bin/python'} 10:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:15:11 INFO - Cleaning up... 10:15:11 INFO - Return code: 0 10:15:11 INFO - Running post-action listener: _resource_record_post_action 10:15:11 INFO - Running post-action listener: _start_resource_monitoring 10:15:11 INFO - Starting resource monitoring. 10:15:11 INFO - [mozharness: 2017-05-21 17:15:11.604310Z] Finished create-virtualenv step (success) 10:15:11 INFO - [mozharness: 2017-05-21 17:15:11.604772Z] Running install step. 10:15:11 INFO - Running pre-action listener: _resource_record_pre_action 10:15:11 INFO - Running main action method: install 10:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:11 INFO - Reading from file tmpfile_stdout 10:15:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:11 INFO - Reading from file tmpfile_stdout 10:15:11 INFO - Output received: 10:15:11 INFO - Usage: mozinstall [options] installer 10:15:11 INFO - Options: 10:15:11 INFO - -h, --help show this help message and exit 10:15:11 INFO - -d DEST, --destination=DEST 10:15:11 INFO - Directory to install application into. [default: 10:15:11 INFO - "/builds/slave/test"] 10:15:11 INFO - --app=APP Application being installed. [default: firefox] 10:15:11 INFO - mkdir: /builds/slave/test/build/application 10:15:11 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'] 10:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:15:28 INFO - Reading from file tmpfile_stdout 10:15:28 INFO - Output received: 10:15:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:15:28 INFO - Running post-action listener: _resource_record_post_action 10:15:28 INFO - [mozharness: 2017-05-21 17:15:28.028866Z] Finished install step (success) 10:15:28 INFO - [mozharness: 2017-05-21 17:15:28.029144Z] Running run-tests step. 10:15:28 INFO - Running pre-action listener: _resource_record_pre_action 10:15:28 INFO - Running main action method: run_tests 10:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:28 INFO - Python 2.7.3 10:15:28 INFO - Return code: 0 10:15:28 INFO - grabbing minidump binary from tooltool 10:15:28 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')]} 10:15:28 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 0x22737a0>, '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 0x22746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2274b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15:28 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 10:15:28 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 10:15:28 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 10:15:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:28 INFO - Return code: 0 10:15:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:15:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:28 INFO - ENV: RUST_BACKTRACE is now 1 10:15:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:15:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:28 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/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 10:15:28 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/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 10:15:28 INFO - Using env: {'DISPLAY': ':0', 10:15:28 INFO - 'HOME': '/home/cltbld', 10:15:28 INFO - 'LANG': 'en_US.UTF-8', 10:15:28 INFO - 'LANGUAGE': 'en_US:en', 10:15:28 INFO - 'LOGNAME': 'cltbld', 10:15:28 INFO - 'MAIL': '/var/mail/cltbld', 10:15:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:28 INFO - 'MOZ_NO_REMOTE': '1', 10:15:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:28 INFO - 'NO_EM_RESTART': '1', 10:15:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:28 INFO - 'PWD': '/builds/slave/test', 10:15:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:28 INFO - 'RUST_BACKTRACE': '1', 10:15:28 INFO - 'SHELL': '/bin/bash', 10:15:28 INFO - 'SHLVL': '1', 10:15:28 INFO - 'TERM': 'linux', 10:15:28 INFO - 'TMOUT': '86400', 10:15:28 INFO - 'USER': 'cltbld', 10:15:28 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320', 10:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:28 INFO - '_': '/tools/buildbot/bin/python'} 10:15:28 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/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 10:15:28 INFO - mozversion application_buildid: 20170521163721 10:15:28 INFO - mozversion application_changeset: b31a663614e8df7876563e03c4735aa5c8a38f5a 10:15:28 INFO - mozversion application_display_name: Nightly 10:15:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:28 INFO - mozversion application_name: Firefox 10:15:28 INFO - mozversion application_remotingname: firefox 10:15:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:15:28 INFO - mozversion application_vendor: Mozilla 10:15:28 INFO - mozversion application_version: 55.0a1 10:15:28 INFO - mozversion platform_buildid: 20170521163721 10:15:28 INFO - mozversion platform_changeset: b31a663614e8df7876563e03c4735aa5c8a38f5a 10:15:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:15:28 INFO - mozversion platform_version: 55.0a1 10:15:28 INFO - using testdate: 1495386928 10:15:28 INFO - actual date: 1495386928 10:15:28 INFO - starting webserver on 'localhost:56933' 10:15:28 INFO - SUITE-START | Running 2 tests 10:15:28 INFO - TEST-START | dromaeo_css 10:15:28 INFO - operating with platform_type : linux_ 10:15:28 INFO - Initialising browser for dromaeo_css test... 10:15:28 INFO - TEST-INFO | started process 12366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7_SasQ/profile http://localhost:56933/getInfo.html) 10:15:28 INFO - PID 12366 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2970: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:15:32 INFO - PID 12366 | __metrics Screen width/height:1600/1200 10:15:32 INFO - PID 12366 | colorDepth:24 10:15:32 INFO - PID 12366 | Browser inner width/height: 1024/695 10:15:32 INFO - PID 12366 | __metrics 10:15:34 INFO - TEST-INFO | 12366: exit 0 10:15:34 INFO - Browser initialized. 10:15:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:34 INFO - TEST-INFO | started process 12544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7_SasQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:46 INFO - PID 12544 | RSS: Main: 170639360 10:15:46 INFO - PID 12544 | 10:18:51 INFO - PID 12544 | Cycle 1(1): loaded http://localhost:56933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56933/tests/dromaeo/cssquery-ext.html) 10:18:53 INFO - PID 12544 | RSS: Main: 173711360 10:18:53 INFO - PID 12544 | 10:21:55 INFO - PID 12544 | Cycle 1(1): loaded http://localhost:56933/tests/dromaeo/cssquery-ext.html (next: http://localhost:56933/tests/dromaeo/cssquery-jquery.html) 10:21:56 INFO - PID 12544 | RSS: Main: 172761088 10:21:56 INFO - PID 12544 | 10:24:57 INFO - PID 12544 | Cycle 1(1): loaded http://localhost:56933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56933/tests/dromaeo/cssquery-mootools.html) 10:24:58 INFO - PID 12544 | RSS: Main: 174501888 10:24:58 INFO - PID 12544 | 10:28:00 INFO - PID 12544 | Cycle 1(1): loaded http://localhost:56933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56933/tests/dromaeo/cssquery-prototype.html) 10:28:01 INFO - PID 12544 | RSS: Main: 173412352 10:28:01 INFO - PID 12544 | 10:31:04 INFO - PID 12544 | Cycle 1(1): loaded http://localhost:56933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56933/tests/dromaeo/cssquery-yui.html) 10:31:04 INFO - PID 12544 | RSS: Main: 172302336 10:31:04 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | Cycle 1(1): loaded http://localhost:56933/tests/dromaeo/cssquery-yui.html (next: http://localhost:56933/tests/dromaeo/cssquery-dojo.html) 10:34:06 INFO - PID 12544 | RSS: Main: 179666944 10:34:06 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | __start_tp_report 10:34:06 INFO - PID 12544 | _x_x_mozilla_page_load 10:34:06 INFO - PID 12544 | _x_x_mozilla_page_load_details 10:34:06 INFO - PID 12544 | |i|pagename|runs| 10:34:06 INFO - PID 12544 | |0;dojo.html;2679.405753576622;2695.689995650501;2700.635414219081;2730.440259746752;2732.781377489801;5039.31969184161;5149.227615857619;5152.510511501401;5163.509466600667;5207.166853303473;5110.795568177277;5181.792728290864;5183.663061900974;5239.711815850127;5295.629305948585;4348.5216626171095;4567.337736028274;4622.098690755296;4668.416447944007;4692.4369075710965;4700.27145792401;4731.455882573514;4739.691920025204;4747.881302967419;4775.426948766153;4579.656525760548;4586.518415566385;4638.350630911675;4652.511486293958;4678.812847486097;4655.627549796042;4666.136764698542;4671.649626278043;4707.129181101473;4713.57577817998;4605.102005109005;4608.792604332813;4611.2852507861335;4652.860414187579;4669.626429885635;5092.261622064817;5172.250023746573;5197.714125723083;5199.610029247821;5271.077561426735;5593.3847276799515;5610.214569960209;5646.632968857052;5663.9716801415725;5677.17680936262;5637.548996080303;5670.6030577859565;5687.232223649796;5688.11834165705;5704.401037891003;5203.063448579216;5246.65896716716;5270.077736396115;5271;5336.573074154058;5758.337791154071;5793.565482588739;5798.10129429939;5818.44724751148;5834.737436815353;5502.477264659851;5525.033119204123;5525.198846167364;5539.667619942817;5541.418151094158;5451.509364157166;5524.861878453071;5560.221568980346;5611.2144299798065;5615.382307946123;5452.26394436746;5559.193916882029;5570.275864137636;5571.498565129158;5572.888542229214;5504.587155963319;5532.3914369419335;5537.750801213874;5540.085885828874;5569.972150139223;4602.470715867651;4621.468531118897;4643.512431194676;4646.256598944153;4650.18621741194;4041.6968727345566;4061.1674606705556;4080.8367665293054;4083.612056854594;4085.5301640311745;4835.153848076572;4847.345608342899;4859.829905953275;4862.513748625109;4867.367242258484;5634.830955071272;5691.886162276731;5707.942920570741;5711.828645140652;5722.942770572241;4714.481407045222;4807.206810876236;4810.350602668595;4816.988432429229;4863.489333619989;4986.6758660687665;4987.925181122286;4993.7503124843615;5012.072766538202;5032.47159048302;5143.974280128576;5202.687838729688;5218.086834803818;5259.184826351845;5329.7068661224;5636.267285252891;5679.574031947538;5681.431856814451;5686.800961966312;5690.630109042899;5229.424763276113;5271.868203294948;5278;5283.10187268173;5289.153735402318;5500.862478437911;5524.530414914777;5544.750486228048;5550.08423610116;5558.638688485235;5583.302087239095;5657.236273103078;5664.0937450007805;5687.033204355353;5713.514351280188;5414.29614150158;5419.945800541944;5459.672419654833;5484.753186106715;5519.613627046068;5459.754311056092;5480.314960629921;5498.670079795225;5501.972490137524;5502.119660854404;5385.569154467712;5389.434109418455;5404.378496472798;5454.645448045864;5459.235707000944;5430.15832545956;5442.809501667422;5449.3188351456065;5490.231367608458;5504.311961004874;5242.947570524246;5308.522232999048;5337.492938170868;5388.811391601275;5400.0819860623005 10:34:06 INFO - PID 12544 | |1;ext.html;679.6431873266534;723.2225357740429;744.6351287868946;1072.8122578548757;1073.581303291717;32917.34165316695;33649.831750841244;33657.158571035674;33728.66271337292;33902.66097339023;35849.82075089627;36079.45880811784;36288.63711362886;36336.63663363372;36419.81790091052;6967;6979.581225126509;7064.611446370448;7099.574025558457;7108.502404831664;7013.719451221945;7060.541064830795;7099.112610923635;7103.502754807139;7103.928960710378;7096.609686467243;7143.535670181422;7145.8928116078305;7152.1046922565565;7157.17692465368;7081.079459670235;7088.503804733671;7088.89366659498;7115.430765538745;7125.144982602069;6992.895106573405;7050.506464547484;7052.083229180225;7061.329173728487;7064.470164737665;32455.83772081148;32880;32935.6706432935;32945.341093178;32972.6702732972;3067.2945222598705;3087.07387783664;3091.30445649727;3098.256418459576;3121.734652554513;24406.26781196567;24662;24726.258212253662;24788.752112479004;24811.751882481123;2899.4780939430893;2908.956365654517;2920.37211999419;2926.9853650731825;2928.1361998210577;142349.2882535591;142771;148170;152991;153076.9999999989;38298;38341.80829095892;38347.23305533874;38502.689838609775;38533.614663853565;40044.79977600093;40244.195116097515;40308.39537406941;40369.19261614751;40392;11823.645290641294;11905.523779048914;11914;11921.642350729491;11955.521779128738;9541.141297283139;9575.760605984768;9579.473128977834;9629.614815407445;9646.372985755903;11848.763024739457;11885.40572971348;12012.159148859497;12104.697382565506;12191.14661973671;5301.310829592206;5332.573394128461;5362.436944120889;5397.599512307222;5416.7020813855615;742.254034695128;892.830362231174;900.9234215091791;907.2424525521263;940.1585580905188;21204.575908482053;21361.893190534258;21374.679379809317;21560.56878862414;21701.13195472195;988.6243227573476;993.7217579077869;1001.1690297053428;1005.9295849290626;1020.8417695257247;10600.310979786289;11440.141989350832;11493.252938558968;11537.88462115368;11604.535818567332;173245;173945.13027435035;174419;174467;175208;40652.39021414681;40933.38599921003;40988.79505602513;41006.179876402304;41036.38445423321;1200.7538454616783;1241.4599649152647;1245.1532957588745;1247.931363775001;1273.6306471123455;19261.518462038563;19684.606307873477;20096.59806803885;20288;20537.075831587317;29191.102578332342;29327.413451731274;29370;29440.11679649614;29467.41065178727;151611;151874.24062879613;151951;152255;152372;29217.41565168727;29227.246365218154;29290.121296361143;30033.69966300309;30463.390732185675;34523.65476345305;35151;35405;35598.644013560566;35892;26364;26841.731582683922;27213.86393068022;27384.452310954068;28034;26366.340841479116;26782.464350712486;27256.863715681295;27548.449031019667;27921.86039069873;30147.246318842204;30261.243468913453;30491;30506;31045.844770776002;26742.59886101749;26890.462190756465;26965.730342696323;27779;28251.75801009746;20322;22054.832787931846;22155.113795448648;22289.77710222877;22545.098196071973 10:34:06 INFO - PID 12544 | |2;jquery.html;399.5026192390471;408.33033824527763;420.89056845220244;428.31042022344025;434.313784220931;14175.574732758008;17264.91367543162;17940.55148621285;17961.191746371427;18130.45608631743;18518;18728.719069213937;18782.342618008373;19229.711554326695;19460;5402.162664786954;5533.667979921198;5577.247071645337;5678.687672178028;5716.542676585884;5631.8592035199035;5637.887242255152;5663.377028526858;5691.231683722686;5694.487496125348;5478.561715062785;5583.3300003999575;5657.971710141464;5660.773569057233;5668.518175955028;5612.747426365823;5646.943530564703;5670.574706896979;5691.174779656968;5714.457126572969;5082.339295891547;5141.9228711568985;5147.305113809625;5184.377874655028;5197.1424714922;22292.66561001586;22471.887640561694;22565.54868902629;22777.31668049961;22822.201222957283;1586.6985272798247;1637.4187163556885;1640.0241856095604;1643.983560164395;1644.284736139771;14556.272186390637;14818.40726370944;15191.544253672408;15204.619884502865;15316.923415382964;1988.7315212446279;1999.6500612392774;2034.5829105033433;2044.9284275050302;2054.794520547948;89465.55267223687;92863.53568232116;93910.53044734869;94273.62990071086;94668;10711.410872402093;10951.890481095246;11036.337819730841;11048.613298534512;11074.446277686084;15123.39506419731;15545.68908621844;15554.22228888551;15554.74456203844;15563.144027078393;7871.84256314882;7888.171741967126;7950.284474397332;8185.836283274301;8208.712695055763;7509.586972716553;7524.699012039567;7677.30904218623;7726.111497177784;7727.459077864495;6802.537454447318;7012.333828286304;7094.326039026284;7155.284471552803;7156.677949492181;2045.8670186437835;2047.3653167518116;2071.2439959414705;2092.340912612522;2202.8568143070647;837.8198687282141;876.4434584039053;878.6441491196076;886.570013543431;903.6927444668713;17187.91406042962;17425.215865286093;17785.7332140018;18103.909480452778;18145.09274536268;880.7886107334193;883.6818745251704;895.7626229049307;903.5346796399859;916.1983264643437;9430.52847357643;9480.24158067353;11344.716382090348;12428.254304741744;12530.81203781944;382812;387841;390500;390826;399114;77454.612726936;80463;84031;84338;85292;1068.615298492542;1093.3931667924378;1108.5565773690428;1146.5929594993825;1152.8501294831617;17879.19543620514;17888.28446862111;18444.907775461037;18492;18777.248910043447;39247;40876.18247634971;41760.79119604383;41794.164116716885;42085.54012191417;49942;50362;50666;51069.74465127651;52530;8311.418200725891;8430.789230269047;8434.24091831738;8527.53098579584;8701.869471958053;13183.472661093449;13385.330733463483;13424.798628020391;13549.187048777105;13599.116057456235;11087.72280692989;11230.101591872794;11359.48882300315;11503.964643182153;11583.07335413148;10683.465826708478;10739.409332486788;10926.890731092906;10985;11078.723031923944;11496.82754758696;11565.768684626428;11576.189666723249;11630.76738465209;11798.11514136426;8321.16788321163;8334.374921880762;8508.021577518664;8613.569321534023;8649.3512986525;11013.779724405307;11077.778444431227;11214.49534770921;11311.830322545333;11404.543818247508 10:34:06 INFO - PID 12544 | |3;mootools.html;1244.2347956007056;1292.2539603342896;1303.302733037825;1309.1098053323742;1313.2776972665035;9460.905390946089;9725.319227654067;9944.403335799858;9949.30354875159;9993.150582200504;9919.553620087096;10044.497775111233;10062.094411502963;10101.797964040716;10105.848412273821;2148.398448434437;2174.749903761072;2207.0509680837235;2210.4694873230387;2212.8008479236864;2175.445261458326;2238.9776102238934;2240.865548067113;2245.5396643688086;2247.8426510144295;2187.9124835006583;2200.6478963365867;2209.2930262316067;2213.092632020872;2216.9778302216932;2190.5837890800776;2204.669299605072;2229.3312006398014;2231.933042008742;2233.798958093771;2096.5806838632334;2192.35325578953;2242.0471299697724;2242.2936774915847;2249.696291000727;9645.469499177543;9692.369995950241;9716.902830971741;9721.756956076155;9733.610655573768;5285.2600635911;5472;5487.807926722586;5496.560275177976;5522.9447705523235;3236.7086962173516;3491.9825400872833;3492.6856582907662;3513.4378499439968;3584.5160903277983;1044.6657069737687;1075.2795626929897;1076.3272954403499;1085.4301491716833;1096.660035389032;13764.242966636832;13771.242581658005;13781.586552403443;13815.654608634864;13908.887289016855;4440.444944381952;4613.077384523109;4720.244760838249;4765.499622539653;4793.113274044313;10104.69685909424;10118.241131915136;10139;10172.237082218864;10180.440075795754;5433.782648694087;5441.102218134043;5441.700706461103;5446.673199608036;5482.91775623366;4946.356973593482;5093.2105523643895;5105.795768169306;5109.770060347293;5133.332666753298;3543.805090720035;3631.1466805300734;3702.259548090393;3707.14735610811;3714.1457464783252;974.9707508774748;986.4673076538733;993.7863359377768;1006.9093781559549;1042.713253855196;687.5118665747375;714.371353209183;715.7494876793081;728.8360118973188;732.1287667675449;5260.13207820713;5418.756155972991;5421.891562168814;5444.50999410055;5471.23402723619;526.9446708095671;541.9972900135552;551.3081083240507;555.4639772619441;561.7444062951347;3188.2985743136474;3198.1205168578363;3220.935581288361;3302.669733026726;3397.9150521237166;11903.523859045714;12333.568325108577;12575.182613130117;12610.432530536147;12616.17994830333;11887.88112118885;12429.875701243052;12480.812787808009;12499.125061245808;12532.060095492874;6991.2309645937885;7170.211276759553;7218.530795498275;7316.865885787712;7325.926740732631;5752.223449834386;5858.443447872445;5883.764649413975;5914.940850591439;6054.576179667381;10408.791824163625;10559.736006599896;10915.617953371911;10933.945330273298;10939.671809845717;10903.56385744593;10960.506777194885;11060.391678457761;11077.501512432122;11116.055135313265;7722.53664780115;7883.763487095396;7942.722004729807;8007.959960200395;8119.75640730779;9071.59177837012;9273.258139348702;9275.912919593038;9291.907080929375;9303.488308143116;7537.54774713519;7800.492967957065;7810;7859;7899.131095579596;7214.242504536948;7417.443691723034;7511.887321690069;7672.693092276247;7795.922040779747;6902.447804175554;6933.861322773617;7000.264972177848;7079.115110611174;7099.751508697171;4692.718436893797;4767.642426818072;4843.709377437365;4845.055214233191;5269.0252303324005;5054.873628159326;5157.07172708916;5203.401608814884;5205.037068142406;5264.868378290574 10:34:06 INFO - PID 12544 | |4;prototype.html;354.3303157033207;361.6329425632981;367.47267670892256;371.8401087532361;373.7682636765206;5504.834854954358;5507.504324610784;5524.502794748471;5526;5530.115181570949;5319.813806516772;5398.406175320712;5398.568114550836;5404.864878378043;5414.296141501609;4191.203671302443;4223.049813791903;4238.364245363205;4240.194363071022;4245.681573881956;4213.220554197468;4214.199302132601;4222.746635201897;4235.53409124996;4248.895287225313;4198.517170525398;4211.094614657848;4213.283741763892;4225.239456897757;4230.957690423103;4164.812583433738;4196.160767846443;4197.91604167918;4209.726367786084;4232.513260974981;3694.224212915264;3763.8870833875026;3768.9057773555605;3772.9056773580605;3780.8109594520165;5304.389995150568;5304.549113325372;5311.442298558634;5322.0952438085615;5324.41431442541;4858.975705121487;4863.19757240055;4887.193613053842;4972.8508144755715;4973.378327709036;5699.515541179005;5714.114312281603;5714.857128571777;5736.770529178828;5750.6262092963825;4228;4232.413214556786;4237.300845360512;4238.851640192578;4239.364095385686;5815.505682017034;5843.5033022193165;5854.824355269348;5939.109133629947;6044.818655440344;3966.4843570336247;3991.1618560102124;3991.600839915985;4000.5599384067727;4001.579834117376;4046.3121269384274;4056.20903923732;4057.9797101014306;4068.2880495913096;4068.3083875740604;4526.456825180933;4709.9620744620215;4718.2214934536105;4724.126036683225;4734.218853889139;5672.461116193955;5676.148577713294;5699.202111704365;5703.572232082527;5714.3999880012;1378.1455497591558;1389.4442223110634;1392.721455708842;1393.477445957766;1398.552498164395;887.2591386192472;920.3097676742443;925.6621333213328;932.421898422982;936.4615346175976;4941.308216849644;4958.454569997298;4975.701457912537;4985.177445721488;4986.202207646759;5896.233489646319;5913.615614985012;5931.73307201177;5935.139404786368;5946.524278057745;4834.274858771142;4946.3817022872145;4958.925616115761;4971.931034827529;4973.502649734997;3104;3117.9243161109835;3143.465610846162;3144.465440875011;3144.9371012579622;5509.917351239735;5531.419200983839;5546.77812887488;5551.805686800943;5568.777248909998;5852.268466441695;6012.669303188367;6066.817995460143;6072.969635151796;6089.330173680892;5525.585581081355;5532.225488431623;5535.225068490415;5545.805896793593;5548.750306236229;5774.7690092397515;5816.94183058164;5886.970565147147;5897.941020589911;5954.970225148846;5817.2146760188525;5835.67903765297;5837.416258374129;5839.416058394127;5855.560832937462;5354;5488.80789172393;5531.474509921551;5535.363433205233;5554.75003624846;3994.1013272013565;4001.639852413297;4004.9399259010556;4005.7396269242404;4018.1762738639095;5884.264142078183;5989.790357337472;5998.760049598141;6001.789042862048;6022.759089636365;5716.571257155647;5721.8569535761935;5757.193992841089;5766.308043034863;5769.394213607511;5744.827655170351;5754.5901254192995;5767.480926716616;5772.797952071657;5783.681897495678;5593.636413633101;5632.9436705632415;5660.518855897295;5661;5690.77236910519;5763.337216220189;5778.711064446845;5785.392533783892;5795.768169273182;5806.303243610793;5493.505584497255;5590.189422533628;5614.52276556481;5617.325920889356;5644.8306550803545 10:34:06 INFO - PID 12544 | |5;yui.html;640.7212862404851;641.9614823110611;723.1936390924118;738.9889151662725;759.3355813663045;13300;13642.181469111847;13720.176789392643;16221.351145954148;16918.154092295397;16070;16129.758053629204;16131.919340403281;16133.27400266988;16150.353985840553;874.1084094223904;892.6964831957133;899.4558292233203;899.7615631857562;899.9370044096916;859.7807559072428;862.1981557151846;863.2834747159842;863.8142799298149;908.8273228086675;947.8957314695378;959.4674955399751;959.5538074795219;959.8224328499215;960.9135177834029;942.8915674697395;953.7091187187905;955.159459675488;955.6225291010081;956.1967946924548;625.3933684326196;664.5514277862471;678.3352314731542;684.6131935456451;694.4548529404444;14327.78508322376;14449.133052016912;14536.854631453762;14558.563243102724;14565.271736413242;14724.411023559045;15840.76238856418;16112.11383373914;16150.111743854084;16157.353705851869;12223.877761222362;12595.433205505682;12630.74738505234;12647.0514711397;12713.237205767591;2945.7937944343903;2952.424277265934;2959.4672958867395;2971.881124755029;2980.210244285266;73992;74002.62998685025;74085.62957185233;75727;77273;12481.438335274754;12518.436670349856;12529.624111276677;12617.684557886127;12741.044421668412;22357;22372.216972405888;22736;22911.656325155134;22948.541029179658;6088.238970128734;6142.416470435302;6152.938470615326;6173.629582225081;6207;2998.6551546571986;3031.9848400757855;3038.194878357237;3054.8167109973474;3061.989543450656;3472.1493234157288;3517.8944631661093;3519.278547897675;3529.3117842021074;3534.3991521440903;657.5134400543564;683.0744341417408;688.8381230410849;690.0305071374727;690.0442886601992;594.8631814682648;595.4551585299489;600.2856600645218;601.0563415437721;615.9476444502268;9082.682106126254;9460.101290377403;9720.513974301257;9874.456904870158;10455.477226138815;552.1441765263825;580.599386423375;603.3513972479602;607;617.4350469320611;4340.392345071693;4446.9777651111535;4460.286354183315;4460.665450091256;4503.211937910853;61699;63030.369696303365;63426.36573634204;63674.36325636777;64204.67897660482;56057;56109.15836262459;56691.71654141703;57057;57209.71395143081;51702.22446663303;52452.47547524476;52664.473355266724;52711;52753;8889.19997200255;10176.64381746665;10347.172226222036;10479.161667066768;10567.31312464718;24192.516149676554;25163.370915727253;25382.873085634452;25684.486310274064;26391.868040659672;42169.78915105405;43342;43564.78217608892;43790;44256.778716106215;13343.799843002556;13527.72944541084;13541.526046588322;13656.65858353549;13708.93145534266;15384.153871537173;15754.842451575338;15961;15978.041317520521;16117.597060073593;12861.421236044212;13370.130941488773;13436.596902092953;13593.32033398346;13879.444822206999;14459.13245205291;14567.198804065878;14724.411023558938;14782.260886955824;14966;12739.681507962376;12833.614991550268;13026.153300035467;13226.537071202847;13280.933595331962;10273.794524109626;10404.427756473468;10422.947885260524;10425.843612345669;10891.128709703364;10244.64143754965;10500.107490863056;10922.071623912056;10990.615328463466;10991.560337586727 10:34:06 INFO - PID 12544 | __end_tp_report 10:34:06 INFO - PID 12544 | __start_cc_report 10:34:06 INFO - PID 12544 | _x_x_mozilla_cycle_collect,274 10:34:06 INFO - PID 12544 | __end_cc_report 10:34:06 INFO - PID 12544 | __startTimestamp1495388046715__endTimestamp 10:34:06 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | ------- Summary: start ------- 10:34:06 INFO - PID 12544 | Number of tests: 6 10:34:06 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | [#0] dojo.html Cycles:165 Average:5140.49 Median:5289.15 stddev:602.94 (11.4%) stddev-sans-first:573.04 10:34:06 INFO - PID 12544 | Values: 2679.4 2695.7 2700.6 2730.4 2732.8 5039.3 5149.2 5152.5 5163.5 5207.2 5110.8 5181.8 5183.7 5239.7 5295.6 4348.5 4567.3 4622.1 4668.4 4692.4 4700.3 4731.5 4739.7 4747.9 4775.4 4579.7 4586.5 4638.4 4652.5 4678.8 4655.6 4666.1 4671.6 4707.1 4713.6 4605.1 4608.8 4611.3 4652.9 4669.6 5092.3 5172.3 5197.7 5199.6 5271.1 5593.4 5610.2 5646.6 5664.0 5677.2 5637.5 5670.6 5687.2 5688.1 5704.4 5203.1 5246.7 5270.1 5271.0 5336.6 5758.3 5793.6 5798.1 5818.4 5834.7 5502.5 5525.0 5525.2 5539.7 5541.4 5451.5 5524.9 5560.2 5611.2 5615.4 5452.3 5559.2 5570.3 5571.5 5572.9 5504.6 5532.4 5537.8 5540.1 5570.0 4602.5 4621.5 4643.5 4646.3 4650.2 4041.7 4061.2 4080.8 4083.6 4085.5 4835.2 4847.3 4859.8 4862.5 4867.4 5634.8 5691.9 5707.9 5711.8 5722.9 4714.5 4807.2 4810.4 4817.0 4863.5 4986.7 4987.9 4993.8 5012.1 5032.5 5144.0 5202.7 5218.1 5259.2 5329.7 5636.3 5679.6 5681.4 5686.8 5690.6 5229.4 5271.9 5278.0 5283.1 5289.2 5500.9 5524.5 5544.8 5550.1 5558.6 5583.3 5657.2 5664.1 5687.0 5713.5 5414.3 5419.9 5459.7 5484.8 5519.6 5459.8 5480.3 5498.7 5502.0 5502.1 5385.6 5389.4 5404.4 5454.6 5459.2 5430.2 5442.8 5449.3 5490.2 5504.3 5242.9 5308.5 5337.5 5388.8 5400.1 10:34:06 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | [#1] ext.html Cycles:180 Average:30177.41 Median:30362.32 stddev:40857.51 (134.6%) stddev-sans-first:40912.09 10:34:06 INFO - PID 12544 | Values: 679.6 723.2 744.6 1072.8 1073.6 32917.3 33649.8 33657.2 33728.7 33902.7 35849.8 36079.5 36288.6 36336.6 36419.8 6967.0 6979.6 7064.6 7099.6 7108.5 7013.7 7060.5 7099.1 7103.5 7103.9 7096.6 7143.5 7145.9 7152.1 7157.2 7081.1 7088.5 7088.9 7115.4 7125.1 6992.9 7050.5 7052.1 7061.3 7064.5 32455.8 32880.0 32935.7 32945.3 32972.7 3067.3 3087.1 3091.3 3098.3 3121.7 24406.3 24662.0 24726.3 24788.8 24811.8 2899.5 2909.0 2920.4 2927.0 2928.1 142349.3 142771.0 148170.0 152991.0 153077.0 38298.0 38341.8 38347.2 38502.7 38533.6 40044.8 40244.2 40308.4 40369.2 40392.0 11823.6 11905.5 11914.0 11921.6 11955.5 9541.1 9575.8 9579.5 9629.6 9646.4 11848.8 11885.4 12012.2 12104.7 12191.1 5301.3 5332.6 5362.4 5397.6 5416.7 742.3 892.8 900.9 907.2 940.2 21204.6 21361.9 21374.7 21560.6 21701.1 988.6 993.7 1001.2 1005.9 1020.8 10600.3 11440.1 11493.3 11537.9 11604.5 173245.0 173945.1 174419.0 174467.0 175208.0 40652.4 40933.4 40988.8 41006.2 41036.4 1200.8 1241.5 1245.2 1247.9 1273.6 19261.5 19684.6 20096.6 20288.0 20537.1 29191.1 29327.4 29370.0 29440.1 29467.4 151611.0 151874.2 151951.0 152255.0 152372.0 29217.4 29227.2 29290.1 30033.7 30463.4 34523.7 35151.0 35405.0 35598.6 35892.0 26364.0 26841.7 27213.9 27384.5 28034.0 26366.3 26782.5 27256.9 27548.4 27921.9 30147.2 30261.2 30491.0 30506.0 31045.8 26742.6 26890.5 26965.7 27779.0 28251.8 20322.0 22054.8 22155.1 22289.8 22545.1 10:34:06 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | [#2] jquery.html Cycles:180 Average:26101.45 Median:390663.00 stddev:64987.64 (16.6%) stddev-sans-first:65141.29 10:34:06 INFO - PID 12544 | Values: 399.5 408.3 420.9 428.3 434.3 14175.6 17264.9 17940.6 17961.2 18130.5 18518.0 18728.7 18782.3 19229.7 19460.0 5402.2 5533.7 5577.2 5678.7 5716.5 5631.9 5637.9 5663.4 5691.2 5694.5 5478.6 5583.3 5658.0 5660.8 5668.5 5612.7 5646.9 5670.6 5691.2 5714.5 5082.3 5141.9 5147.3 5184.4 5197.1 22292.7 22471.9 22565.5 22777.3 22822.2 1586.7 1637.4 1640.0 1644.0 1644.3 14556.3 14818.4 15191.5 15204.6 15316.9 1988.7 1999.7 2034.6 2044.9 2054.8 89465.6 92863.5 93910.5 94273.6 94668.0 10711.4 10951.9 11036.3 11048.6 11074.4 15123.4 15545.7 15554.2 15554.7 15563.1 7871.8 7888.2 7950.3 8185.8 8208.7 7509.6 7524.7 7677.3 7726.1 7727.5 6802.5 7012.3 7094.3 7155.3 7156.7 2045.9 2047.4 2071.2 2092.3 2202.9 837.8 876.4 878.6 886.6 903.7 17187.9 17425.2 17785.7 18103.9 18145.1 880.8 883.7 895.8 903.5 916.2 9430.5 9480.2 11344.7 12428.3 12530.8 382812.0 387841.0 390500.0 390826.0 399114.0 77454.6 80463.0 84031.0 84338.0 85292.0 1068.6 1093.4 1108.6 1146.6 1152.9 17879.2 17888.3 18444.9 18492.0 18777.2 39247.0 40876.2 41760.8 41794.2 42085.5 49942.0 50362.0 50666.0 51069.7 52530.0 8311.4 8430.8 8434.2 8527.5 8701.9 13183.5 13385.3 13424.8 13549.2 13599.1 11087.7 11230.1 11359.5 11504.0 11583.1 10683.5 10739.4 10926.9 10985.0 11078.7 11496.8 11565.8 11576.2 11630.8 11798.1 8321.2 8334.4 8508.0 8613.6 8649.4 11013.8 11077.8 11214.5 11311.8 11404.5 10:34:06 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | [#3] mootools.html Cycles:180 Average:5967.30 Median:4766.57 stddev:3739.47 (78.5%) stddev-sans-first:3733.12 10:34:06 INFO - PID 12544 | Values: 1244.2 1292.3 1303.3 1309.1 1313.3 9460.9 9725.3 9944.4 9949.3 9993.2 9919.6 10044.5 10062.1 10101.8 10105.8 2148.4 2174.7 2207.1 2210.5 2212.8 2175.4 2239.0 2240.9 2245.5 2247.8 2187.9 2200.6 2209.3 2213.1 2217.0 2190.6 2204.7 2229.3 2231.9 2233.8 2096.6 2192.4 2242.0 2242.3 2249.7 9645.5 9692.4 9716.9 9721.8 9733.6 5285.3 5472.0 5487.8 5496.6 5522.9 3236.7 3492.0 3492.7 3513.4 3584.5 1044.7 1075.3 1076.3 1085.4 1096.7 13764.2 13771.2 13781.6 13815.7 13908.9 4440.4 4613.1 4720.2 4765.5 4793.1 10104.7 10118.2 10139.0 10172.2 10180.4 5433.8 5441.1 5441.7 5446.7 5482.9 4946.4 5093.2 5105.8 5109.8 5133.3 3543.8 3631.1 3702.3 3707.1 3714.1 975.0 986.5 993.8 1006.9 1042.7 687.5 714.4 715.7 728.8 732.1 5260.1 5418.8 5421.9 5444.5 5471.2 526.9 542.0 551.3 555.5 561.7 3188.3 3198.1 3220.9 3302.7 3397.9 11903.5 12333.6 12575.2 12610.4 12616.2 11887.9 12429.9 12480.8 12499.1 12532.1 6991.2 7170.2 7218.5 7316.9 7325.9 5752.2 5858.4 5883.8 5914.9 6054.6 10408.8 10559.7 10915.6 10933.9 10939.7 10903.6 10960.5 11060.4 11077.5 11116.1 7722.5 7883.8 7942.7 8008.0 8119.8 9071.6 9273.3 9275.9 9291.9 9303.5 7537.5 7800.5 7810.0 7859.0 7899.1 7214.2 7417.4 7511.9 7672.7 7795.9 6902.4 6933.9 7000.3 7079.1 7099.8 4692.7 4767.6 4843.7 4845.1 5269.0 5054.9 5157.1 5203.4 5205.0 5264.9 10:34:06 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | [#4] prototype.html Cycles:180 Average:4735.96 Median:5451.55 stddev:1395.89 (25.6%) stddev-sans-first:1360.51 10:34:06 INFO - PID 12544 | Values: 354.3 361.6 367.5 371.8 373.8 5504.8 5507.5 5524.5 5526.0 5530.1 5319.8 5398.4 5398.6 5404.9 5414.3 4191.2 4223.0 4238.4 4240.2 4245.7 4213.2 4214.2 4222.7 4235.5 4248.9 4198.5 4211.1 4213.3 4225.2 4231.0 4164.8 4196.2 4197.9 4209.7 4232.5 3694.2 3763.9 3768.9 3772.9 3780.8 5304.4 5304.5 5311.4 5322.1 5324.4 4859.0 4863.2 4887.2 4972.9 4973.4 5699.5 5714.1 5714.9 5736.8 5750.6 4228.0 4232.4 4237.3 4238.9 4239.4 5815.5 5843.5 5854.8 5939.1 6044.8 3966.5 3991.2 3991.6 4000.6 4001.6 4046.3 4056.2 4058.0 4068.3 4068.3 4526.5 4710.0 4718.2 4724.1 4734.2 5672.5 5676.1 5699.2 5703.6 5714.4 1378.1 1389.4 1392.7 1393.5 1398.6 887.3 920.3 925.7 932.4 936.5 4941.3 4958.5 4975.7 4985.2 4986.2 5896.2 5913.6 5931.7 5935.1 5946.5 4834.3 4946.4 4958.9 4971.9 4973.5 3104.0 3117.9 3143.5 3144.5 3144.9 5509.9 5531.4 5546.8 5551.8 5568.8 5852.3 6012.7 6066.8 6073.0 6089.3 5525.6 5532.2 5535.2 5545.8 5548.8 5774.8 5816.9 5887.0 5897.9 5955.0 5817.2 5835.7 5837.4 5839.4 5855.6 5354.0 5488.8 5531.5 5535.4 5554.8 3994.1 4001.6 4004.9 4005.7 4018.2 5884.3 5989.8 5998.8 6001.8 6022.8 5716.6 5721.9 5757.2 5766.3 5769.4 5744.8 5754.6 5767.5 5772.8 5783.7 5593.6 5632.9 5660.5 5661.0 5690.8 5763.3 5778.7 5785.4 5795.8 5806.3 5493.5 5590.2 5614.5 5617.3 5644.8 10:34:06 INFO - PID 12544 | 10:34:06 INFO - PID 12544 | [#5] yui.html Cycles:180 Average:15657.30 Median:3495.02 stddev:18741.07 (536.2%) stddev-sans-first:18759.71 10:34:06 INFO - PID 12544 | Values: 640.7 642.0 723.2 739.0 759.3 13300.0 13642.2 13720.2 16221.4 16918.2 16070.0 16129.8 16131.9 16133.3 16150.4 874.1 892.7 899.5 899.8 899.9 859.8 862.2 863.3 863.8 908.8 947.9 959.5 959.6 959.8 960.9 942.9 953.7 955.2 955.6 956.2 625.4 664.6 678.3 684.6 694.5 14327.8 14449.1 14536.9 14558.6 14565.3 14724.4 15840.8 16112.1 16150.1 16157.4 12223.9 12595.4 12630.7 12647.1 12713.2 2945.8 2952.4 2959.5 2971.9 2980.2 73992.0 74002.6 74085.6 75727.0 77273.0 12481.4 12518.4 12529.6 12617.7 12741.0 22357.0 22372.2 22736.0 22911.7 22948.5 6088.2 6142.4 6152.9 6173.6 6207.0 2998.7 3032.0 3038.2 3054.8 3062.0 3472.1 3517.9 3519.3 3529.3 3534.4 657.5 683.1 688.8 690.0 690.0 594.9 595.5 600.3 601.1 615.9 9082.7 9460.1 9720.5 9874.5 10455.5 552.1 580.6 603.4 607.0 617.4 4340.4 4447.0 4460.3 4460.7 4503.2 61699.0 63030.4 63426.4 63674.4 64204.7 56057.0 56109.2 56691.7 57057.0 57209.7 51702.2 52452.5 52664.5 52711.0 52753.0 8889.2 10176.6 10347.2 10479.2 10567.3 24192.5 25163.4 25382.9 25684.5 26391.9 42169.8 43342.0 43564.8 43790.0 44256.8 13343.8 13527.7 13541.5 13656.7 13708.9 15384.2 15754.8 15961.0 15978.0 16117.6 12861.4 13370.1 13436.6 13593.3 13879.4 14459.1 14567.2 14724.4 14782.3 14966.0 12739.7 12833.6 13026.2 13226.5 13280.9 10273.8 10404.4 10422.9 10425.8 10891.1 10244.6 10500.1 10922.1 10990.6 10991.6 10:34:06 INFO - PID 12544 | -------- Summary: end -------- 10:34:06 INFO - PID 12544 | 10:34:07 INFO - TEST-INFO | 12544: exit 0 10:34:07 INFO - TEST-OK | dromaeo_css | took 1119222ms 10:34:07 INFO - TEST-START | kraken 10:34:07 INFO - operating with platform_type : linux_ 10:34:07 INFO - Initialising browser for kraken test... 10:34:07 INFO - TEST-INFO | started process 12968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sVx9F/profile http://localhost:56933/getInfo.html) 10:34:08 INFO - PID 12968 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2970: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:34:11 INFO - PID 12968 | __metrics Screen width/height:1600/1200 10:34:11 INFO - PID 12968 | colorDepth:24 10:34:11 INFO - PID 12968 | Browser inner width/height: 1024/695 10:34:11 INFO - PID 12968 | __metrics 10:34:13 INFO - TEST-INFO | 12968: exit 0 10:34:13 INFO - Browser initialized. 10:34:13 INFO - Running cycle 1/1 for kraken test... 10:34:13 INFO - TEST-INFO | started process 13148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sVx9F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:25 INFO - PID 13148 | RSS: Main: 170958848 10:34:25 INFO - PID 13148 | 10:34:28 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56933/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:29 INFO - PID 13148 | RSS: Main: 174759936 10:34:29 INFO - PID 13148 | 10:34:31 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56933/tests/kraken/driver.html?testName=audio-dft) 10:34:32 INFO - PID 13148 | RSS: Main: 174198784 10:34:32 INFO - PID 13148 | 10:34:35 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56933/tests/kraken/driver.html?testName=audio-fft) 10:34:36 INFO - PID 13148 | RSS: Main: 169381888 10:34:36 INFO - PID 13148 | 10:34:38 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56933/tests/kraken/driver.html?testName=audio-oscillator) 10:34:38 INFO - PID 13148 | RSS: Main: 169947136 10:34:38 INFO - PID 13148 | 10:34:40 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:41 INFO - PID 13148 | RSS: Main: 170381312 10:34:41 INFO - PID 13148 | 10:34:44 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56933/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:45 INFO - PID 13148 | RSS: Main: 174329856 10:34:45 INFO - PID 13148 | 10:34:48 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56933/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:49 INFO - PID 13148 | RSS: Main: 171413504 10:34:49 INFO - PID 13148 | 10:34:52 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56933/tests/kraken/driver.html?testName=json-parse-financial) 10:34:53 INFO - PID 13148 | RSS: Main: 172634112 10:34:53 INFO - PID 13148 | 10:34:54 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:55 INFO - PID 13148 | RSS: Main: 172683264 10:34:55 INFO - PID 13148 | 10:34:57 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56933/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:57 INFO - PID 13148 | RSS: Main: 172916736 10:34:57 INFO - PID 13148 | 10:34:59 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:00 INFO - PID 13148 | RSS: Main: 172986368 10:35:00 INFO - PID 13148 | 10:35:03 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:04 INFO - PID 13148 | RSS: Main: 173121536 10:35:04 INFO - PID 13148 | 10:35:07 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:07 INFO - PID 13148 | RSS: Main: 172789760 10:35:07 INFO - PID 13148 | 10:35:09 INFO - PID 13148 | Cycle 1(1): loaded http://localhost:56933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56933/tests/kraken/driver.html?testName=ai-astar) 10:35:10 INFO - PID 13148 | RSS: Main: 174342144 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | __start_tp_report 10:35:10 INFO - PID 13148 | _x_x_mozilla_page_load 10:35:10 INFO - PID 13148 | _x_x_mozilla_page_load_details 10:35:10 INFO - PID 13148 | |i|pagename|runs| 10:35:10 INFO - PID 13148 | |0;ai-astar;104;113;114;112;112;114;113;113;114;113 10:35:10 INFO - PID 13148 | |1;audio-beat-detection;165;123;126;168;124;122;124;124;145;123 10:35:10 INFO - PID 13148 | |2;audio-dft;164;162;164;164;166;165;171;163;164;163 10:35:10 INFO - PID 13148 | |3;audio-fft;77;75;76;106;77;75;77;74;97;79 10:35:10 INFO - PID 13148 | |4;audio-oscillator;83;84;113;84;84;88;97;83;85;109 10:35:10 INFO - PID 13148 | |5;imaging-gaussian-blur;114;114;114;114;114;115;114;114;119;115 10:35:10 INFO - PID 13148 | |6;imaging-darkroom;151;150;150;150;151;151;151;151;150;150 10:35:10 INFO - PID 13148 | |7;imaging-desaturate;95;97;95;94;95;96;95;95;94;95 10:35:10 INFO - PID 13148 | |8;json-parse-financial;58;53;55;55;56;55;56;60;54;55 10:35:10 INFO - PID 13148 | |9;json-stringify-tinderbox;57;56;57;57;57;59;57;57;56;56 10:35:10 INFO - PID 13148 | |10;stanford-crypto-aes;85;89;85;83;83;85;82;82;82;84 10:35:10 INFO - PID 13148 | |11;stanford-crypto-ccm;138;133;133;135;144;133;136;133;177;130 10:35:10 INFO - PID 13148 | |12;stanford-crypto-pbkdf2;187;189;186;195;196;196;199;195;202;192 10:35:10 INFO - PID 13148 | |13;stanford-crypto-sha256-iterative;76;77;78;75;78;74;74;74;76;77 10:35:10 INFO - PID 13148 | __end_tp_report 10:35:10 INFO - PID 13148 | __start_cc_report 10:35:10 INFO - PID 13148 | _x_x_mozilla_cycle_collect,773 10:35:10 INFO - PID 13148 | __end_cc_report 10:35:10 INFO - PID 13148 | __startTimestamp1495388110018__endTimestamp 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | ------- Summary: start ------- 10:35:10 INFO - PID 13148 | Number of tests: 14 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.97 (2.6%) stddev-sans-first:0.78 10:35:10 INFO - PID 13148 | Values: 104.0 113.0 114.0 112.0 112.0 114.0 113.0 113.0 114.0 113.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:125.00 stddev:18.22 (14.6%) stddev-sans-first:15.60 10:35:10 INFO - PID 13148 | Values: 165.0 123.0 126.0 168.0 124.0 122.0 124.0 124.0 145.0 123.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.50 (1.5%) stddev-sans-first:2.65 10:35:10 INFO - PID 13148 | Values: 164.0 162.0 164.0 164.0 166.0 165.0 171.0 163.0 164.0 163.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#3] audio-fft Cycles:10 Average:81.30 Median:77.00 stddev:10.94 (14.2%) stddev-sans-first:11.50 10:35:10 INFO - PID 13148 | Values: 77.0 75.0 76.0 106.0 77.0 75.0 77.0 74.0 97.0 79.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:84.00 stddev:11.37 (13.5%) stddev-sans-first:11.69 10:35:10 INFO - PID 13148 | Values: 83.0 84.0 113.0 84.0 84.0 88.0 97.0 83.0 85.0 109.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:1.57 (1.4%) stddev-sans-first:1.64 10:35:10 INFO - PID 13148 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 119.0 115.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 10:35:10 INFO - PID 13148 | Values: 151.0 150.0 150.0 150.0 151.0 151.0 151.0 151.0 150.0 150.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 10:35:10 INFO - PID 13148 | Values: 95.0 97.0 95.0 94.0 95.0 96.0 95.0 95.0 94.0 95.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:2.00 (3.6%) stddev-sans-first:1.94 10:35:10 INFO - PID 13148 | Values: 58.0 53.0 55.0 55.0 56.0 55.0 56.0 60.0 54.0 55.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 10:35:10 INFO - PID 13148 | Values: 57.0 56.0 57.0 57.0 57.0 59.0 57.0 57.0 56.0 56.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.50 stddev:2.16 (2.6%) stddev-sans-first:2.26 10:35:10 INFO - PID 13148 | Values: 85.0 89.0 85.0 83.0 83.0 85.0 82.0 82.0 82.0 84.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:135.50 stddev:13.82 (10.2%) stddev-sans-first:14.65 10:35:10 INFO - PID 13148 | Values: 138.0 133.0 133.0 135.0 144.0 133.0 136.0 133.0 177.0 130.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:195.50 stddev:5.17 (2.6%) stddev-sans-first:4.88 10:35:10 INFO - PID 13148 | Values: 187.0 189.0 186.0 195.0 196.0 196.0 199.0 195.0 202.0 192.0 10:35:10 INFO - PID 13148 | 10:35:10 INFO - PID 13148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:76.50 stddev:1.60 (2.1%) stddev-sans-first:1.69 10:35:10 INFO - PID 13148 | Values: 76.0 77.0 78.0 75.0 78.0 74.0 74.0 74.0 76.0 77.0 10:35:10 INFO - PID 13148 | -------- Summary: end -------- 10:35:10 INFO - PID 13148 | 10:35:11 INFO - TEST-INFO | 13148: exit 0 10:35:11 INFO - TEST-OK | kraken | took 63537ms 10:35:11 INFO - SUITE-END | took 1182s 10:35:11 INFO - Completed test suite (00:19:42) 10:35:11 INFO - javascript benchmark 10:35:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6684.83502017551, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.405753576622, 2695.689995650501, 2700.635414219081, 2730.440259746752, 2732.781377489801, 5039.31969184161, 5149.227615857619, 5152.510511501401, 5163.509466600667, 5207.166853303473, 5110.795568177277, 5181.792728290864, 5183.663061900974, 5239.711815850127, 5295.629305948585, 4348.5216626171095, 4567.337736028274, 4622.098690755296, 4668.416447944007, 4692.4369075710965, 4700.27145792401, 4731.455882573514, 4739.691920025204, 4747.881302967419, 4775.426948766153, 4579.656525760548, 4586.518415566385, 4638.350630911675, 4652.511486293958, 4678.812847486097, 4655.627549796042, 4666.136764698542, 4671.649626278043, 4707.129181101473, 4713.57577817998, 4605.102005109005, 4608.792604332813, 4611.2852507861335, 4652.860414187579, 4669.626429885635, 5092.261622064817, 5172.250023746573, 5197.714125723083, 5199.610029247821, 5271.077561426735, 5593.3847276799515, 5610.214569960209, 5646.632968857052, 5663.9716801415725, 5677.17680936262, 5637.548996080303, 5670.6030577859565, 5687.232223649796, 5688.11834165705, 5704.401037891003, 5203.063448579216, 5246.65896716716, 5270.077736396115, 5271.0, 5336.573074154058, 5758.337791154071, 5793.565482588739, 5798.10129429939, 5818.44724751148, 5834.737436815353, 5502.477264659851, 5525.033119204123, 5525.198846167364, 5539.667619942817, 5541.418151094158, 5451.509364157166, 5524.861878453071, 5560.221568980346, 5611.2144299798065, 5615.382307946123, 5452.26394436746, 5559.193916882029, 5570.275864137636, 5571.498565129158, 5572.888542229214, 5504.587155963319, 5532.3914369419335, 5537.750801213874, 5540.085885828874, 5569.972150139223, 4602.470715867651, 4621.468531118897, 4643.512431194676, 4646.256598944153, 4650.18621741194, 4041.6968727345566, 4061.1674606705556, 4080.8367665293054, 4083.612056854594, 4085.5301640311745, 4835.153848076572, 4847.345608342899, 4859.829905953275, 4862.513748625109, 4867.367242258484, 5634.830955071272, 5691.886162276731, 5707.942920570741, 5711.828645140652, 5722.942770572241, 4714.481407045222, 4807.206810876236, 4810.350602668595, 4816.988432429229, 4863.489333619989, 4986.6758660687665, 4987.925181122286, 4993.7503124843615, 5012.072766538202, 5032.47159048302, 5143.974280128576, 5202.687838729688, 5218.086834803818, 5259.184826351845, 5329.7068661224, 5636.267285252891, 5679.574031947538, 5681.431856814451, 5686.800961966312, 5690.630109042899, 5229.424763276113, 5271.868203294948, 5278.0, 5283.10187268173, 5289.153735402318, 5500.862478437911, 5524.530414914777, 5544.750486228048, 5550.08423610116, 5558.638688485235, 5583.302087239095, 5657.236273103078, 5664.0937450007805, 5687.033204355353, 5713.514351280188, 5414.29614150158, 5419.945800541944, 5459.672419654833, 5484.753186106715, 5519.613627046068, 5459.754311056092, 5480.314960629921, 5498.670079795225, 5501.972490137524, 5502.119660854404, 5385.569154467712, 5389.434109418455, 5404.378496472798, 5454.645448045864, 5459.235707000944, 5430.15832545956, 5442.809501667422, 5449.3188351456065, 5490.231367608458, 5504.311961004874, 5242.947570524246, 5308.522232999048, 5337.492938170868, 5388.811391601275, 5400.0819860623005], "value": 5096.668770286145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6431873266534, 723.2225357740429, 744.6351287868946, 1072.8122578548757, 1073.581303291717, 32917.34165316695, 33649.831750841244, 33657.158571035674, 33728.66271337292, 33902.66097339023, 35849.82075089627, 36079.45880811784, 36288.63711362886, 36336.63663363372, 36419.81790091052, 6967.0, 6979.581225126509, 7064.611446370448, 7099.574025558457, 7108.502404831664, 7013.719451221945, 7060.541064830795, 7099.112610923635, 7103.502754807139, 7103.928960710378, 7096.609686467243, 7143.535670181422, 7145.8928116078305, 7152.1046922565565, 7157.17692465368, 7081.079459670235, 7088.503804733671, 7088.89366659498, 7115.430765538745, 7125.144982602069, 6992.895106573405, 7050.506464547484, 7052.083229180225, 7061.329173728487, 7064.470164737665, 32455.83772081148, 32880.0, 32935.6706432935, 32945.341093178, 32972.6702732972, 3067.2945222598705, 3087.07387783664, 3091.30445649727, 3098.256418459576, 3121.734652554513, 24406.26781196567, 24662.0, 24726.258212253662, 24788.752112479004, 24811.751882481123, 2899.4780939430893, 2908.956365654517, 2920.37211999419, 2926.9853650731825, 2928.1361998210577, 142349.2882535591, 142771.0, 148170.0, 152991.0, 153076.9999999989, 38298.0, 38341.80829095892, 38347.23305533874, 38502.689838609775, 38533.614663853565, 40044.79977600093, 40244.195116097515, 40308.39537406941, 40369.19261614751, 40392.0, 11823.645290641294, 11905.523779048914, 11914.0, 11921.642350729491, 11955.521779128738, 9541.141297283139, 9575.760605984768, 9579.473128977834, 9629.614815407445, 9646.372985755903, 11848.763024739457, 11885.40572971348, 12012.159148859497, 12104.697382565506, 12191.14661973671, 5301.310829592206, 5332.573394128461, 5362.436944120889, 5397.599512307222, 5416.7020813855615, 742.254034695128, 892.830362231174, 900.9234215091791, 907.2424525521263, 940.1585580905188, 21204.575908482053, 21361.893190534258, 21374.679379809317, 21560.56878862414, 21701.13195472195, 988.6243227573476, 993.7217579077869, 1001.1690297053428, 1005.9295849290626, 1020.8417695257247, 10600.310979786289, 11440.141989350832, 11493.252938558968, 11537.88462115368, 11604.535818567332, 173245.0, 173945.13027435035, 174419.0, 174467.0, 175208.0, 40652.39021414681, 40933.38599921003, 40988.79505602513, 41006.179876402304, 41036.38445423321, 1200.7538454616783, 1241.4599649152647, 1245.1532957588745, 1247.931363775001, 1273.6306471123455, 19261.518462038563, 19684.606307873477, 20096.59806803885, 20288.0, 20537.075831587317, 29191.102578332342, 29327.413451731274, 29370.0, 29440.11679649614, 29467.41065178727, 151611.0, 151874.24062879613, 151951.0, 152255.0, 152372.0, 29217.41565168727, 29227.246365218154, 29290.121296361143, 30033.69966300309, 30463.390732185675, 34523.65476345305, 35151.0, 35405.0, 35598.644013560566, 35892.0, 26364.0, 26841.731582683922, 27213.86393068022, 27384.452310954068, 28034.0, 26366.340841479116, 26782.464350712486, 27256.863715681295, 27548.449031019667, 27921.86039069873, 30147.246318842204, 30261.243468913453, 30491.0, 30506.0, 31045.844770776002, 26742.59886101749, 26890.462190756465, 26965.730342696323, 27779.0, 28251.75801009746, 20322.0, 22054.832787931846, 22155.113795448648, 22289.77710222877, 22545.098196071973], "value": 14432.152651104967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.5026192390471, 408.33033824527763, 420.89056845220244, 428.31042022344025, 434.313784220931, 14175.574732758008, 17264.91367543162, 17940.55148621285, 17961.191746371427, 18130.45608631743, 18518.0, 18728.719069213937, 18782.342618008373, 19229.711554326695, 19460.0, 5402.162664786954, 5533.667979921198, 5577.247071645337, 5678.687672178028, 5716.542676585884, 5631.8592035199035, 5637.887242255152, 5663.377028526858, 5691.231683722686, 5694.487496125348, 5478.561715062785, 5583.3300003999575, 5657.971710141464, 5660.773569057233, 5668.518175955028, 5612.747426365823, 5646.943530564703, 5670.574706896979, 5691.174779656968, 5714.457126572969, 5082.339295891547, 5141.9228711568985, 5147.305113809625, 5184.377874655028, 5197.1424714922, 22292.66561001586, 22471.887640561694, 22565.54868902629, 22777.31668049961, 22822.201222957283, 1586.6985272798247, 1637.4187163556885, 1640.0241856095604, 1643.983560164395, 1644.284736139771, 14556.272186390637, 14818.40726370944, 15191.544253672408, 15204.619884502865, 15316.923415382964, 1988.7315212446279, 1999.6500612392774, 2034.5829105033433, 2044.9284275050302, 2054.794520547948, 89465.55267223687, 92863.53568232116, 93910.53044734869, 94273.62990071086, 94668.0, 10711.410872402093, 10951.890481095246, 11036.337819730841, 11048.613298534512, 11074.446277686084, 15123.39506419731, 15545.68908621844, 15554.22228888551, 15554.74456203844, 15563.144027078393, 7871.84256314882, 7888.171741967126, 7950.284474397332, 8185.836283274301, 8208.712695055763, 7509.586972716553, 7524.699012039567, 7677.30904218623, 7726.111497177784, 7727.459077864495, 6802.537454447318, 7012.333828286304, 7094.326039026284, 7155.284471552803, 7156.677949492181, 2045.8670186437835, 2047.3653167518116, 2071.2439959414705, 2092.340912612522, 2202.8568143070647, 837.8198687282141, 876.4434584039053, 878.6441491196076, 886.570013543431, 903.6927444668713, 17187.91406042962, 17425.215865286093, 17785.7332140018, 18103.909480452778, 18145.09274536268, 880.7886107334193, 883.6818745251704, 895.7626229049307, 903.5346796399859, 916.1983264643437, 9430.52847357643, 9480.24158067353, 11344.716382090348, 12428.254304741744, 12530.81203781944, 382812.0, 387841.0, 390500.0, 390826.0, 399114.0, 77454.612726936, 80463.0, 84031.0, 84338.0, 85292.0, 1068.615298492542, 1093.3931667924378, 1108.5565773690428, 1146.5929594993825, 1152.8501294831617, 17879.19543620514, 17888.28446862111, 18444.907775461037, 18492.0, 18777.248910043447, 39247.0, 40876.18247634971, 41760.79119604383, 41794.164116716885, 42085.54012191417, 49942.0, 50362.0, 50666.0, 51069.74465127651, 52530.0, 8311.418200725891, 8430.789230269047, 8434.24091831738, 8527.53098579584, 8701.869471958053, 13183.472661093449, 13385.330733463483, 13424.798628020391, 13549.187048777105, 13599.116057456235, 11087.72280692989, 11230.101591872794, 11359.48882300315, 11503.964643182153, 11583.07335413148, 10683.465826708478, 10739.409332486788, 10926.890731092906, 10985.0, 11078.723031923944, 11496.82754758696, 11565.768684626428, 11576.189666723249, 11630.76738465209, 11798.11514136426, 8321.16788321163, 8334.374921880762, 8508.021577518664, 8613.569321534023, 8649.3512986525, 11013.779724405307, 11077.778444431227, 11214.49534770921, 11311.830322545333, 11404.543818247508], "value": 9123.80525825483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.2347956007056, 1292.2539603342896, 1303.302733037825, 1309.1098053323742, 1313.2776972665035, 9460.905390946089, 9725.319227654067, 9944.403335799858, 9949.30354875159, 9993.150582200504, 9919.553620087096, 10044.497775111233, 10062.094411502963, 10101.797964040716, 10105.848412273821, 2148.398448434437, 2174.749903761072, 2207.0509680837235, 2210.4694873230387, 2212.8008479236864, 2175.445261458326, 2238.9776102238934, 2240.865548067113, 2245.5396643688086, 2247.8426510144295, 2187.9124835006583, 2200.6478963365867, 2209.2930262316067, 2213.092632020872, 2216.9778302216932, 2190.5837890800776, 2204.669299605072, 2229.3312006398014, 2231.933042008742, 2233.798958093771, 2096.5806838632334, 2192.35325578953, 2242.0471299697724, 2242.2936774915847, 2249.696291000727, 9645.469499177543, 9692.369995950241, 9716.902830971741, 9721.756956076155, 9733.610655573768, 5285.2600635911, 5472.0, 5487.807926722586, 5496.560275177976, 5522.9447705523235, 3236.7086962173516, 3491.9825400872833, 3492.6856582907662, 3513.4378499439968, 3584.5160903277983, 1044.6657069737687, 1075.2795626929897, 1076.3272954403499, 1085.4301491716833, 1096.660035389032, 13764.242966636832, 13771.242581658005, 13781.586552403443, 13815.654608634864, 13908.887289016855, 4440.444944381952, 4613.077384523109, 4720.244760838249, 4765.499622539653, 4793.113274044313, 10104.69685909424, 10118.241131915136, 10139.0, 10172.237082218864, 10180.440075795754, 5433.782648694087, 5441.102218134043, 5441.700706461103, 5446.673199608036, 5482.91775623366, 4946.356973593482, 5093.2105523643895, 5105.795768169306, 5109.770060347293, 5133.332666753298, 3543.805090720035, 3631.1466805300734, 3702.259548090393, 3707.14735610811, 3714.1457464783252, 974.9707508774748, 986.4673076538733, 993.7863359377768, 1006.9093781559549, 1042.713253855196, 687.5118665747375, 714.371353209183, 715.7494876793081, 728.8360118973188, 732.1287667675449, 5260.13207820713, 5418.756155972991, 5421.891562168814, 5444.50999410055, 5471.23402723619, 526.9446708095671, 541.9972900135552, 551.3081083240507, 555.4639772619441, 561.7444062951347, 3188.2985743136474, 3198.1205168578363, 3220.935581288361, 3302.669733026726, 3397.9150521237166, 11903.523859045714, 12333.568325108577, 12575.182613130117, 12610.432530536147, 12616.17994830333, 11887.88112118885, 12429.875701243052, 12480.812787808009, 12499.125061245808, 12532.060095492874, 6991.2309645937885, 7170.211276759553, 7218.530795498275, 7316.865885787712, 7325.926740732631, 5752.223449834386, 5858.443447872445, 5883.764649413975, 5914.940850591439, 6054.576179667381, 10408.791824163625, 10559.736006599896, 10915.617953371911, 10933.945330273298, 10939.671809845717, 10903.56385744593, 10960.506777194885, 11060.391678457761, 11077.501512432122, 11116.055135313265, 7722.53664780115, 7883.763487095396, 7942.722004729807, 8007.959960200395, 8119.75640730779, 9071.59177837012, 9273.258139348702, 9275.912919593038, 9291.907080929375, 9303.488308143116, 7537.54774713519, 7800.492967957065, 7810.0, 7859.0, 7899.131095579596, 7214.242504536948, 7417.443691723034, 7511.887321690069, 7672.693092276247, 7795.922040779747, 6902.447804175554, 6933.861322773617, 7000.264972177848, 7079.115110611174, 7099.751508697171, 4692.718436893797, 4767.642426818072, 4843.709377437365, 4845.055214233191, 5269.0252303324005, 5054.873628159326, 5157.07172708916, 5203.401608814884, 5205.037068142406, 5264.868378290574], "value": 4510.604937741231, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.3303157033207, 361.6329425632981, 367.47267670892256, 371.8401087532361, 373.7682636765206, 5504.834854954358, 5507.504324610784, 5524.502794748471, 5526.0, 5530.115181570949, 5319.813806516772, 5398.406175320712, 5398.568114550836, 5404.864878378043, 5414.296141501609, 4191.203671302443, 4223.049813791903, 4238.364245363205, 4240.194363071022, 4245.681573881956, 4213.220554197468, 4214.199302132601, 4222.746635201897, 4235.53409124996, 4248.895287225313, 4198.517170525398, 4211.094614657848, 4213.283741763892, 4225.239456897757, 4230.957690423103, 4164.812583433738, 4196.160767846443, 4197.91604167918, 4209.726367786084, 4232.513260974981, 3694.224212915264, 3763.8870833875026, 3768.9057773555605, 3772.9056773580605, 3780.8109594520165, 5304.389995150568, 5304.549113325372, 5311.442298558634, 5322.0952438085615, 5324.41431442541, 4858.975705121487, 4863.19757240055, 4887.193613053842, 4972.8508144755715, 4973.378327709036, 5699.515541179005, 5714.114312281603, 5714.857128571777, 5736.770529178828, 5750.6262092963825, 4228.0, 4232.413214556786, 4237.300845360512, 4238.851640192578, 4239.364095385686, 5815.505682017034, 5843.5033022193165, 5854.824355269348, 5939.109133629947, 6044.818655440344, 3966.4843570336247, 3991.1618560102124, 3991.600839915985, 4000.5599384067727, 4001.579834117376, 4046.3121269384274, 4056.20903923732, 4057.9797101014306, 4068.2880495913096, 4068.3083875740604, 4526.456825180933, 4709.9620744620215, 4718.2214934536105, 4724.126036683225, 4734.218853889139, 5672.461116193955, 5676.148577713294, 5699.202111704365, 5703.572232082527, 5714.3999880012, 1378.1455497591558, 1389.4442223110634, 1392.721455708842, 1393.477445957766, 1398.552498164395, 887.2591386192472, 920.3097676742443, 925.6621333213328, 932.421898422982, 936.4615346175976, 4941.308216849644, 4958.454569997298, 4975.701457912537, 4985.177445721488, 4986.202207646759, 5896.233489646319, 5913.615614985012, 5931.73307201177, 5935.139404786368, 5946.524278057745, 4834.274858771142, 4946.3817022872145, 4958.925616115761, 4971.931034827529, 4973.502649734997, 3104.0, 3117.9243161109835, 3143.465610846162, 3144.465440875011, 3144.9371012579622, 5509.917351239735, 5531.419200983839, 5546.77812887488, 5551.805686800943, 5568.777248909998, 5852.268466441695, 6012.669303188367, 6066.817995460143, 6072.969635151796, 6089.330173680892, 5525.585581081355, 5532.225488431623, 5535.225068490415, 5545.805896793593, 5548.750306236229, 5774.7690092397515, 5816.94183058164, 5886.970565147147, 5897.941020589911, 5954.970225148846, 5817.2146760188525, 5835.67903765297, 5837.416258374129, 5839.416058394127, 5855.560832937462, 5354.0, 5488.80789172393, 5531.474509921551, 5535.363433205233, 5554.75003624846, 3994.1013272013565, 4001.639852413297, 4004.9399259010556, 4005.7396269242404, 4018.1762738639095, 5884.264142078183, 5989.790357337472, 5998.760049598141, 6001.789042862048, 6022.759089636365, 5716.571257155647, 5721.8569535761935, 5757.193992841089, 5766.308043034863, 5769.394213607511, 5744.827655170351, 5754.5901254192995, 5767.480926716616, 5772.797952071657, 5783.681897495678, 5593.636413633101, 5632.9436705632415, 5660.518855897295, 5661.0, 5690.77236910519, 5763.337216220189, 5778.711064446845, 5785.392533783892, 5795.768169273182, 5806.303243610793, 5493.505584497255, 5590.189422533628, 5614.52276556481, 5617.325920889356, 5644.8306550803545], "value": 4295.146892758686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.7212862404851, 641.9614823110611, 723.1936390924118, 738.9889151662725, 759.3355813663045, 13300.0, 13642.181469111847, 13720.176789392643, 16221.351145954148, 16918.154092295397, 16070.0, 16129.758053629204, 16131.919340403281, 16133.27400266988, 16150.353985840553, 874.1084094223904, 892.6964831957133, 899.4558292233203, 899.7615631857562, 899.9370044096916, 859.7807559072428, 862.1981557151846, 863.2834747159842, 863.8142799298149, 908.8273228086675, 947.8957314695378, 959.4674955399751, 959.5538074795219, 959.8224328499215, 960.9135177834029, 942.8915674697395, 953.7091187187905, 955.159459675488, 955.6225291010081, 956.1967946924548, 625.3933684326196, 664.5514277862471, 678.3352314731542, 684.6131935456451, 694.4548529404444, 14327.78508322376, 14449.133052016912, 14536.854631453762, 14558.563243102724, 14565.271736413242, 14724.411023559045, 15840.76238856418, 16112.11383373914, 16150.111743854084, 16157.353705851869, 12223.877761222362, 12595.433205505682, 12630.74738505234, 12647.0514711397, 12713.237205767591, 2945.7937944343903, 2952.424277265934, 2959.4672958867395, 2971.881124755029, 2980.210244285266, 73992.0, 74002.62998685025, 74085.62957185233, 75727.0, 77273.0, 12481.438335274754, 12518.436670349856, 12529.624111276677, 12617.684557886127, 12741.044421668412, 22357.0, 22372.216972405888, 22736.0, 22911.656325155134, 22948.541029179658, 6088.238970128734, 6142.416470435302, 6152.938470615326, 6173.629582225081, 6207.0, 2998.6551546571986, 3031.9848400757855, 3038.194878357237, 3054.8167109973474, 3061.989543450656, 3472.1493234157288, 3517.8944631661093, 3519.278547897675, 3529.3117842021074, 3534.3991521440903, 657.5134400543564, 683.0744341417408, 688.8381230410849, 690.0305071374727, 690.0442886601992, 594.8631814682648, 595.4551585299489, 600.2856600645218, 601.0563415437721, 615.9476444502268, 9082.682106126254, 9460.101290377403, 9720.513974301257, 9874.456904870158, 10455.477226138815, 552.1441765263825, 580.599386423375, 603.3513972479602, 607.0, 617.4350469320611, 4340.392345071693, 4446.9777651111535, 4460.286354183315, 4460.665450091256, 4503.211937910853, 61699.0, 63030.369696303365, 63426.36573634204, 63674.36325636777, 64204.67897660482, 56057.0, 56109.15836262459, 56691.71654141703, 57057.0, 57209.71395143081, 51702.22446663303, 52452.47547524476, 52664.473355266724, 52711.0, 52753.0, 8889.19997200255, 10176.64381746665, 10347.172226222036, 10479.161667066768, 10567.31312464718, 24192.516149676554, 25163.370915727253, 25382.873085634452, 25684.486310274064, 26391.868040659672, 42169.78915105405, 43342.0, 43564.78217608892, 43790.0, 44256.778716106215, 13343.799843002556, 13527.72944541084, 13541.526046588322, 13656.65858353549, 13708.93145534266, 15384.153871537173, 15754.842451575338, 15961.0, 15978.041317520521, 16117.597060073593, 12861.421236044212, 13370.130941488773, 13436.596902092953, 13593.32033398346, 13879.444822206999, 14459.13245205291, 14567.198804065878, 14724.411023558938, 14782.260886955824, 14966.0, 12739.681507962376, 12833.614991550268, 13026.153300035467, 13226.537071202847, 13280.933595331962, 10273.794524109626, 10404.427756473468, 10422.947885260524, 10425.843612345669, 10891.128709703364, 10244.64143754965, 10500.107490863056, 10922.071623912056, 10990.615328463466, 10991.560337586727], "value": 6862.842766836249, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 112.0, 112.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 123.0, 126.0, 168.0, 124.0, 122.0, 124.0, 124.0, 145.0, 123.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 164.0, 166.0, 165.0, 171.0, 163.0, 164.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 106.0, 77.0, 75.0, 77.0, 74.0, 97.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 113.0, 84.0, 84.0, 88.0, 97.0, 83.0, 85.0, 109.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 119.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0, 151.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 55.0, 55.0, 56.0, 55.0, 56.0, 60.0, 54.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 59.0, 57.0, 57.0, 56.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 85.0, 83.0, 83.0, 85.0, 82.0, 82.0, 82.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 133.0, 135.0, 144.0, 133.0, 136.0, 133.0, 177.0, 130.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 189.0, 186.0, 195.0, 196.0, 196.0, 199.0, 195.0, 202.0, 192.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 75.0, 78.0, 74.0, 74.0, 74.0, 76.0, 77.0], "value": 75.9, "unit": "score"}]}]} 10:35:11 INFO - Return code: 0 10:35:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:35:11 INFO - # TBPL SUCCESS # 10:35:11 INFO - Running post-action listener: _resource_record_post_action 10:35:11 INFO - [mozharness: 2017-05-21 17:35:11.311337Z] Finished run-tests step (success) 10:35:11 INFO - Running post-run listener: _resource_record_post_run 10:35:11 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 419151872; Read time: 80; Write time: 256140 10:35:11 INFO - TinderboxPrint: CPU usage
13.3% 10:35:11 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 80 10:35:11 INFO - TinderboxPrint: I/O write bytes / time
419,151,872 / 256,140 10:35:11 INFO - TinderboxPrint: CPU idle
8,293.5 (86.7%) 10:35:11 INFO - TinderboxPrint: CPU user
1,218.7 (12.7%) 10:35:11 INFO - TinderboxPrint: Swap in / out
0 / 0 10:35:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 82268160; Read time: 68; Write time: 49332 10:35:11 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 318963712; Read time: 0; Write time: 170868 10:35:11 INFO - Running post-run listener: _upload_blobber_files 10:35:11 INFO - Blob upload gear active. 10:35:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:11 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 10:35:11 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'] 10:35:11 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 10:35:12 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:19 INFO - (blobuploader) - INFO - Done attempting. 10:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:35:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:19 INFO - (blobuploader) - INFO - Done attempting. 10:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:20 INFO - (blobuploader) - INFO - Done attempting. 10:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:21 INFO - (blobuploader) - INFO - Done attempting. 10:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:21 INFO - Return code: 0 10:35:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3218ee58dbc771e920eac675a9690597421b02b5bf0ae661af1888f8346296c2692f0e68f125895e0db34abb4a2043c8d29fb2468cb181334092d5c998315d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8731af0d6c2b1e9f6fc446a9ec0d20ff81955f1ff3cce966dbbeba10d44995f5fa0123ec6999c6f86222157cdfb270fc7497bfe2186ed26bf9f3a7b42c259a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b5183a6527ebd6cf5bf8a0bb6c9b6046827ba507235b9eeeb7d81a247e65bb56238832f6bf18a13bfc9a1b0e931a31e44b48d0bfd0400cc3858f7bf29527a7f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f20d8b16732f91f5f5ea6638a139981430f573c1324eb680a7d288776f973818f82dc2aac89c5ca9f6abef36a487eb7370edd7f399dd2744f608c40fcca9cac"} 10:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:21 INFO - Contents: 10:35:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3218ee58dbc771e920eac675a9690597421b02b5bf0ae661af1888f8346296c2692f0e68f125895e0db34abb4a2043c8d29fb2468cb181334092d5c998315d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8731af0d6c2b1e9f6fc446a9ec0d20ff81955f1ff3cce966dbbeba10d44995f5fa0123ec6999c6f86222157cdfb270fc7497bfe2186ed26bf9f3a7b42c259a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b5183a6527ebd6cf5bf8a0bb6c9b6046827ba507235b9eeeb7d81a247e65bb56238832f6bf18a13bfc9a1b0e931a31e44b48d0bfd0400cc3858f7bf29527a7f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f20d8b16732f91f5f5ea6638a139981430f573c1324eb680a7d288776f973818f82dc2aac89c5ca9f6abef36a487eb7370edd7f399dd2744f608c40fcca9cac"} 10:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:21 INFO - Copying logs to upload dir... 10:35:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.133893 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-21 10:35:21.861735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-21 10:35:21.865622) ========= 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=3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320 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/bc3218ee58dbc771e920eac675a9690597421b02b5bf0ae661af1888f8346296c2692f0e68f125895e0db34abb4a2043c8d29fb2468cb181334092d5c998315d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8731af0d6c2b1e9f6fc446a9ec0d20ff81955f1ff3cce966dbbeba10d44995f5fa0123ec6999c6f86222157cdfb270fc7497bfe2186ed26bf9f3a7b42c259a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b5183a6527ebd6cf5bf8a0bb6c9b6046827ba507235b9eeeb7d81a247e65bb56238832f6bf18a13bfc9a1b0e931a31e44b48d0bfd0400cc3858f7bf29527a7f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f20d8b16732f91f5f5ea6638a139981430f573c1324eb680a7d288776f973818f82dc2aac89c5ca9f6abef36a487eb7370edd7f399dd2744f608c40fcca9cac"} build_url:https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/D3QdNzzWR_a9NWu79MqGHg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3218ee58dbc771e920eac675a9690597421b02b5bf0ae661af1888f8346296c2692f0e68f125895e0db34abb4a2043c8d29fb2468cb181334092d5c998315d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8731af0d6c2b1e9f6fc446a9ec0d20ff81955f1ff3cce966dbbeba10d44995f5fa0123ec6999c6f86222157cdfb270fc7497bfe2186ed26bf9f3a7b42c259a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b5183a6527ebd6cf5bf8a0bb6c9b6046827ba507235b9eeeb7d81a247e65bb56238832f6bf18a13bfc9a1b0e931a31e44b48d0bfd0400cc3858f7bf29527a7f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f20d8b16732f91f5f5ea6638a139981430f573c1324eb680a7d288776f973818f82dc2aac89c5ca9f6abef36a487eb7370edd7f399dd2744f608c40fcca9cac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-21 10:35:21.890969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:35:21.891317) ========= 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=3836458cccd887f2d2de3cf1000001de-1495385958.898635-409228320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:35:21.979923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-21 10:35:21.980314) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-21 10:35:21.980692) ========= ========= Total master_lag: 0.21 =========