builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1494851614.54 results: success (0) revision: 4f45e56b828c9dba63586012672016cb610a3b14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:34.543769) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:34.544163) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:34.544473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:34.572572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:34.572832) ========= 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=4300f881736b422476174874000001bc-1494848928.452438-2073740192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-15 05:33:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-05-15 05:33:35 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125975 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:34.712555) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:34.712849) ========= 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=4300f881736b422476174874000001bc-1494848928.452438-2073740192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015989 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:34.761736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-15 05:33:34.762029) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f45e56b828c9dba63586012672016cb610a3b14 --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 4f45e56b828c9dba63586012672016cb610a3b14 --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=4300f881736b422476174874000001bc-1494848928.452438-2073740192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-15 05:33:35,179 truncating revision to first 12 chars 2017-05-15 05:33:35,179 Setting DEBUG logging. 2017-05-15 05:33:35,179 attempt 1/10 2017-05-15 05:33:35,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f45e56b828c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-15 05:33:36,282 unpacking tar archive at: mozilla-central-4f45e56b828c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.396617 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-15 05:33:36.174911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:36.175205) ========= script_repo_revision: 4f45e56b828c9dba63586012672016cb610a3b14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:36.178619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:36.178881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-15 05:33:36.189891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-15 05:33:36.190162) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1494848928.452438-2073740192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:33:36 INFO - MultiFileLogger online at 20170515 05:33:36 in /builds/slave/test 05:33:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:33:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:33:36 INFO - {'append_to_log': False, 05:33:36 INFO - 'base_work_dir': '/builds/slave/test', 05:33:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:33:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:33:36 INFO - 'branch': 'Firefox-Non-PGO', 05:33:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:33:36 INFO - 'config_files': ('talos/linux_config.py',), 05:33:36 INFO - 'default_actions': ('clobber', 05:33:36 INFO - 'read-buildbot-config', 05:33:36 INFO - 'download-and-extract', 05:33:36 INFO - 'populate-webroot', 05:33:36 INFO - 'create-virtualenv', 05:33:36 INFO - 'install', 05:33:36 INFO - 'run-tests'), 05:33:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:33:36 INFO - 'download_minidump_stackwalk': True, 05:33:36 INFO - 'download_symbols': 'ondemand', 05:33:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:33:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:33:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:33:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:33:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:33:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:33:36 INFO - 'gecko_profile': False, 05:33:36 INFO - 'gecko_profile_interval': 0, 05:33:36 INFO - 'installer_path': 'installer.exe', 05:33:36 INFO - 'log_level': 'info', 05:33:36 INFO - 'log_name': 'talos', 05:33:36 INFO - 'log_to_console': True, 05:33:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:33:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:33:36 INFO - 'opt_config_files': (), 05:33:36 INFO - 'pip_index': False, 05:33:36 INFO - 'suite': 'dromaeojs-e10s', 05:33:36 INFO - 'system_bits': '32', 05:33:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:33:36 INFO - 'title': 'talos-linux64-ix-045', 05:33:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:33:36 INFO - 'use_talos_json': True, 05:33:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:33:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:33:36 INFO - 'work_dir': 'build'} 05:33:36 INFO - [mozharness: 2017-05-15 12:33:36.705533Z] Running clobber step. 05:33:36 INFO - Running pre-action listener: _resource_record_pre_action 05:33:36 INFO - Running main action method: clobber 05:33:36 INFO - rmtree: /builds/slave/test/build 05:33:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:33:38 INFO - Running post-action listener: _resource_record_post_action 05:33:38 INFO - [mozharness: 2017-05-15 12:33:38.228708Z] Finished clobber step (success) 05:33:38 INFO - [mozharness: 2017-05-15 12:33:38.228806Z] Running read-buildbot-config step. 05:33:38 INFO - Running pre-action listener: _resource_record_pre_action 05:33:38 INFO - Running main action method: read_buildbot_config 05:33:38 INFO - Using buildbot properties: 05:33:38 INFO - { 05:33:38 INFO - "project": "", 05:33:38 INFO - "product": "firefox", 05:33:38 INFO - "who": "cbook@mozilla.com", 05:33:38 INFO - "installer_path": "public/build/target.tar.bz2", 05:33:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:33:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:33:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:33:38 INFO - "stage_platform": "linux64", 05:33:38 INFO - "basedir": "/builds/slave/test", 05:33:38 INFO - "buildnumber": 829, 05:33:38 INFO - "platform": "ubuntu64_hw", 05:33:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:33:38 INFO - "slavebuilddir": "test", 05:33:38 INFO - "taskId": "bJE70XVYRkCfcVYJfvToGg", 05:33:38 INFO - "branch": "mozilla-central", 05:33:38 INFO - "script_repo_revision": "production", 05:33:38 INFO - "revision": "4f45e56b828c9dba63586012672016cb610a3b14", 05:33:38 INFO - "slavename": "talos-linux64-ix-045", 05:33:38 INFO - "repo_path": "mozilla-central" 05:33:38 INFO - } 05:33:38 INFO - Finding installer, test and symbols from parent task. 05:33:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bJE70XVYRkCfcVYJfvToGg'}, attempt #1 05:33:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bJE70XVYRkCfcVYJfvToGg'}, attempt #1 05:33:39 INFO - Task dependencies: FZfeLPyGR1ujk6QKz6BZJg 05:33:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg'}, attempt #1 05:33:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.tar.bz2 05:33:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/test_packages.json 05:33:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.crashreporter-symbols.zip 05:33:39 INFO - Running post-action listener: _resource_record_post_action 05:33:39 INFO - [mozharness: 2017-05-15 12:33:39.597000Z] Finished read-buildbot-config step (success) 05:33:39 INFO - [mozharness: 2017-05-15 12:33:39.597220Z] Running download-and-extract step. 05:33:39 INFO - Running pre-action listener: _resource_record_pre_action 05:33:39 INFO - Running main action method: download_and_extract 05:33:39 INFO - mkdir: /builds/slave/test/build/tests 05:33:39 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')]} 05:33:39 INFO - trying https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.test_packages.json 05:33:39 INFO - Downloading https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:33:40 INFO - Downloaded 986 bytes. 05:33:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:33:40 INFO - Using the following test package requirements: 05:33:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:33:40 INFO - u'common': [u'target.common.tests.zip'], 05:33:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:33:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:33:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:33:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:33:40 INFO - u'mozbase': [u'target.common.tests.zip'], 05:33:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:33:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:33:40 INFO - u'web-platform': [u'target.common.tests.zip', 05:33:40 INFO - u'target.web-platform.tests.zip'], 05:33:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:33:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:33:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.common.tests.zip 05:33:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:33:40 INFO - Fetch https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.common.tests.zip into memory 05:33:42 INFO - Content-Length response header: 62448330 05:33:42 INFO - Bytes received: 62448330 05:33:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:33:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.common.tests.zip 05:33:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:33:52 INFO - Fetch https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.common.tests.zip into memory 05:33:53 INFO - Content-Length response header: 62448330 05:33:53 INFO - Bytes received: 62448330 05:34:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.talos.tests.zip 05:34:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:34:05 INFO - Fetch https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.talos.tests.zip into memory 05:34:06 INFO - Content-Length response header: 14410013 05:34:06 INFO - Bytes received: 14410013 05:34:06 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')]} 05:34:06 INFO - trying https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.tar.bz2 05:34:06 INFO - Downloading https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:34:08 INFO - Downloaded 63410618 bytes. 05:34:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.tar.bz2 05:34:08 INFO - mkdir: /builds/slave/test/properties 05:34:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:34:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:34:08 INFO - Contents: 05:34:08 INFO - build_url:https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.tar.bz2 05:34:08 INFO - Running post-action listener: _resource_record_post_action 05:34:08 INFO - Running post-action listener: set_extra_try_arguments 05:34:08 INFO - [mozharness: 2017-05-15 12:34:08.664479Z] Finished download-and-extract step (success) 05:34:08 INFO - [mozharness: 2017-05-15 12:34:08.664608Z] Running populate-webroot step. 05:34:08 INFO - Running pre-action listener: _resource_record_pre_action 05:34:08 INFO - Running main action method: populate_webroot 05:34:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:34:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:34:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:34:08 INFO - '--tppagecycles', 05:34:08 INFO - '7'], 05:34:08 INFO - 'tests': ['tsvgm']}}, 05:34:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:34:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:34:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:34:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:34:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:34:08 INFO - 'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:34:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:34:08 INFO - 'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['damp', 'tps']}, 05:34:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:34:08 INFO - 'tests': ['damp', 'tps']}, 05:34:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['dromaeo_dom']}, 05:34:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:34:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:34:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:34:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['a11yr', 05:34:08 INFO - 'ts_paint', 05:34:08 INFO - 'tpaint', 05:34:08 INFO - 'sessionrestore', 05:34:08 INFO - 'sessionrestore_no_auto_restore', 05:34:08 INFO - 'tabpaint']}, 05:34:08 INFO - 'other-e10s': {'tests': ['a11yr', 05:34:08 INFO - 'ts_paint', 05:34:08 INFO - 'tpaint', 05:34:08 INFO - 'sessionrestore', 05:34:08 INFO - 'sessionrestore_no_auto_restore', 05:34:08 INFO - 'tabpaint']}, 05:34:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:34:08 INFO - 'ts_paint', 05:34:08 INFO - 'tpaint', 05:34:08 INFO - 'sessionrestore', 05:34:08 INFO - 'sessionrestore_no_auto_restore', 05:34:08 INFO - 'tabpaint']}, 05:34:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:34:08 INFO - 'ts_paint', 05:34:08 INFO - 'tpaint', 05:34:08 INFO - 'sessionrestore', 05:34:08 INFO - 'sessionrestore_no_auto_restore', 05:34:08 INFO - 'tabpaint']}, 05:34:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['a11yr', 05:34:08 INFO - 'ts_paint', 05:34:08 INFO - 'tpaint', 05:34:08 INFO - 'sessionrestore', 05:34:08 INFO - 'sessionrestore_no_auto_restore', 05:34:08 INFO - 'tabpaint']}, 05:34:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['a11yr', 05:34:08 INFO - 'ts_paint', 05:34:08 INFO - 'tpaint', 05:34:08 INFO - 'sessionrestore', 05:34:08 INFO - 'sessionrestore_no_auto_restore', 05:34:08 INFO - 'tabpaint']}, 05:34:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:34:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:34:08 INFO - 'bloom_basic_ref']}, 05:34:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['tsvgx', 05:34:08 INFO - 'tsvgr_opacity', 05:34:08 INFO - 'tart', 05:34:08 INFO - 'tscrollx', 05:34:08 INFO - 'cart', 05:34:08 INFO - 'tsvg_static']}, 05:34:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:34:08 INFO - 'tsvgr_opacity', 05:34:08 INFO - 'tart', 05:34:08 INFO - 'tscrollx', 05:34:08 INFO - 'cart', 05:34:08 INFO - 'tsvg_static']}, 05:34:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:34:08 INFO - 'talos_options': ['--disable-e10s'], 05:34:08 INFO - 'tests': ['tp5o']}, 05:34:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:34:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:34:08 INFO - 'talos_options': ['--disable-e10s', 05:34:08 INFO - '--xperf_path', 05:34:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:08 INFO - 'tests': ['tp5n']}, 05:34:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:34:08 INFO - 'talos_options': ['--xperf_path', 05:34:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:08 INFO - 'tests': ['tp5n']}}, 05:34:08 INFO - 'talos.zip': {'path': '', 05:34:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:34:08 INFO - Running post-action listener: _resource_record_post_action 05:34:08 INFO - [mozharness: 2017-05-15 12:34:08.680701Z] Finished populate-webroot step (success) 05:34:08 INFO - [mozharness: 2017-05-15 12:34:08.680789Z] Running create-virtualenv step. 05:34:08 INFO - Running pre-action listener: _resource_record_pre_action 05:34:08 INFO - Running main action method: create_virtualenv 05:34:08 INFO - Creating virtualenv /builds/slave/test/build/venv 05:34:08 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 05:34:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:34:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:34:08 INFO - Using real prefix '/usr' 05:34:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:34:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:34:11 INFO - Installing pip.................done. 05:34:11 INFO - Return code: 0 05:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:34:11 INFO - Reading from file tmpfile_stdout 05:34:11 INFO - Output received: 05:34:11 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) 05:34:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:34: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')]} 05:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34: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')]} 05:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34: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', 'pip>=1.5'] in /builds/slave/test/build 05:34: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 pip>=1.5 05:34:11 INFO - Using env: {'DISPLAY': ':0', 05:34:11 INFO - 'HOME': '/home/cltbld', 05:34:11 INFO - 'LANG': 'en_US.UTF-8', 05:34:11 INFO - 'LANGUAGE': 'en_US:en', 05:34:11 INFO - 'LOGNAME': 'cltbld', 05:34:11 INFO - 'MAIL': '/var/mail/cltbld', 05:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:11 INFO - 'MOZ_NO_REMOTE': '1', 05:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:11 INFO - 'NO_EM_RESTART': '1', 05:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:11 INFO - 'PWD': '/builds/slave/test', 05:34:11 INFO - 'SHELL': '/bin/bash', 05:34:11 INFO - 'SHLVL': '1', 05:34:11 INFO - 'TERM': 'linux', 05:34:11 INFO - 'TMOUT': '86400', 05:34:11 INFO - 'USER': 'cltbld', 05:34:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:11 INFO - '_': '/tools/buildbot/bin/python'} 05:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:11 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 05:34:11 INFO - Cleaning up... 05:34:11 INFO - Return code: 0 05:34:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:34: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')]} 05:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34: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')]} 05:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34: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', '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 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:34: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 psutil>=3.1.1 05:34:11 INFO - Using env: {'DISPLAY': ':0', 05:34:11 INFO - 'HOME': '/home/cltbld', 05:34:11 INFO - 'LANG': 'en_US.UTF-8', 05:34:11 INFO - 'LANGUAGE': 'en_US:en', 05:34:11 INFO - 'LOGNAME': 'cltbld', 05:34:11 INFO - 'MAIL': '/var/mail/cltbld', 05:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:11 INFO - 'MOZ_NO_REMOTE': '1', 05:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:11 INFO - 'NO_EM_RESTART': '1', 05:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:11 INFO - 'PWD': '/builds/slave/test', 05:34:11 INFO - 'SHELL': '/bin/bash', 05:34:11 INFO - 'SHLVL': '1', 05:34:11 INFO - 'TERM': 'linux', 05:34:11 INFO - 'TMOUT': '86400', 05:34:11 INFO - 'USER': 'cltbld', 05:34:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:11 INFO - '_': '/tools/buildbot/bin/python'} 05:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:11 INFO - Downloading/unpacking psutil>=3.1.1 05:34:11 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 05:34:11 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 05:34:11 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 05:34:11 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 05:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:34:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:13 INFO - Installing collected packages: psutil 05:34:13 INFO - Running setup.py install for psutil 05:34:13 INFO - building 'psutil._psutil_linux' extension 05:34:13 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 05:34:13 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 05:34:13 INFO - building 'psutil._psutil_posix' extension 05:34:13 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 05:34:13 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 05:34:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:13 INFO - Successfully installed psutil 05:34:13 INFO - Cleaning up... 05:34:13 INFO - Return code: 0 05:34:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:34:13 INFO - Using env: {'DISPLAY': ':0', 05:34:13 INFO - 'HOME': '/home/cltbld', 05:34:13 INFO - 'LANG': 'en_US.UTF-8', 05:34:13 INFO - 'LANGUAGE': 'en_US:en', 05:34:13 INFO - 'LOGNAME': 'cltbld', 05:34:13 INFO - 'MAIL': '/var/mail/cltbld', 05:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:13 INFO - 'MOZ_NO_REMOTE': '1', 05:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:13 INFO - 'NO_EM_RESTART': '1', 05:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:13 INFO - 'PWD': '/builds/slave/test', 05:34:13 INFO - 'SHELL': '/bin/bash', 05:34:13 INFO - 'SHLVL': '1', 05:34:13 INFO - 'TERM': 'linux', 05:34:13 INFO - 'TMOUT': '86400', 05:34:13 INFO - 'USER': 'cltbld', 05:34:13 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:13 INFO - '_': '/tools/buildbot/bin/python'} 05:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:34:13 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 05:34:13 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 05:34:13 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 05:34:13 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 05:34:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:34:14 INFO - Installing collected packages: mozsystemmonitor 05:34:14 INFO - Running setup.py install for mozsystemmonitor 05:34:15 INFO - Successfully installed mozsystemmonitor 05:34:15 INFO - Cleaning up... 05:34:15 INFO - Return code: 0 05:34:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:34:15 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')]} 05:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:15 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')]} 05:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:15 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 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34:15 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 05:34:15 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 05:34:15 INFO - Using env: {'DISPLAY': ':0', 05:34:15 INFO - 'HOME': '/home/cltbld', 05:34:15 INFO - 'LANG': 'en_US.UTF-8', 05:34:15 INFO - 'LANGUAGE': 'en_US:en', 05:34:15 INFO - 'LOGNAME': 'cltbld', 05:34:15 INFO - 'MAIL': '/var/mail/cltbld', 05:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:15 INFO - 'MOZ_NO_REMOTE': '1', 05:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:15 INFO - 'NO_EM_RESTART': '1', 05:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:15 INFO - 'PWD': '/builds/slave/test', 05:34:15 INFO - 'SHELL': '/bin/bash', 05:34:15 INFO - 'SHLVL': '1', 05:34:15 INFO - 'TERM': 'linux', 05:34:15 INFO - 'TMOUT': '86400', 05:34:15 INFO - 'USER': 'cltbld', 05:34:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:15 INFO - '_': '/tools/buildbot/bin/python'} 05:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:15 INFO - Downloading/unpacking jsonschema==2.5.1 05:34:15 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 05:34:15 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 05:34:15 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 05:34:15 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 05:34:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:34:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:34:16 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 05:34:16 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 05:34:16 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 05:34:16 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 05:34:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:34:16 INFO - warning: no files found matching '*.txt' 05:34:16 INFO - no previously-included directories found matching 'build' 05:34:16 INFO - no previously-included directories found matching 'dist' 05:34:16 INFO - no previously-included directories found matching '.git*' 05:34:16 INFO - Installing collected packages: jsonschema, functools32 05:34:16 INFO - Running setup.py install for functools32 05:34:16 INFO - warning: no files found matching '*.txt' 05:34:16 INFO - no previously-included directories found matching 'build' 05:34:16 INFO - no previously-included directories found matching 'dist' 05:34:16 INFO - no previously-included directories found matching '.git*' 05:34:16 INFO - Successfully installed jsonschema functools32 05:34:16 INFO - Cleaning up... 05:34:16 INFO - Return code: 0 05:34:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:34:16 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')]} 05:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:16 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')]} 05:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:16 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 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34:16 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 05:34:16 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 05:34:16 INFO - Using env: {'DISPLAY': ':0', 05:34:16 INFO - 'HOME': '/home/cltbld', 05:34:16 INFO - 'LANG': 'en_US.UTF-8', 05:34:16 INFO - 'LANGUAGE': 'en_US:en', 05:34:16 INFO - 'LOGNAME': 'cltbld', 05:34:16 INFO - 'MAIL': '/var/mail/cltbld', 05:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:16 INFO - 'MOZ_NO_REMOTE': '1', 05:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:16 INFO - 'NO_EM_RESTART': '1', 05:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:16 INFO - 'PWD': '/builds/slave/test', 05:34:16 INFO - 'SHELL': '/bin/bash', 05:34:16 INFO - 'SHLVL': '1', 05:34:16 INFO - 'TERM': 'linux', 05:34:16 INFO - 'TMOUT': '86400', 05:34:16 INFO - 'USER': 'cltbld', 05:34:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:16 INFO - '_': '/tools/buildbot/bin/python'} 05:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:34:16 INFO - Cleaning up... 05:34:17 INFO - Return code: 0 05:34:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:17 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 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34:17 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 05:34:17 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 05:34:17 INFO - Using env: {'DISPLAY': ':0', 05:34:17 INFO - 'HOME': '/home/cltbld', 05:34:17 INFO - 'LANG': 'en_US.UTF-8', 05:34:17 INFO - 'LANGUAGE': 'en_US:en', 05:34:17 INFO - 'LOGNAME': 'cltbld', 05:34:17 INFO - 'MAIL': '/var/mail/cltbld', 05:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:17 INFO - 'MOZ_NO_REMOTE': '1', 05:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:17 INFO - 'NO_EM_RESTART': '1', 05:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:17 INFO - 'PWD': '/builds/slave/test', 05:34:17 INFO - 'SHELL': '/bin/bash', 05:34:17 INFO - 'SHLVL': '1', 05:34:17 INFO - 'TERM': 'linux', 05:34:17 INFO - 'TMOUT': '86400', 05:34:17 INFO - 'USER': 'cltbld', 05:34:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:17 INFO - '_': '/tools/buildbot/bin/python'} 05:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:17 INFO - Downloading/unpacking blobuploader==1.2.4 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:18 INFO - Downloading blobuploader-1.2.4.tar.gz 05:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:34:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:34:18 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 05:34:18 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 05:34:18 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 05:34:18 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 05:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:34:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:34:18 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 05:34:18 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 05:34:18 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 05:34:18 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 05:34:18 INFO - Downloading docopt-0.6.1.tar.gz 05:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:34:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:34:18 INFO - Running setup.py install for blobuploader 05:34:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:34:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:34:18 INFO - Running setup.py install for requests 05:34:19 INFO - Running setup.py install for docopt 05:34:19 INFO - Successfully installed blobuploader requests docopt 05:34:19 INFO - Cleaning up... 05:34:19 INFO - Return code: 0 05:34:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:19 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 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34:19 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 05:34:19 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 05:34:19 INFO - Using env: {'DISPLAY': ':0', 05:34:19 INFO - 'HOME': '/home/cltbld', 05:34:19 INFO - 'LANG': 'en_US.UTF-8', 05:34:19 INFO - 'LANGUAGE': 'en_US:en', 05:34:19 INFO - 'LOGNAME': 'cltbld', 05:34:19 INFO - 'MAIL': '/var/mail/cltbld', 05:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:19 INFO - 'MOZ_NO_REMOTE': '1', 05:34:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:19 INFO - 'NO_EM_RESTART': '1', 05:34:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:19 INFO - 'PWD': '/builds/slave/test', 05:34:19 INFO - 'SHELL': '/bin/bash', 05:34:19 INFO - 'SHLVL': '1', 05:34:19 INFO - 'TERM': 'linux', 05:34:19 INFO - 'TMOUT': '86400', 05:34:19 INFO - 'USER': 'cltbld', 05:34:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:19 INFO - '_': '/tools/buildbot/bin/python'} 05:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:19 INFO - Running setup.py (path:/tmp/pip-WJzDu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:19 INFO - Running setup.py (path:/tmp/pip-2Qpsss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:19 INFO - Running setup.py (path:/tmp/pip-NR_gOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:19 INFO - Running setup.py (path:/tmp/pip-eUDpC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:20 INFO - Running setup.py (path:/tmp/pip-EvP0he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:20 INFO - Running setup.py (path:/tmp/pip-42dxZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:20 INFO - Running setup.py (path:/tmp/pip-DosYXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:20 INFO - Running setup.py (path:/tmp/pip-1817yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:20 INFO - Running setup.py (path:/tmp/pip-A8Cj29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:20 INFO - Running setup.py (path:/tmp/pip-QRDJUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:20 INFO - Running setup.py (path:/tmp/pip-ex9CAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:20 INFO - Running setup.py (path:/tmp/pip-9BTeBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:20 INFO - Running setup.py (path:/tmp/pip-gE6_U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:20 INFO - Running setup.py (path:/tmp/pip-PPXdND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:20 INFO - Running setup.py (path:/tmp/pip-5thJVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:20 INFO - Running setup.py (path:/tmp/pip-KuxxK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:20 INFO - Running setup.py (path:/tmp/pip-JfOPSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:34:20 INFO - Running setup.py install for manifestparser 05:34:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Running setup.py install for mozcrash 05:34:21 INFO - Running setup.py install for mozdebug 05:34:21 INFO - Running setup.py install for mozdevice 05:34:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Running setup.py install for mozfile 05:34:21 INFO - Running setup.py install for mozhttpd 05:34:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Running setup.py install for mozinfo 05:34:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Running setup.py install for mozInstall 05:34:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Running setup.py install for mozleak 05:34:21 INFO - Running setup.py install for mozlog 05:34:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:34:21 INFO - Running setup.py install for moznetwork 05:34:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:34:22 INFO - Running setup.py install for mozprocess 05:34:22 INFO - Running setup.py install for mozprofile 05:34:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:34:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:34:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:34:22 INFO - Running setup.py install for mozrunner 05:34:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:34:22 INFO - Running setup.py install for mozscreenshot 05:34:22 INFO - Running setup.py install for moztest 05:34:22 INFO - Running setup.py install for mozversion 05:34:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:34:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:34:22 INFO - Cleaning up... 05:34:22 INFO - Return code: 0 05:34:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:22 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 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34:22 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 05:34:22 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 05:34:22 INFO - Using env: {'DISPLAY': ':0', 05:34:22 INFO - 'HOME': '/home/cltbld', 05:34:22 INFO - 'LANG': 'en_US.UTF-8', 05:34:22 INFO - 'LANGUAGE': 'en_US:en', 05:34:22 INFO - 'LOGNAME': 'cltbld', 05:34:22 INFO - 'MAIL': '/var/mail/cltbld', 05:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:22 INFO - 'MOZ_NO_REMOTE': '1', 05:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:22 INFO - 'NO_EM_RESTART': '1', 05:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:22 INFO - 'PWD': '/builds/slave/test', 05:34:22 INFO - 'SHELL': '/bin/bash', 05:34:22 INFO - 'SHLVL': '1', 05:34:22 INFO - 'TERM': 'linux', 05:34:22 INFO - 'TMOUT': '86400', 05:34:22 INFO - 'USER': 'cltbld', 05:34:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:22 INFO - '_': '/tools/buildbot/bin/python'} 05:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:22 INFO - Running setup.py (path:/tmp/pip-C26WKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:23 INFO - Running setup.py (path:/tmp/pip-93wAxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:23 INFO - Running setup.py (path:/tmp/pip-8SPl0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:23 INFO - Running setup.py (path:/tmp/pip-zW44S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:23 INFO - Running setup.py (path:/tmp/pip-2SVKGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:23 INFO - Running setup.py (path:/tmp/pip-BnX2KQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:23 INFO - Running setup.py (path:/tmp/pip-_9SrJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:23 INFO - Running setup.py (path:/tmp/pip-QzKG5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:23 INFO - Running setup.py (path:/tmp/pip-kRtij4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:23 INFO - Running setup.py (path:/tmp/pip-AmMD0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:23 INFO - Running setup.py (path:/tmp/pip-tl018R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:23 INFO - Running setup.py (path:/tmp/pip-VgajZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:23 INFO - Running setup.py (path:/tmp/pip-_u00JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:23 INFO - Running setup.py (path:/tmp/pip-3Hr2la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:23 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)) 05:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:23 INFO - Running setup.py (path:/tmp/pip-YBoaZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:24 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)) 05:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:24 INFO - Running setup.py (path:/tmp/pip-0nYPPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:24 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)) 05:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:24 INFO - Running setup.py (path:/tmp/pip-8h9_Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:24 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)) 05:34:24 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)) 05:34:24 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)) 05:34:24 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)) 05:34:24 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)) 05:34:24 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)) 05:34:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:25 INFO - Downloading blessings-1.6.tar.gz 05:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:34:25 INFO - Installing collected packages: blessings 05:34:25 INFO - Running setup.py install for blessings 05:34:25 INFO - Successfully installed blessings 05:34:25 INFO - Cleaning up... 05:34:25 INFO - Return code: 0 05:34:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:34:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:34:25 INFO - Reading from file tmpfile_stdout 05:34:25 INFO - Current package versions: 05:34:25 INFO - argparse == 1.2.1 05:34:25 INFO - blessings == 1.6 05:34:25 INFO - blobuploader == 1.2.4 05:34:25 INFO - docopt == 0.6.1 05:34:25 INFO - functools32 == 3.2.3-2 05:34:25 INFO - jsonschema == 2.5.1 05:34:25 INFO - manifestparser == 1.1 05:34:25 INFO - mozInstall == 1.12 05:34:25 INFO - mozcrash == 1.0 05:34:25 INFO - mozdebug == 0.1 05:34:25 INFO - mozdevice == 0.50 05:34:25 INFO - mozfile == 1.2 05:34:25 INFO - mozhttpd == 0.7 05:34:25 INFO - mozinfo == 0.9 05:34:25 INFO - mozleak == 0.1 05:34:25 INFO - mozlog == 3.4 05:34:25 INFO - moznetwork == 0.27 05:34:25 INFO - mozprocess == 0.25 05:34:25 INFO - mozprofile == 0.28 05:34:25 INFO - mozrunner == 6.13 05:34:25 INFO - mozscreenshot == 0.1 05:34:25 INFO - mozsystemmonitor == 0.3 05:34:25 INFO - moztest == 0.8 05:34:25 INFO - mozversion == 1.4 05:34:25 INFO - psutil == 3.1.1 05:34:25 INFO - requests == 1.2.3 05:34:25 INFO - wsgiref == 0.1.2 05:34:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:25 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 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34:25 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 05:34:25 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 05:34:25 INFO - Using env: {'DISPLAY': ':0', 05:34:25 INFO - 'HOME': '/home/cltbld', 05:34:25 INFO - 'LANG': 'en_US.UTF-8', 05:34:25 INFO - 'LANGUAGE': 'en_US:en', 05:34:25 INFO - 'LOGNAME': 'cltbld', 05:34:25 INFO - 'MAIL': '/var/mail/cltbld', 05:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:25 INFO - 'MOZ_NO_REMOTE': '1', 05:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:25 INFO - 'NO_EM_RESTART': '1', 05:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:25 INFO - 'PWD': '/builds/slave/test', 05:34:25 INFO - 'SHELL': '/bin/bash', 05:34:25 INFO - 'SHLVL': '1', 05:34:25 INFO - 'TERM': 'linux', 05:34:25 INFO - 'TMOUT': '86400', 05:34:25 INFO - 'USER': 'cltbld', 05:34:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:25 INFO - '_': '/tools/buildbot/bin/python'} 05:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 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)) 05:34:25 INFO - Cleaning up... 05:34:25 INFO - Return code: 0 05:34:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2621a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, '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': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', '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 05:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:34:25 INFO - Using env: {'DISPLAY': ':0', 05:34:25 INFO - 'HOME': '/home/cltbld', 05:34:25 INFO - 'LANG': 'en_US.UTF-8', 05:34:25 INFO - 'LANGUAGE': 'en_US:en', 05:34:25 INFO - 'LOGNAME': 'cltbld', 05:34:25 INFO - 'MAIL': '/var/mail/cltbld', 05:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:25 INFO - 'MOZ_NO_REMOTE': '1', 05:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:25 INFO - 'NO_EM_RESTART': '1', 05:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:25 INFO - 'PWD': '/builds/slave/test', 05:34:25 INFO - 'SHELL': '/bin/bash', 05:34:25 INFO - 'SHLVL': '1', 05:34:25 INFO - 'TERM': 'linux', 05:34:25 INFO - 'TMOUT': '86400', 05:34:25 INFO - 'USER': 'cltbld', 05:34:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:25 INFO - '_': '/tools/buildbot/bin/python'} 05:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:34:26 INFO - Cleaning up... 05:34:26 INFO - Return code: 0 05:34:26 INFO - Running post-action listener: _resource_record_post_action 05:34:26 INFO - Running post-action listener: _start_resource_monitoring 05:34:26 INFO - Starting resource monitoring. 05:34:26 INFO - [mozharness: 2017-05-15 12:34:26.189054Z] Finished create-virtualenv step (success) 05:34:26 INFO - [mozharness: 2017-05-15 12:34:26.189574Z] Running install step. 05:34:26 INFO - Running pre-action listener: _resource_record_pre_action 05:34:26 INFO - Running main action method: install 05:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:34:26 INFO - Reading from file tmpfile_stdout 05:34:26 INFO - Detecting whether we're running mozinstall >=1.0... 05:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:34:26 INFO - Reading from file tmpfile_stdout 05:34:26 INFO - Output received: 05:34:26 INFO - Usage: mozinstall [options] installer 05:34:26 INFO - Options: 05:34:26 INFO - -h, --help show this help message and exit 05:34:26 INFO - -d DEST, --destination=DEST 05:34:26 INFO - Directory to install application into. [default: 05:34:26 INFO - "/builds/slave/test"] 05:34:26 INFO - --app=APP Application being installed. [default: firefox] 05:34:26 INFO - mkdir: /builds/slave/test/build/application 05:34:26 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'] 05:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:34:42 INFO - Reading from file tmpfile_stdout 05:34:42 INFO - Output received: 05:34:42 INFO - /builds/slave/test/build/application/firefox/firefox 05:34:42 INFO - Running post-action listener: _resource_record_post_action 05:34:42 INFO - [mozharness: 2017-05-15 12:34:42.335627Z] Finished install step (success) 05:34:42 INFO - [mozharness: 2017-05-15 12:34:42.335903Z] Running run-tests step. 05:34:42 INFO - Running pre-action listener: _resource_record_pre_action 05:34:42 INFO - Running main action method: run_tests 05:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:34:42 INFO - Python 2.7.3 05:34:42 INFO - Return code: 0 05:34:42 INFO - grabbing minidump binary from tooltool 05:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:42 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 0x27c47a0>, '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 0x27c56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c5b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:34:42 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 05:34:42 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 05:34:42 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 05:34:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:42 INFO - Return code: 0 05:34:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:34:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:34:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:34:42 INFO - ENV: RUST_BACKTRACE is now 1 05:34:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:34:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 05:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 05:34:42 INFO - Using env: {'DISPLAY': ':0', 05:34:42 INFO - 'HOME': '/home/cltbld', 05:34:42 INFO - 'LANG': 'en_US.UTF-8', 05:34:42 INFO - 'LANGUAGE': 'en_US:en', 05:34:42 INFO - 'LOGNAME': 'cltbld', 05:34:42 INFO - 'MAIL': '/var/mail/cltbld', 05:34:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:34:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:42 INFO - 'MOZ_NO_REMOTE': '1', 05:34:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:42 INFO - 'NO_EM_RESTART': '1', 05:34:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:42 INFO - 'PWD': '/builds/slave/test', 05:34:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:34:42 INFO - 'RUST_BACKTRACE': '1', 05:34:42 INFO - 'SHELL': '/bin/bash', 05:34:42 INFO - 'SHLVL': '1', 05:34:42 INFO - 'TERM': 'linux', 05:34:42 INFO - 'TMOUT': '86400', 05:34:42 INFO - 'USER': 'cltbld', 05:34:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1494848928.452438-2073740192', 05:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:42 INFO - '_': '/tools/buildbot/bin/python'} 05:34:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 05:34:42 INFO - mozversion application_buildid: 20170515115217 05:34:42 INFO - mozversion application_changeset: 4f45e56b828c9dba63586012672016cb610a3b14 05:34:42 INFO - mozversion application_display_name: Nightly 05:34:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:42 INFO - mozversion application_name: Firefox 05:34:42 INFO - mozversion application_remotingname: firefox 05:34:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:34:42 INFO - mozversion application_vendor: Mozilla 05:34:42 INFO - mozversion application_version: 55.0a1 05:34:42 INFO - mozversion platform_buildid: 20170515115217 05:34:42 INFO - mozversion platform_changeset: 4f45e56b828c9dba63586012672016cb610a3b14 05:34:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:34:42 INFO - mozversion platform_version: 55.0a1 05:34:42 INFO - using testdate: 1494851682 05:34:42 INFO - actual date: 1494851682 05:34:42 INFO - starting webserver on 'localhost:34779' 05:34:42 INFO - SUITE-START | Running 2 tests 05:34:42 INFO - TEST-START | dromaeo_css 05:34:42 INFO - operating with platform_type : linux_ 05:34:42 INFO - Initialising browser for dromaeo_css test... 05:34:42 INFO - TEST-INFO | started process 9133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNgrsRC/profile http://localhost:34779/getInfo.html) 05:34:43 INFO - PID 9133 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 05:34:46 INFO - PID 9133 | __metrics Screen width/height:1600/1200 05:34:46 INFO - PID 9133 | colorDepth:24 05:34:46 INFO - PID 9133 | Browser inner width/height: 1024/695 05:34:46 INFO - PID 9133 | __metrics 05:34:48 INFO - TEST-INFO | 9133: exit 0 05:34:48 INFO - Browser initialized. 05:34:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:48 INFO - TEST-INFO | started process 9303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNgrsRC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:00 INFO - PID 9303 | RSS: Main: 161861632 05:35:00 INFO - PID 9303 | 05:38:05 INFO - PID 9303 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34779/tests/dromaeo/cssquery-ext.html) 05:38:08 INFO - PID 9303 | RSS: Main: 170323968 05:38:08 INFO - PID 9303 | 05:41:10 INFO - PID 9303 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-ext.html (next: http://localhost:34779/tests/dromaeo/cssquery-jquery.html) 05:41:11 INFO - PID 9303 | RSS: Main: 167186432 05:41:11 INFO - PID 9303 | 05:44:12 INFO - PID 9303 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34779/tests/dromaeo/cssquery-mootools.html) 05:44:13 INFO - PID 9303 | RSS: Main: 169725952 05:44:13 INFO - PID 9303 | 05:47:15 INFO - PID 9303 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34779/tests/dromaeo/cssquery-prototype.html) 05:47:15 INFO - PID 9303 | RSS: Main: 166649856 05:47:15 INFO - PID 9303 | 05:50:18 INFO - PID 9303 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34779/tests/dromaeo/cssquery-yui.html) 05:50:19 INFO - PID 9303 | RSS: Main: 167469056 05:50:19 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-yui.html (next: http://localhost:34779/tests/dromaeo/cssquery-dojo.html) 05:53:21 INFO - PID 9303 | RSS: Main: 174096384 05:53:21 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | __start_tp_report 05:53:21 INFO - PID 9303 | _x_x_mozilla_page_load 05:53:21 INFO - PID 9303 | _x_x_mozilla_page_load_details 05:53:21 INFO - PID 9303 | |i|pagename|runs| 05:53:21 INFO - PID 9303 | |0;dojo.html;2711.7694995925344;2746.58801179823;2767.142185922363;2788.079933621905;2789.790765692572;5303.522682958533;5390.78436862525;5417.729113544322;5442.863928401792;5462.617616766833;5382.300300960879;5419.458054194579;5470.124780035195;5485.451454854512;5489.752961116749;4496.213162696531;4770;4774.80900763969;4795.064962332347;4865.318855360252;4865.927011094836;4910.533499317577;4911.968486617815;4914.1400254955415;4935.358403407552;4650.720956742606;4748.738819364934;4832.323474713543;4851.369321988119;4950.108980383529;4767.737774422405;4819.7108173509705;4836.733979631119;4860.149473842099;4877.0489754497885;4737.194676904935;4754.904901901978;4774.307725379836;4775.761211939389;4805.231163013901;5278.261043453919;5383.73081345935;5401.243825864382;5402.8919421611745;5407.864803379907;5655.123455864347;5696.515796157331;5732.770689172428;5743.195952566644;5752.741126649311;5779.450952159538;5780.757137215477;5792.768289268424;5792.8841423171725;5799.913001304942;5267.341582302212;5315.707636079976;5328.547073498718;5357.1696387060065;5370.543503802142;5874.853128671817;5901.793437229677;5906.143609176645;5939.4951429129005;5945;5618.550515958714;5629.831105066854;5633.8591535211945;5639.520640745501;5640.971795140998;5744.913826292609;5769.365369809318;5812.389699081536;5857.443542863506;5897.7935772247765;5822.941770582324;5824.592278540462;5831.3877042910735;5835.620684655484;5867.237259156283;5805.129230615442;5814.215080964101;5818.6217895836635;5820.88358232833;5836.037053886062;4712.952870471251;4761.309610106515;4793.592544633675;4846.030793841246;4847.830325938646;4176.2691528982305;4182.372644103348;4189.05746207107;4221.936670949877;4249.426327445817;4989.650724449254;5010.69935803853;5013.89972200554;5017.209557539825;5070.391553013662;5721.684012677108;5806.1581070744505;5807.4482924122985;5922.437368449991;5937.317208520989;4899.216125419915;4907.754612269372;4915.3855768029;4916.139675556763;4944.3572335596145;5016.147254966664;5124.5131712488;5128.256402821645;5128.769205385766;5151.922721159186;5253.553447956967;5308.150695888639;5318.016167009116;5320.547753441001;5334.359876814807;5116.820911268088;5733.02538568436;5774.56690748204;5879.323877753942;5922.5261979040715;5441.347038355423;5442.265294185393;5446.428125046971;5447.4824891635235;5481.040817856939;5640.125780504029;5684.090545512699;5717.1995920570325;5797.1304304353;5855.648661080349;5778.711064446845;5863.530917526502;5876.647401155944;5878.500327472213;5880.411958804086;5566.165075238747;5571.860703482445;5572.721363931868;5575.8884822304135;5576.358718747396;5542.972285138549;5547.140193270049;5556.388797232382;5563.58273129525;5572;5481.451854814487;5493.917591236055;5497.147942068986;5499.615026948075;5515;5485.204645326326;5600.579956503197;5607.8878422432135;5613.326400831927;5630.2680651516675;4991.975040124777;5388.191771234189;5631.8592035199445;5652.971735141298;5676.978143934131 05:53:21 INFO - PID 9303 | |1;ext.html;744.8286894014377;762.7101701353484;1062.9202809789263;1077.288989267084;1156.3177725142164;32880.83559582202;34088.31823363531;34255.14362140944;34305;34323.14192145198;31407.68592314076;31623.209419764516;31645.841770791172;31752.206194845083;31788.68211317886;6401.9039714404325;6513;6515.0227465880025;6778.525503214777;6914.274001229874;6900.171979362483;6990.231074581792;6990.405815505688;6993.720251189946;6994.230634630212;6924.272951340113;6944.826379340507;6952.374286314231;6974.476914231427;7015.789526314194;6907.6875393675045;6957.47818913581;6966.9303306967295;7001.894971575431;7016.71933122677;6875.140607424072;6914.723411063602;6928.272531384183;6951.89572156418;6965.79102626922;31521.36957260842;32009.199770005704;32170;32175.35649287001;32189.356212875613;2926.897558585439;2947.0422112813208;2963.229560314312;2963.4517614241436;2964.688707685705;24641.876790616112;25166.874165629237;25245.11642092518;25286.114985975586;25358.746412535824;3048.131282584475;3059.4951832947536;3072.0476652237653;3142.5600415941785;3158.7630927680284;131963;131981.3400932999;132042.3397883014;133032.33483832615;133787;37939.81030094832;39388.40917386241;39615;39729.801350993635;40103;40425;40606.187876242904;40744.79627601902;40909;41014.794926025774;12977.545785897448;13093.476260949647;13093.934530327479;13098.2141071536;13118.737625247442;10309.53607087683;10381.169506439466;10413.947930260452;10448.425336606408;10466.058054775107;12640.178388404724;12728.93635531835;12775.744485110246;12797.992471769126;12909.09636325467;5135.486451354835;5163.509466600667;5352.090144675414;5359.598030147755;5366.007288651612;857.121450513229;912.762681702762;920.0569416348296;921.9262459003263;945.7730144765206;20513.435820522434;21569.67645485319;21725.239616613344;21778.128874845144;21988.34034978953;986.1420564109128;993.438707130469;1003.3377970539555;1011.4841430870162;1014.7970405918845;10881.455927203608;11236.494357753922;11462.770744585061;11513.963743263146;11646.825297620542;171355;172744;173900;174117;174894;41009;41162.38256426156;41233;41244;41398.37902431466;1189.3280296632374;1244.4959791284543;1258.9748205035849;1261.9810702839466;1263.8925691316342;19483.805161948767;19744.210573224333;20191.79808201899;21114.577708446053;21171;29179.85410072936;29500.704992949795;29549.704502954693;29581.556276655436;29673.703262967094;144373;144464;144736.27631861775;144789;145024.27487862494;29009.274768130967;29120.854395727885;30422.543661844647;31688.366232674758;31813.8409307952;37389.626103738614;37860.432093518066;37931.81034094812;37951.43072853965;37960;27136.72863271421;27727.861360693874;27985.300367490974;28216.71783282141;28560;27807.443851122458;28244.576331354634;28905.710942890302;29238.707612923597;29552.408951821275;30867.0739877804;31462.528062079546;31560.053198404086;31576.842115789274;31595.21011974719;27244.455110898067;27415.17754467369;28100.43799124047;28339.14982550527;29145.85427072936;21905.561888762455;22573.43566410853;22933.770662293162;23040.769592303863;23158 05:53:21 INFO - PID 9303 | |2;jquery.html;405.5457887166374;410.61197168675596;428.824182085345;430.6619303846479;439.1590104949023;13796.793048104286;16731.163441827906;17384.391546295883;17399.91300043501;17489.300427982897;18098.547536311566;18415.723764143517;18785.34251301205;18839.623207535842;19083;5363.195520671891;5364.651297665649;5585.776568937237;5597.076482380423;5619.522340601054;5405.243265942771;5530.640508366943;5535.501804837564;5536.806211782588;5550.111982082867;5434.130539113743;5461.863453413656;5528.44715528448;5560.165975103726;5568.554515638739;5492.780288788464;5512.944870551283;5516.420775818561;5531.474509921572;5549.334079910396;4959.727215003173;4965;4991.725455099968;4996.350474438336;4999.650024498286;21990.780092199195;22021.35743710749;22215.22246721357;22519.211827585958;22928.656070158795;1659.5353301075718;1680.596656802371;1685.8314168583165;1703.4804384662673;1704.991475042617;14441;14555.636109097251;14989.625259368495;15027.699446011127;15044.473443429428;2046.2531176120758;2108.1462007886676;2130.5738852229615;2143.442704896738;2157.9028943697413;89328.55335723345;89380.10619893782;90279;91363;92248.53875730645;10937.507812148473;10960.780784384267;11027.779444411068;11046;11212.66362009141;15273.541793746206;15408.228053773959;15461.38154473831;15464;15478.845211547741;7845.882311765328;7852.528848269122;7886.132525422199;8096.392770542115;8099.392545559107;7258.891116633255;7293.52592081513;7462.85074298511;7516.398688105048;7537.623118844036;6940.687669054904;6973.58158510491;6995.335443132894;7036.6481675916;7045.612491313027;2038.88786116765;2061.2476446097066;2070.513429344103;2086.728725265736;2195.83531235158;842.9157084291522;872.7425409504084;875.3434923807145;888.2716172738293;906.6735975048977;17489.56276093108;17490.475285741195;17764.822351776318;18144.461829943033;18223.45329640113;857.8798968144465;871.4640496094983;874.3922973533333;883.3286702106317;903.4263242840843;9344.813103738023;9756.414615123116;9795.167410770022;9852.852207216898;9856.162226210852;375536;388793;393287;393295;393462;77178;78091;78113.6094319536;78344;78681.60659196667;1033.7622346860114;1041.1046500009986;1072.8712554493354;1075.4461452352045;1075.9515821788038;14882.404703811726;15051;15104.773428398803;15390.153541555323;15704.293306800993;38089.6191038086;38960.32476102886;39225.411618826314;40236;40937;49084.75457622832;49094.26358604695;49155;51500.742496287276;51906;7878.133405325524;8024.598770061591;8029.638666259915;8154.633041513028;8330.583470826556;11534.365609891536;11716.824247636121;11852.940735296268;11989.64031079069;13087.345632718136;10148.644797432054;10238.692839214835;10524.210684198562;10537.841932370868;10643.94678026605;9903;9999.55002024896;10161.339512931636;10359.63741269052;10772.569097236023;10125.746856328651;10732.839007415052;10930.453477325942;11078.224524283223;11202.21584489078;7677.30904218623;7697.114831794192;7906.644201010853;7933.642986065756;8148.877766833383;10395.532201050819;10434.799998000328;10766.515506802369;11054.502547385548;11081.390523521284 05:53:21 INFO - PID 9303 | |3;mootools.html;1232.9691757706057;1292.573450761249;1298.0329654407467;1303.4720938020105;1303.7066660001499;10165.339252948563;10613.41626210558;10628.415437150954;10657.520411581478;10841.457927103633;10603.045725884669;10689.572417103325;10755.569777208922;10770.623028194015;10801.243912926098;2236.2508559632543;2265.2184996176375;2275.419767959168;2279.133929106937;2279.3731723776013;2159.136345461812;2222.744384395791;2240.9215677451293;2244.349138749769;2250.0999600159985;2201.2515744646817;2213.889305534725;2253.3915842722454;2254.4363909022745;2254.9098036078535;2134.210342173398;2143.5605700831293;2174.1629472652985;2175.401764514755;2175.771543987882;2035.369035598969;2167.6856855755987;2169.425102347879;2176.7279090113734;2179.66215236637;9985.800283994353;10104.837943636503;10106.747331316703;10109.03964123407;10113.949430252875;5693.146028095777;5840.007198776176;5858.648481091148;5878;5891.351951285355;3174.9682503174904;3350.849211785451;3354.446516324828;3369.0566641340465;3422.57217847769;1035.9896401036044;1042.4162469017374;1076.6070384309671;1081.3674000709593;1098.9010989011028;15230.695386092328;15336.23318834065;15342.463013794575;15350.462733804263;15441.768373474295;4758;4921.834392867127;5031.169856973558;5056.772445239973;5116;11027.503762330714;11039.39283339408;11059.447027648584;11079.279846810094;11088.112950963903;5797.971010144923;5799.304083509922;5805.6806875621405;5805.970970145207;5806.593538452268;5146.382434107931;5312.893742125136;5317.521423071942;5344.278522399504;5395.379531353945;3785.507883975121;3871.322518559241;3910.843566257318;3968.682505399619;4025.597440255951;1085.1752667972398;1088.3198001249218;1103.4372470040337;1109.8723646780722;1126.4255229832845;689.1454596300651;720.5100531638536;731.1920328037548;739.1056821246244;742.4617152564348;5450.591205659592;5523.917141242885;5598.776048957996;5689.573282003867;5730.541556675456;531.2509361799844;552.6214543038031;555.4445554445555;557.4230671255232;570.9115087161497;3550.7336949728356;3559.483874838134;4073.5315438724333;4108.034611866209;4177.686673499439;13181.143225690299;13642.113262637897;13663.521776737767;13729.725405492034;13735.313234338244;12910.483580656857;13494.257815820029;13521.66195845092;13531.255780932142;13534;7512.286332798375;7588.468807183444;7650.655720492591;7658.157602663702;7674.194209608022;6231.844203894758;6388.87222255543;6469.385408386384;6494.383033611799;6637.966810165918;11729.706757331134;12111.273323600612;12163.81754273669;12334.321612311409;12428.689282768004;12213.267203967791;12318.50725970987;12525.749485010067;12540.122191446877;12624.116311858083;7975.361971042419;8161.959190204011;8165.836683266421;8166.305864001626;8197.75406737775;9587.520623968912;9596.808063838824;9626.518674066128;9760.85358719634;9837.852432213665;8155.062167850773;8330.916690833257;8341.20758527939;8374.120717324593;8629.69796057135;8259.876101858597;8331.875021874797;8342.249197572248;8370.288525475402;8381.11998240176;7408.888866667112;7422.294881986203;7596.430267729832;7644.050767054588;7681.577513236825;5339.439358867418;5347.893042139058;5387.838364849061;5456.945430545644;5467.507924286833;5567.805126820542;5669.092945128759;5758.337791154071;5869.94130058711;5878.118282257696 05:53:21 INFO - PID 9303 | |4;prototype.html;370.84609886896925;380.6003696119075;391.9020244938765;393.91727737175194;394.18797277608127;5459.754311056002;5589.217509548661;5595.636283641566;5624.734434752184;5642.210090587321;5323.494268044539;5445.237666726662;5451.911066699975;5453.291072160623;5461.262729531512;4081.591840815917;4086.284900142478;4105.187946256809;4123.649489793356;4131.070509135436;4065;4074.8777536673947;4081.653059489947;4140.3168477201225;4142.420061191436;4060.066184777503;4063.2482990646677;4081.938770918424;4086;4101.9179616407655;4076.979615101935;4082.81627326771;4085.2850751118435;4110.650594699454;4112.856050038235;3590.6588874056924;3594.2272411431404;3594.712423006153;3597.6402359764074;3600.873969411084;5277.815276465343;5320.397855854697;5334.946650533522;5347.839564813023;5373.361124856917;4773.665843390964;4796.8560943171415;4809.038192361541;4816.494268101834;4823.975880120577;5648.983183027053;5767.798127065533;5791.971040144772;5798.753268047348;5818.301803783573;4419.40338054365;4429.069895321986;4455.955440445587;4480.955190448087;4489.19194544985;5946.7026648667825;6087.391260873877;6154.199954005995;6228;6299.68501574924;4310.978445107754;4319.114581510783;4330.826766929351;4341.956580434218;4342.999999999937;4393.143337049309;4402.933955990663;4403.603675669141;4404.933925991113;4423.137488189836;4953.702777833341;4991.376077990251;4996.625253105959;5139.254808052811;5189.55888749453;5850.9414905851245;5867.530597552186;5885;5898.911516327258;5901.262342207224;1600.2398860541382;1621.9675606487804;1622.9350825966828;1633.7712720219179;1639.9672006559802;1136.267107715519;1171.722822123889;1173.3546549397797;1182.4265231362783;1185.7391373897728;5059.772310246048;5078.908034772541;5096.184610462383;5102.642815002989;5123.820666276737;5937.554683398763;6030.849228769316;6059.212302400748;6069.757209711651;6070.180525628984;4968.807596062124;4994.750262486861;5080.796768129233;5093.617978651616;5112.642115051911;3147.669494703069;3215.716841042839;3220.0822765511716;3224.548952971172;3243.0919342584116;5427.29445172133;5514.393416724157;5568.081266591048;5580.91628625571;5596.888062238814;6161.4146656067605;6174.691265436711;6190.628562286277;6195.349488303663;6200.81397558074;5465.125579907196;5561.304836895388;5567.436840422133;5573.498385145275;5593.133064375028;5949.286085669747;6010.33886272501;6014.939850601438;6051.213342265477;6055.424734650202;5732.4267573244015;5886.763779606331;5907.2911250650195;5930.703464826827;5951.672658003851;5552.918604825531;5563.443655634404;5612.7754889803955;5624.971875140598;5633.8309850704545;4080.3471444568727;4124.876253712393;4131.380292956081;4132.896677583084;4149.190907772955;5939.554533409925;6010.909836352371;6053.485453736482;6070.2108725865355;6104.236970378703;5808.30300363959;5808.680522571299;5839.620424672383;5857.882842343214;5887.852803679943;5652.089174075437;5814.186013958134;5834.15404766298;5835.737391817293;5847.947369473535;5674.347450043298;5718.199452076629;5778.191053252464;5787.450192231731;5789.45000224978;5878.559108066826;5890.793822216373;5895.056790913433;5896.587238893408;5904.52763778888;5534.612577119724;5673.177389278614;5729.197912292366;5729.312482502127;5772.3650398456975 05:53:21 INFO - PID 9303 | |5;yui.html;674.3189378727484;678.4979115454563;683.6650041479677;684.7671791590858;686.3925425997991;12414.565490207833;12716.68208294792;12784.488620455182;13485.05604607678;14304.427822887072;13817.654558636039;14062.718745625081;14150.221737804417;14354.856451435482;14364.92817535911;834.1325021977136;856.8928883889514;857.3312816003496;858.159004175908;860.4063196394468;869.5521806269776;892.0366004714892;904.4302089683523;905.4386280506095;910.0899100899101;905.782612173077;933.4166146158651;936.1013427109982;937.624950019994;940.4592359393342;903.2954295649371;927.4064598656865;928.8746019287445;931.0224264522225;935.4247138010109;670.3999920071509;680.2619158213345;688.3529482286634;689.2556039477403;693.4002088193727;12328.691782705504;12689.175203611736;12852.614421567368;12930.09489335747;13986.440542378394;15647.843521564753;15701.842981570266;15822.841771582252;16089.758653620205;16142.75785863213;12014.639560813102;12153.359296495037;12287.139900206988;12300.753984920251;12319.322437265946;2866.5413533834485;2893.3489964757973;2914.373409716921;2918.781091418131;2943.5731818886356;69933;70736;71640.28359716389;72299.27700722979;73088.99999999946;11417.714557136138;11600.535978560763;11778.469968851423;12383.071269654632;12514.937425312997;20195.899020505098;21593.568128637653;21728.456788580414;21855.781442185693;22102.557948840935;6048.153258543719;6186.381361863778;6285.277193122758;6286.9056964145575;6453.548251622436;3053.6946305369283;3116.4857798463;3123.703248191418;3125.4842950912844;3131.5928929239053;3051.893183738603;3148.307372378073;3150.6061742282213;3156.1005113542988;3168.1762741687326;729.3217307903594;740.6000759589762;740.7962810227231;746.9290417410338;749.8537785131956;591.340655169483;602.4638072115821;604.8699529601157;608.2154021312457;629.2669040567779;9038.412503187272;9649.276304277068;9675.951620241995;9770.951145244228;10281.94859025715;577.5610535992676;593.5251798561134;595.4611076975344;602.0337358539568;607.7872744539465;4301.6773741968855;4486.842960496367;4510.932336014962;4517.2094883395275;4596.816127354935;64609.35390646127;65141.67429162824;65586;66478;68043.3195668037;56602.7169864148;57556.71221643865;57972;60534;61282.69358653178;52861.47138528642;53008.20487692688;53109.2033619496;53237.7338113307;53846.7307663467;8782.385233033627;9107.453552786854;9152.130547597968;9158.129977652112;9396.201322887358;25151.24546263615;25532.872335638203;25622.103226386986;26203.082892098686;26738.331541711614;43288.350674739275;43681;44079;44870.551294487945;47716.284255735496;14390.568282951528;14757.335919883846;14856.554303370916;15017.474388396353;15200.923995379952;14242.145471271757;14728.337224825123;15005.024673396194;15201.467948621745;15685.45100921508;14973.700525989201;14976.251187440803;14976.850231497981;15033;15372.84627153714;12657.93671031639;13396;13638.93180534091;13702.65743356424;13779.931100344435;12452.377381130726;12667.113302069136;13528.188308701116;13576.524821631196;13602.183868967893;9275.350725449423;9709.80580388374;9882.25883058759;9975.301728878909;9981.700548983543;9961.551730172016;10131.848022279524;10582.576696932036;10705;11252.774944501229 05:53:21 INFO - PID 9303 | __end_tp_report 05:53:21 INFO - PID 9303 | __start_cc_report 05:53:21 INFO - PID 9303 | _x_x_mozilla_cycle_collect,285 05:53:21 INFO - PID 9303 | __end_cc_report 05:53:21 INFO - PID 9303 | __startTimestamp1494852801497__endTimestamp 05:53:21 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | ------- Summary: start ------- 05:53:21 INFO - PID 9303 | Number of tests: 6 05:53:21 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | [#0] dojo.html Cycles:165 Average:5287.82 Median:5447.48 stddev:620.09 (11.4%) stddev-sans-first:588.14 05:53:21 INFO - PID 9303 | Values: 2711.8 2746.6 2767.1 2788.1 2789.8 5303.5 5390.8 5417.7 5442.9 5462.6 5382.3 5419.5 5470.1 5485.5 5489.8 4496.2 4770.0 4774.8 4795.1 4865.3 4865.9 4910.5 4912.0 4914.1 4935.4 4650.7 4748.7 4832.3 4851.4 4950.1 4767.7 4819.7 4836.7 4860.1 4877.0 4737.2 4754.9 4774.3 4775.8 4805.2 5278.3 5383.7 5401.2 5402.9 5407.9 5655.1 5696.5 5732.8 5743.2 5752.7 5779.5 5780.8 5792.8 5792.9 5799.9 5267.3 5315.7 5328.5 5357.2 5370.5 5874.9 5901.8 5906.1 5939.5 5945.0 5618.6 5629.8 5633.9 5639.5 5641.0 5744.9 5769.4 5812.4 5857.4 5897.8 5822.9 5824.6 5831.4 5835.6 5867.2 5805.1 5814.2 5818.6 5820.9 5836.0 4713.0 4761.3 4793.6 4846.0 4847.8 4176.3 4182.4 4189.1 4221.9 4249.4 4989.7 5010.7 5013.9 5017.2 5070.4 5721.7 5806.2 5807.4 5922.4 5937.3 4899.2 4907.8 4915.4 4916.1 4944.4 5016.1 5124.5 5128.3 5128.8 5151.9 5253.6 5308.2 5318.0 5320.5 5334.4 5116.8 5733.0 5774.6 5879.3 5922.5 5441.3 5442.3 5446.4 5447.5 5481.0 5640.1 5684.1 5717.2 5797.1 5855.6 5778.7 5863.5 5876.6 5878.5 5880.4 5566.2 5571.9 5572.7 5575.9 5576.4 5543.0 5547.1 5556.4 5563.6 5572.0 5481.5 5493.9 5497.1 5499.6 5515.0 5485.2 5600.6 5607.9 5613.3 5630.3 4992.0 5388.2 5631.9 5653.0 5677.0 05:53:21 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | [#1] ext.html Cycles:180 Average:29740.35 Median:2964.07 stddev:38950.50 (1314.1%) stddev-sans-first:38998.92 05:53:21 INFO - PID 9303 | Values: 744.8 762.7 1062.9 1077.3 1156.3 32880.8 34088.3 34255.1 34305.0 34323.1 31407.7 31623.2 31645.8 31752.2 31788.7 6401.9 6513.0 6515.0 6778.5 6914.3 6900.2 6990.2 6990.4 6993.7 6994.2 6924.3 6944.8 6952.4 6974.5 7015.8 6907.7 6957.5 6966.9 7001.9 7016.7 6875.1 6914.7 6928.3 6951.9 6965.8 31521.4 32009.2 32170.0 32175.4 32189.4 2926.9 2947.0 2963.2 2963.5 2964.7 24641.9 25166.9 25245.1 25286.1 25358.7 3048.1 3059.5 3072.0 3142.6 3158.8 131963.0 131981.3 132042.3 133032.3 133787.0 37939.8 39388.4 39615.0 39729.8 40103.0 40425.0 40606.2 40744.8 40909.0 41014.8 12977.5 13093.5 13093.9 13098.2 13118.7 10309.5 10381.2 10413.9 10448.4 10466.1 12640.2 12728.9 12775.7 12798.0 12909.1 5135.5 5163.5 5352.1 5359.6 5366.0 857.1 912.8 920.1 921.9 945.8 20513.4 21569.7 21725.2 21778.1 21988.3 986.1 993.4 1003.3 1011.5 1014.8 10881.5 11236.5 11462.8 11514.0 11646.8 171355.0 172744.0 173900.0 174117.0 174894.0 41009.0 41162.4 41233.0 41244.0 41398.4 1189.3 1244.5 1259.0 1262.0 1263.9 19483.8 19744.2 20191.8 21114.6 21171.0 29179.9 29500.7 29549.7 29581.6 29673.7 144373.0 144464.0 144736.3 144789.0 145024.3 29009.3 29120.9 30422.5 31688.4 31813.8 37389.6 37860.4 37931.8 37951.4 37960.0 27136.7 27727.9 27985.3 28216.7 28560.0 27807.4 28244.6 28905.7 29238.7 29552.4 30867.1 31462.5 31560.1 31576.8 31595.2 27244.5 27415.2 28100.4 28339.1 29145.9 21905.6 22573.4 22933.8 23040.8 23158.0 05:53:21 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | [#2] jquery.html Cycles:180 Average:25484.25 Median:216849.00 stddev:64654.87 (29.8%) stddev-sans-first:64808.82 05:53:21 INFO - PID 9303 | Values: 405.5 410.6 428.8 430.7 439.2 13796.8 16731.2 17384.4 17399.9 17489.3 18098.5 18415.7 18785.3 18839.6 19083.0 5363.2 5364.7 5585.8 5597.1 5619.5 5405.2 5530.6 5535.5 5536.8 5550.1 5434.1 5461.9 5528.4 5560.2 5568.6 5492.8 5512.9 5516.4 5531.5 5549.3 4959.7 4965.0 4991.7 4996.4 4999.7 21990.8 22021.4 22215.2 22519.2 22928.7 1659.5 1680.6 1685.8 1703.5 1705.0 14441.0 14555.6 14989.6 15027.7 15044.5 2046.3 2108.1 2130.6 2143.4 2157.9 89328.6 89380.1 90279.0 91363.0 92248.5 10937.5 10960.8 11027.8 11046.0 11212.7 15273.5 15408.2 15461.4 15464.0 15478.8 7845.9 7852.5 7886.1 8096.4 8099.4 7258.9 7293.5 7462.9 7516.4 7537.6 6940.7 6973.6 6995.3 7036.6 7045.6 2038.9 2061.2 2070.5 2086.7 2195.8 842.9 872.7 875.3 888.3 906.7 17489.6 17490.5 17764.8 18144.5 18223.5 857.9 871.5 874.4 883.3 903.4 9344.8 9756.4 9795.2 9852.9 9856.2 375536.0 388793.0 393287.0 393295.0 393462.0 77178.0 78091.0 78113.6 78344.0 78681.6 1033.8 1041.1 1072.9 1075.4 1076.0 14882.4 15051.0 15104.8 15390.2 15704.3 38089.6 38960.3 39225.4 40236.0 40937.0 49084.8 49094.3 49155.0 51500.7 51906.0 7878.1 8024.6 8029.6 8154.6 8330.6 11534.4 11716.8 11852.9 11989.6 13087.3 10148.6 10238.7 10524.2 10537.8 10643.9 9903.0 9999.6 10161.3 10359.6 10772.6 10125.7 10732.8 10930.5 11078.2 11202.2 7677.3 7697.1 7906.6 7933.6 8148.9 10395.5 10434.8 10766.5 11054.5 11081.4 05:53:21 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | [#3] mootools.html Cycles:180 Average:6418.76 Median:3672.50 stddev:4131.87 (112.5%) stddev-sans-first:4125.09 05:53:21 INFO - PID 9303 | Values: 1233.0 1292.6 1298.0 1303.5 1303.7 10165.3 10613.4 10628.4 10657.5 10841.5 10603.0 10689.6 10755.6 10770.6 10801.2 2236.3 2265.2 2275.4 2279.1 2279.4 2159.1 2222.7 2240.9 2244.3 2250.1 2201.3 2213.9 2253.4 2254.4 2254.9 2134.2 2143.6 2174.2 2175.4 2175.8 2035.4 2167.7 2169.4 2176.7 2179.7 9985.8 10104.8 10106.7 10109.0 10113.9 5693.1 5840.0 5858.6 5878.0 5891.4 3175.0 3350.8 3354.4 3369.1 3422.6 1036.0 1042.4 1076.6 1081.4 1098.9 15230.7 15336.2 15342.5 15350.5 15441.8 4758.0 4921.8 5031.2 5056.8 5116.0 11027.5 11039.4 11059.4 11079.3 11088.1 5798.0 5799.3 5805.7 5806.0 5806.6 5146.4 5312.9 5317.5 5344.3 5395.4 3785.5 3871.3 3910.8 3968.7 4025.6 1085.2 1088.3 1103.4 1109.9 1126.4 689.1 720.5 731.2 739.1 742.5 5450.6 5523.9 5598.8 5689.6 5730.5 531.3 552.6 555.4 557.4 570.9 3550.7 3559.5 4073.5 4108.0 4177.7 13181.1 13642.1 13663.5 13729.7 13735.3 12910.5 13494.3 13521.7 13531.3 13534.0 7512.3 7588.5 7650.7 7658.2 7674.2 6231.8 6388.9 6469.4 6494.4 6638.0 11729.7 12111.3 12163.8 12334.3 12428.7 12213.3 12318.5 12525.7 12540.1 12624.1 7975.4 8162.0 8165.8 8166.3 8197.8 9587.5 9596.8 9626.5 9760.9 9837.9 8155.1 8330.9 8341.2 8374.1 8629.7 8259.9 8331.9 8342.2 8370.3 8381.1 7408.9 7422.3 7596.4 7644.1 7681.6 5339.4 5347.9 5387.8 5456.9 5467.5 5567.8 5669.1 5758.3 5869.9 5878.1 05:53:21 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | [#4] prototype.html Cycles:180 Average:4822.62 Median:5400.33 stddev:1392.87 (25.8%) stddev-sans-first:1356.11 05:53:21 INFO - PID 9303 | Values: 370.8 380.6 391.9 393.9 394.2 5459.8 5589.2 5595.6 5624.7 5642.2 5323.5 5445.2 5451.9 5453.3 5461.3 4081.6 4086.3 4105.2 4123.6 4131.1 4065.0 4074.9 4081.7 4140.3 4142.4 4060.1 4063.2 4081.9 4086.0 4101.9 4077.0 4082.8 4085.3 4110.7 4112.9 3590.7 3594.2 3594.7 3597.6 3600.9 5277.8 5320.4 5334.9 5347.8 5373.4 4773.7 4796.9 4809.0 4816.5 4824.0 5649.0 5767.8 5792.0 5798.8 5818.3 4419.4 4429.1 4456.0 4481.0 4489.2 5946.7 6087.4 6154.2 6228.0 6299.7 4311.0 4319.1 4330.8 4342.0 4343.0 4393.1 4402.9 4403.6 4404.9 4423.1 4953.7 4991.4 4996.6 5139.3 5189.6 5850.9 5867.5 5885.0 5898.9 5901.3 1600.2 1622.0 1622.9 1633.8 1640.0 1136.3 1171.7 1173.4 1182.4 1185.7 5059.8 5078.9 5096.2 5102.6 5123.8 5937.6 6030.8 6059.2 6069.8 6070.2 4968.8 4994.8 5080.8 5093.6 5112.6 3147.7 3215.7 3220.1 3224.5 3243.1 5427.3 5514.4 5568.1 5580.9 5596.9 6161.4 6174.7 6190.6 6195.3 6200.8 5465.1 5561.3 5567.4 5573.5 5593.1 5949.3 6010.3 6014.9 6051.2 6055.4 5732.4 5886.8 5907.3 5930.7 5951.7 5552.9 5563.4 5612.8 5625.0 5633.8 4080.3 4124.9 4131.4 4132.9 4149.2 5939.6 6010.9 6053.5 6070.2 6104.2 5808.3 5808.7 5839.6 5857.9 5887.9 5652.1 5814.2 5834.2 5835.7 5847.9 5674.3 5718.2 5778.2 5787.5 5789.5 5878.6 5890.8 5895.1 5896.6 5904.5 5534.6 5673.2 5729.2 5729.3 5772.4 05:53:21 INFO - PID 9303 | 05:53:21 INFO - PID 9303 | [#5] yui.html Cycles:180 Average:15534.71 Median:24690.74 stddev:18907.58 (76.6%) stddev-sans-first:18927.69 05:53:21 INFO - PID 9303 | Values: 674.3 678.5 683.7 684.8 686.4 12414.6 12716.7 12784.5 13485.1 14304.4 13817.7 14062.7 14150.2 14354.9 14364.9 834.1 856.9 857.3 858.2 860.4 869.6 892.0 904.4 905.4 910.1 905.8 933.4 936.1 937.6 940.5 903.3 927.4 928.9 931.0 935.4 670.4 680.3 688.4 689.3 693.4 12328.7 12689.2 12852.6 12930.1 13986.4 15647.8 15701.8 15822.8 16089.8 16142.8 12014.6 12153.4 12287.1 12300.8 12319.3 2866.5 2893.3 2914.4 2918.8 2943.6 69933.0 70736.0 71640.3 72299.3 73089.0 11417.7 11600.5 11778.5 12383.1 12514.9 20195.9 21593.6 21728.5 21855.8 22102.6 6048.2 6186.4 6285.3 6286.9 6453.5 3053.7 3116.5 3123.7 3125.5 3131.6 3051.9 3148.3 3150.6 3156.1 3168.2 729.3 740.6 740.8 746.9 749.9 591.3 602.5 604.9 608.2 629.3 9038.4 9649.3 9676.0 9771.0 10281.9 577.6 593.5 595.5 602.0 607.8 4301.7 4486.8 4510.9 4517.2 4596.8 64609.4 65141.7 65586.0 66478.0 68043.3 56602.7 57556.7 57972.0 60534.0 61282.7 52861.5 53008.2 53109.2 53237.7 53846.7 8782.4 9107.5 9152.1 9158.1 9396.2 25151.2 25532.9 25622.1 26203.1 26738.3 43288.4 43681.0 44079.0 44870.6 47716.3 14390.6 14757.3 14856.6 15017.5 15200.9 14242.1 14728.3 15005.0 15201.5 15685.5 14973.7 14976.3 14976.9 15033.0 15372.8 12657.9 13396.0 13638.9 13702.7 13779.9 12452.4 12667.1 13528.2 13576.5 13602.2 9275.4 9709.8 9882.3 9975.3 9981.7 9961.6 10131.8 10582.6 10705.0 11252.8 05:53:21 INFO - PID 9303 | -------- Summary: end -------- 05:53:21 INFO - PID 9303 | 05:53:22 INFO - TEST-INFO | 9303: exit 0 05:53:22 INFO - TEST-OK | dromaeo_css | took 1119771ms 05:53:22 INFO - TEST-START | kraken 05:53:22 INFO - operating with platform_type : linux_ 05:53:22 INFO - Initialising browser for kraken test... 05:53:22 INFO - TEST-INFO | started process 9716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKBOr0/profile http://localhost:34779/getInfo.html) 05:53:22 INFO - PID 9716 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 05:53:26 INFO - PID 9716 | __metrics Screen width/height:1600/1200 05:53:26 INFO - PID 9716 | colorDepth:24 05:53:26 INFO - PID 9716 | Browser inner width/height: 1024/695 05:53:26 INFO - PID 9716 | __metrics 05:53:28 INFO - TEST-INFO | 9716: exit 0 05:53:28 INFO - Browser initialized. 05:53:28 INFO - Running cycle 1/1 for kraken test... 05:53:28 INFO - TEST-INFO | started process 9889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKBOr0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:39 INFO - PID 9889 | RSS: Main: 162332672 05:53:39 INFO - PID 9889 | 05:53:42 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34779/tests/kraken/driver.html?testName=audio-beat-detection) 05:53:43 INFO - PID 9889 | RSS: Main: 167907328 05:53:43 INFO - PID 9889 | 05:53:46 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34779/tests/kraken/driver.html?testName=audio-dft) 05:53:46 INFO - PID 9889 | RSS: Main: 167280640 05:53:46 INFO - PID 9889 | 05:53:49 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34779/tests/kraken/driver.html?testName=audio-fft) 05:53:50 INFO - PID 9889 | RSS: Main: 162422784 05:53:50 INFO - PID 9889 | 05:53:52 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34779/tests/kraken/driver.html?testName=audio-oscillator) 05:53:53 INFO - PID 9889 | RSS: Main: 162914304 05:53:53 INFO - PID 9889 | 05:53:55 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:55 INFO - PID 9889 | RSS: Main: 163725312 05:53:55 INFO - PID 9889 | 05:53:58 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34779/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:59 INFO - PID 9889 | RSS: Main: 167788544 05:53:59 INFO - PID 9889 | 05:54:03 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34779/tests/kraken/driver.html?testName=imaging-desaturate) 05:54:03 INFO - PID 9889 | RSS: Main: 165134336 05:54:03 INFO - PID 9889 | 05:54:06 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34779/tests/kraken/driver.html?testName=json-parse-financial) 05:54:07 INFO - PID 9889 | RSS: Main: 165576704 05:54:07 INFO - PID 9889 | 05:54:08 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:54:09 INFO - PID 9889 | RSS: Main: 166232064 05:54:09 INFO - PID 9889 | 05:54:11 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:54:11 INFO - PID 9889 | RSS: Main: 165494784 05:54:11 INFO - PID 9889 | 05:54:14 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:54:14 INFO - PID 9889 | RSS: Main: 165838848 05:54:14 INFO - PID 9889 | 05:54:17 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:54:18 INFO - PID 9889 | RSS: Main: 166293504 05:54:18 INFO - PID 9889 | 05:54:21 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:54:21 INFO - PID 9889 | RSS: Main: 166232064 05:54:21 INFO - PID 9889 | 05:54:23 INFO - PID 9889 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34779/tests/kraken/driver.html?testName=ai-astar) 05:54:24 INFO - PID 9889 | RSS: Main: 167309312 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | __start_tp_report 05:54:24 INFO - PID 9889 | _x_x_mozilla_page_load 05:54:24 INFO - PID 9889 | _x_x_mozilla_page_load_details 05:54:24 INFO - PID 9889 | |i|pagename|runs| 05:54:24 INFO - PID 9889 | |0;ai-astar;103;113;112;111;110;113;112;114;113;113 05:54:24 INFO - PID 9889 | |1;audio-beat-detection;153;123;132;179;129;132;123;128;147;123 05:54:24 INFO - PID 9889 | |2;audio-dft;165;165;164;166;165;166;169;168;166;164 05:54:24 INFO - PID 9889 | |3;audio-fft;76;77;75;107;76;76;75;75;95;77 05:54:24 INFO - PID 9889 | |4;audio-oscillator;83;83;102;84;83;83;115;82;83;103 05:54:24 INFO - PID 9889 | |5;imaging-gaussian-blur;114;114;118;114;114;115;115;114;114;120 05:54:24 INFO - PID 9889 | |6;imaging-darkroom;150;150;151;153;151;150;150;150;153;151 05:54:24 INFO - PID 9889 | |7;imaging-desaturate;94;96;95;95;95;94;94;95;94;95 05:54:24 INFO - PID 9889 | |8;json-parse-financial;55;55;57;56;55;55;56;56;55;56 05:54:24 INFO - PID 9889 | |9;json-stringify-tinderbox;55;56;55;55;55;56;58;56;56;55 05:54:24 INFO - PID 9889 | |10;stanford-crypto-aes;81;90;83;84;84;85;83;84;82;83 05:54:24 INFO - PID 9889 | |11;stanford-crypto-ccm;135;145;133;132;134;137;131;138;185;138 05:54:24 INFO - PID 9889 | |12;stanford-crypto-pbkdf2;182;193;195;195;191;198;199;192;197;195 05:54:24 INFO - PID 9889 | |13;stanford-crypto-sha256-iterative;76;75;75;76;74;75;73;75;75;71 05:54:24 INFO - PID 9889 | __end_tp_report 05:54:24 INFO - PID 9889 | __start_cc_report 05:54:24 INFO - PID 9889 | _x_x_mozilla_cycle_collect,780 05:54:24 INFO - PID 9889 | __end_cc_report 05:54:24 INFO - PID 9889 | __startTimestamp1494852864035__endTimestamp 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | ------- Summary: start ------- 05:54:24 INFO - PID 9889 | Number of tests: 14 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.17 (2.8%) stddev-sans-first:1.22 05:54:24 INFO - PID 9889 | Values: 103.0 113.0 112.0 111.0 110.0 113.0 112.0 114.0 113.0 113.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:132.00 stddev:17.96 (13.6%) stddev-sans-first:18.08 05:54:24 INFO - PID 9889 | Values: 153.0 123.0 132.0 179.0 129.0 132.0 123.0 128.0 147.0 123.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 05:54:24 INFO - PID 9889 | Values: 165.0 165.0 164.0 166.0 165.0 166.0 169.0 168.0 166.0 164.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:10.99 (14.5%) stddev-sans-first:11.51 05:54:24 INFO - PID 9889 | Values: 76.0 77.0 75.0 107.0 76.0 76.0 75.0 75.0 95.0 77.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.00 stddev:11.94 (14.4%) stddev-sans-first:12.38 05:54:24 INFO - PID 9889 | Values: 83.0 83.0 102.0 84.0 83.0 83.0 115.0 82.0 83.0 103.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:114.50 stddev:2.10 (1.8%) stddev-sans-first:2.18 05:54:24 INFO - PID 9889 | Values: 114.0 114.0 118.0 114.0 114.0 115.0 115.0 114.0 114.0 120.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 05:54:24 INFO - PID 9889 | Values: 150.0 150.0 151.0 153.0 151.0 150.0 150.0 150.0 153.0 151.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:54:24 INFO - PID 9889 | Values: 94.0 96.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 05:54:24 INFO - PID 9889 | Values: 55.0 55.0 57.0 56.0 55.0 55.0 56.0 56.0 55.0 56.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.95 (1.7%) stddev-sans-first:0.97 05:54:24 INFO - PID 9889 | Values: 55.0 56.0 55.0 55.0 55.0 56.0 58.0 56.0 56.0 55.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:2.42 (2.9%) stddev-sans-first:2.33 05:54:24 INFO - PID 9889 | Values: 81.0 90.0 83.0 84.0 84.0 85.0 83.0 84.0 82.0 83.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:137.50 stddev:16.04 (11.7%) stddev-sans-first:16.88 05:54:24 INFO - PID 9889 | Values: 135.0 145.0 133.0 132.0 134.0 137.0 131.0 138.0 185.0 138.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:195.00 stddev:4.83 (2.5%) stddev-sans-first:2.69 05:54:24 INFO - PID 9889 | Values: 182.0 193.0 195.0 195.0 191.0 198.0 199.0 192.0 197.0 195.0 05:54:24 INFO - PID 9889 | 05:54:24 INFO - PID 9889 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:75.00 stddev:1.51 (2.0%) stddev-sans-first:1.50 05:54:24 INFO - PID 9889 | Values: 76.0 75.0 75.0 76.0 74.0 75.0 73.0 75.0 75.0 71.0 05:54:24 INFO - PID 9889 | -------- Summary: end -------- 05:54:24 INFO - PID 9889 | 05:54:25 INFO - TEST-INFO | 9889: exit 0 05:54:25 INFO - TEST-OK | kraken | took 62730ms 05:54:25 INFO - SUITE-END | took 1182s 05:54:25 INFO - Completed test suite (00:19:42) 05:54:25 INFO - javascript benchmark 05:54:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6764.654122982714, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2711.7694995925344, 2746.58801179823, 2767.142185922363, 2788.079933621905, 2789.790765692572, 5303.522682958533, 5390.78436862525, 5417.729113544322, 5442.863928401792, 5462.617616766833, 5382.300300960879, 5419.458054194579, 5470.124780035195, 5485.451454854512, 5489.752961116749, 4496.213162696531, 4770.0, 4774.80900763969, 4795.064962332347, 4865.318855360252, 4865.927011094836, 4910.533499317577, 4911.968486617815, 4914.1400254955415, 4935.358403407552, 4650.720956742606, 4748.738819364934, 4832.323474713543, 4851.369321988119, 4950.108980383529, 4767.737774422405, 4819.7108173509705, 4836.733979631119, 4860.149473842099, 4877.0489754497885, 4737.194676904935, 4754.904901901978, 4774.307725379836, 4775.761211939389, 4805.231163013901, 5278.261043453919, 5383.73081345935, 5401.243825864382, 5402.8919421611745, 5407.864803379907, 5655.123455864347, 5696.515796157331, 5732.770689172428, 5743.195952566644, 5752.741126649311, 5779.450952159538, 5780.757137215477, 5792.768289268424, 5792.8841423171725, 5799.913001304942, 5267.341582302212, 5315.707636079976, 5328.547073498718, 5357.1696387060065, 5370.543503802142, 5874.853128671817, 5901.793437229677, 5906.143609176645, 5939.4951429129005, 5945.0, 5618.550515958714, 5629.831105066854, 5633.8591535211945, 5639.520640745501, 5640.971795140998, 5744.913826292609, 5769.365369809318, 5812.389699081536, 5857.443542863506, 5897.7935772247765, 5822.941770582324, 5824.592278540462, 5831.3877042910735, 5835.620684655484, 5867.237259156283, 5805.129230615442, 5814.215080964101, 5818.6217895836635, 5820.88358232833, 5836.037053886062, 4712.952870471251, 4761.309610106515, 4793.592544633675, 4846.030793841246, 4847.830325938646, 4176.2691528982305, 4182.372644103348, 4189.05746207107, 4221.936670949877, 4249.426327445817, 4989.650724449254, 5010.69935803853, 5013.89972200554, 5017.209557539825, 5070.391553013662, 5721.684012677108, 5806.1581070744505, 5807.4482924122985, 5922.437368449991, 5937.317208520989, 4899.216125419915, 4907.754612269372, 4915.3855768029, 4916.139675556763, 4944.3572335596145, 5016.147254966664, 5124.5131712488, 5128.256402821645, 5128.769205385766, 5151.922721159186, 5253.553447956967, 5308.150695888639, 5318.016167009116, 5320.547753441001, 5334.359876814807, 5116.820911268088, 5733.02538568436, 5774.56690748204, 5879.323877753942, 5922.5261979040715, 5441.347038355423, 5442.265294185393, 5446.428125046971, 5447.4824891635235, 5481.040817856939, 5640.125780504029, 5684.090545512699, 5717.1995920570325, 5797.1304304353, 5855.648661080349, 5778.711064446845, 5863.530917526502, 5876.647401155944, 5878.500327472213, 5880.411958804086, 5566.165075238747, 5571.860703482445, 5572.721363931868, 5575.8884822304135, 5576.358718747396, 5542.972285138549, 5547.140193270049, 5556.388797232382, 5563.58273129525, 5572.0, 5481.451854814487, 5493.917591236055, 5497.147942068986, 5499.615026948075, 5515.0, 5485.204645326326, 5600.579956503197, 5607.8878422432135, 5613.326400831927, 5630.2680651516675, 4991.975040124777, 5388.191771234189, 5631.8592035199445, 5652.971735141298, 5676.978143934131], "value": 5242.939934848641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.8286894014377, 762.7101701353484, 1062.9202809789263, 1077.288989267084, 1156.3177725142164, 32880.83559582202, 34088.31823363531, 34255.14362140944, 34305.0, 34323.14192145198, 31407.68592314076, 31623.209419764516, 31645.841770791172, 31752.206194845083, 31788.68211317886, 6401.9039714404325, 6513.0, 6515.0227465880025, 6778.525503214777, 6914.274001229874, 6900.171979362483, 6990.231074581792, 6990.405815505688, 6993.720251189946, 6994.230634630212, 6924.272951340113, 6944.826379340507, 6952.374286314231, 6974.476914231427, 7015.789526314194, 6907.6875393675045, 6957.47818913581, 6966.9303306967295, 7001.894971575431, 7016.71933122677, 6875.140607424072, 6914.723411063602, 6928.272531384183, 6951.89572156418, 6965.79102626922, 31521.36957260842, 32009.199770005704, 32170.0, 32175.35649287001, 32189.356212875613, 2926.897558585439, 2947.0422112813208, 2963.229560314312, 2963.4517614241436, 2964.688707685705, 24641.876790616112, 25166.874165629237, 25245.11642092518, 25286.114985975586, 25358.746412535824, 3048.131282584475, 3059.4951832947536, 3072.0476652237653, 3142.5600415941785, 3158.7630927680284, 131963.0, 131981.3400932999, 132042.3397883014, 133032.33483832615, 133787.0, 37939.81030094832, 39388.40917386241, 39615.0, 39729.801350993635, 40103.0, 40425.0, 40606.187876242904, 40744.79627601902, 40909.0, 41014.794926025774, 12977.545785897448, 13093.476260949647, 13093.934530327479, 13098.2141071536, 13118.737625247442, 10309.53607087683, 10381.169506439466, 10413.947930260452, 10448.425336606408, 10466.058054775107, 12640.178388404724, 12728.93635531835, 12775.744485110246, 12797.992471769126, 12909.09636325467, 5135.486451354835, 5163.509466600667, 5352.090144675414, 5359.598030147755, 5366.007288651612, 857.121450513229, 912.762681702762, 920.0569416348296, 921.9262459003263, 945.7730144765206, 20513.435820522434, 21569.67645485319, 21725.239616613344, 21778.128874845144, 21988.34034978953, 986.1420564109128, 993.438707130469, 1003.3377970539555, 1011.4841430870162, 1014.7970405918845, 10881.455927203608, 11236.494357753922, 11462.770744585061, 11513.963743263146, 11646.825297620542, 171355.0, 172744.0, 173900.0, 174117.0, 174894.0, 41009.0, 41162.38256426156, 41233.0, 41244.0, 41398.37902431466, 1189.3280296632374, 1244.4959791284543, 1258.9748205035849, 1261.9810702839466, 1263.8925691316342, 19483.805161948767, 19744.210573224333, 20191.79808201899, 21114.577708446053, 21171.0, 29179.85410072936, 29500.704992949795, 29549.704502954693, 29581.556276655436, 29673.703262967094, 144373.0, 144464.0, 144736.27631861775, 144789.0, 145024.27487862494, 29009.274768130967, 29120.854395727885, 30422.543661844647, 31688.366232674758, 31813.8409307952, 37389.626103738614, 37860.432093518066, 37931.81034094812, 37951.43072853965, 37960.0, 27136.72863271421, 27727.861360693874, 27985.300367490974, 28216.71783282141, 28560.0, 27807.443851122458, 28244.576331354634, 28905.710942890302, 29238.707612923597, 29552.408951821275, 30867.0739877804, 31462.528062079546, 31560.053198404086, 31576.842115789274, 31595.21011974719, 27244.455110898067, 27415.17754467369, 28100.43799124047, 28339.14982550527, 29145.85427072936, 21905.561888762455, 22573.43566410853, 22933.770662293162, 23040.769592303863, 23158.0], "value": 14552.452632727576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.5457887166374, 410.61197168675596, 428.824182085345, 430.6619303846479, 439.1590104949023, 13796.793048104286, 16731.163441827906, 17384.391546295883, 17399.91300043501, 17489.300427982897, 18098.547536311566, 18415.723764143517, 18785.34251301205, 18839.623207535842, 19083.0, 5363.195520671891, 5364.651297665649, 5585.776568937237, 5597.076482380423, 5619.522340601054, 5405.243265942771, 5530.640508366943, 5535.501804837564, 5536.806211782588, 5550.111982082867, 5434.130539113743, 5461.863453413656, 5528.44715528448, 5560.165975103726, 5568.554515638739, 5492.780288788464, 5512.944870551283, 5516.420775818561, 5531.474509921572, 5549.334079910396, 4959.727215003173, 4965.0, 4991.725455099968, 4996.350474438336, 4999.650024498286, 21990.780092199195, 22021.35743710749, 22215.22246721357, 22519.211827585958, 22928.656070158795, 1659.5353301075718, 1680.596656802371, 1685.8314168583165, 1703.4804384662673, 1704.991475042617, 14441.0, 14555.636109097251, 14989.625259368495, 15027.699446011127, 15044.473443429428, 2046.2531176120758, 2108.1462007886676, 2130.5738852229615, 2143.442704896738, 2157.9028943697413, 89328.55335723345, 89380.10619893782, 90279.0, 91363.0, 92248.53875730645, 10937.507812148473, 10960.780784384267, 11027.779444411068, 11046.0, 11212.66362009141, 15273.541793746206, 15408.228053773959, 15461.38154473831, 15464.0, 15478.845211547741, 7845.882311765328, 7852.528848269122, 7886.132525422199, 8096.392770542115, 8099.392545559107, 7258.891116633255, 7293.52592081513, 7462.85074298511, 7516.398688105048, 7537.623118844036, 6940.687669054904, 6973.58158510491, 6995.335443132894, 7036.6481675916, 7045.612491313027, 2038.88786116765, 2061.2476446097066, 2070.513429344103, 2086.728725265736, 2195.83531235158, 842.9157084291522, 872.7425409504084, 875.3434923807145, 888.2716172738293, 906.6735975048977, 17489.56276093108, 17490.475285741195, 17764.822351776318, 18144.461829943033, 18223.45329640113, 857.8798968144465, 871.4640496094983, 874.3922973533333, 883.3286702106317, 903.4263242840843, 9344.813103738023, 9756.414615123116, 9795.167410770022, 9852.852207216898, 9856.162226210852, 375536.0, 388793.0, 393287.0, 393295.0, 393462.0, 77178.0, 78091.0, 78113.6094319536, 78344.0, 78681.60659196667, 1033.7622346860114, 1041.1046500009986, 1072.8712554493354, 1075.4461452352045, 1075.9515821788038, 14882.404703811726, 15051.0, 15104.773428398803, 15390.153541555323, 15704.293306800993, 38089.6191038086, 38960.32476102886, 39225.411618826314, 40236.0, 40937.0, 49084.75457622832, 49094.26358604695, 49155.0, 51500.742496287276, 51906.0, 7878.133405325524, 8024.598770061591, 8029.638666259915, 8154.633041513028, 8330.583470826556, 11534.365609891536, 11716.824247636121, 11852.940735296268, 11989.64031079069, 13087.345632718136, 10148.644797432054, 10238.692839214835, 10524.210684198562, 10537.841932370868, 10643.94678026605, 9903.0, 9999.55002024896, 10161.339512931636, 10359.63741269052, 10772.569097236023, 10125.746856328651, 10732.839007415052, 10930.453477325942, 11078.224524283223, 11202.21584489078, 7677.30904218623, 7697.114831794192, 7906.644201010853, 7933.642986065756, 8148.877766833383, 10395.532201050819, 10434.799998000328, 10766.515506802369, 11054.502547385548, 11081.390523521284], "value": 8837.042478782108, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.9691757706057, 1292.573450761249, 1298.0329654407467, 1303.4720938020105, 1303.7066660001499, 10165.339252948563, 10613.41626210558, 10628.415437150954, 10657.520411581478, 10841.457927103633, 10603.045725884669, 10689.572417103325, 10755.569777208922, 10770.623028194015, 10801.243912926098, 2236.2508559632543, 2265.2184996176375, 2275.419767959168, 2279.133929106937, 2279.3731723776013, 2159.136345461812, 2222.744384395791, 2240.9215677451293, 2244.349138749769, 2250.0999600159985, 2201.2515744646817, 2213.889305534725, 2253.3915842722454, 2254.4363909022745, 2254.9098036078535, 2134.210342173398, 2143.5605700831293, 2174.1629472652985, 2175.401764514755, 2175.771543987882, 2035.369035598969, 2167.6856855755987, 2169.425102347879, 2176.7279090113734, 2179.66215236637, 9985.800283994353, 10104.837943636503, 10106.747331316703, 10109.03964123407, 10113.949430252875, 5693.146028095777, 5840.007198776176, 5858.648481091148, 5878.0, 5891.351951285355, 3174.9682503174904, 3350.849211785451, 3354.446516324828, 3369.0566641340465, 3422.57217847769, 1035.9896401036044, 1042.4162469017374, 1076.6070384309671, 1081.3674000709593, 1098.9010989011028, 15230.695386092328, 15336.23318834065, 15342.463013794575, 15350.462733804263, 15441.768373474295, 4758.0, 4921.834392867127, 5031.169856973558, 5056.772445239973, 5116.0, 11027.503762330714, 11039.39283339408, 11059.447027648584, 11079.279846810094, 11088.112950963903, 5797.971010144923, 5799.304083509922, 5805.6806875621405, 5805.970970145207, 5806.593538452268, 5146.382434107931, 5312.893742125136, 5317.521423071942, 5344.278522399504, 5395.379531353945, 3785.507883975121, 3871.322518559241, 3910.843566257318, 3968.682505399619, 4025.597440255951, 1085.1752667972398, 1088.3198001249218, 1103.4372470040337, 1109.8723646780722, 1126.4255229832845, 689.1454596300651, 720.5100531638536, 731.1920328037548, 739.1056821246244, 742.4617152564348, 5450.591205659592, 5523.917141242885, 5598.776048957996, 5689.573282003867, 5730.541556675456, 531.2509361799844, 552.6214543038031, 555.4445554445555, 557.4230671255232, 570.9115087161497, 3550.7336949728356, 3559.483874838134, 4073.5315438724333, 4108.034611866209, 4177.686673499439, 13181.143225690299, 13642.113262637897, 13663.521776737767, 13729.725405492034, 13735.313234338244, 12910.483580656857, 13494.257815820029, 13521.66195845092, 13531.255780932142, 13534.0, 7512.286332798375, 7588.468807183444, 7650.655720492591, 7658.157602663702, 7674.194209608022, 6231.844203894758, 6388.87222255543, 6469.385408386384, 6494.383033611799, 6637.966810165918, 11729.706757331134, 12111.273323600612, 12163.81754273669, 12334.321612311409, 12428.689282768004, 12213.267203967791, 12318.50725970987, 12525.749485010067, 12540.122191446877, 12624.116311858083, 7975.361971042419, 8161.959190204011, 8165.836683266421, 8166.305864001626, 8197.75406737775, 9587.520623968912, 9596.808063838824, 9626.518674066128, 9760.85358719634, 9837.852432213665, 8155.062167850773, 8330.916690833257, 8341.20758527939, 8374.120717324593, 8629.69796057135, 8259.876101858597, 8331.875021874797, 8342.249197572248, 8370.288525475402, 8381.11998240176, 7408.888866667112, 7422.294881986203, 7596.430267729832, 7644.050767054588, 7681.577513236825, 5339.439358867418, 5347.893042139058, 5387.838364849061, 5456.945430545644, 5467.507924286833, 5567.805126820542, 5669.092945128759, 5758.337791154071, 5869.94130058711, 5878.118282257696], "value": 4773.031045959809, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.84609886896925, 380.6003696119075, 391.9020244938765, 393.91727737175194, 394.18797277608127, 5459.754311056002, 5589.217509548661, 5595.636283641566, 5624.734434752184, 5642.210090587321, 5323.494268044539, 5445.237666726662, 5451.911066699975, 5453.291072160623, 5461.262729531512, 4081.591840815917, 4086.284900142478, 4105.187946256809, 4123.649489793356, 4131.070509135436, 4065.0, 4074.8777536673947, 4081.653059489947, 4140.3168477201225, 4142.420061191436, 4060.066184777503, 4063.2482990646677, 4081.938770918424, 4086.0, 4101.9179616407655, 4076.979615101935, 4082.81627326771, 4085.2850751118435, 4110.650594699454, 4112.856050038235, 3590.6588874056924, 3594.2272411431404, 3594.712423006153, 3597.6402359764074, 3600.873969411084, 5277.815276465343, 5320.397855854697, 5334.946650533522, 5347.839564813023, 5373.361124856917, 4773.665843390964, 4796.8560943171415, 4809.038192361541, 4816.494268101834, 4823.975880120577, 5648.983183027053, 5767.798127065533, 5791.971040144772, 5798.753268047348, 5818.301803783573, 4419.40338054365, 4429.069895321986, 4455.955440445587, 4480.955190448087, 4489.19194544985, 5946.7026648667825, 6087.391260873877, 6154.199954005995, 6228.0, 6299.68501574924, 4310.978445107754, 4319.114581510783, 4330.826766929351, 4341.956580434218, 4342.999999999937, 4393.143337049309, 4402.933955990663, 4403.603675669141, 4404.933925991113, 4423.137488189836, 4953.702777833341, 4991.376077990251, 4996.625253105959, 5139.254808052811, 5189.55888749453, 5850.9414905851245, 5867.530597552186, 5885.0, 5898.911516327258, 5901.262342207224, 1600.2398860541382, 1621.9675606487804, 1622.9350825966828, 1633.7712720219179, 1639.9672006559802, 1136.267107715519, 1171.722822123889, 1173.3546549397797, 1182.4265231362783, 1185.7391373897728, 5059.772310246048, 5078.908034772541, 5096.184610462383, 5102.642815002989, 5123.820666276737, 5937.554683398763, 6030.849228769316, 6059.212302400748, 6069.757209711651, 6070.180525628984, 4968.807596062124, 4994.750262486861, 5080.796768129233, 5093.617978651616, 5112.642115051911, 3147.669494703069, 3215.716841042839, 3220.0822765511716, 3224.548952971172, 3243.0919342584116, 5427.29445172133, 5514.393416724157, 5568.081266591048, 5580.91628625571, 5596.888062238814, 6161.4146656067605, 6174.691265436711, 6190.628562286277, 6195.349488303663, 6200.81397558074, 5465.125579907196, 5561.304836895388, 5567.436840422133, 5573.498385145275, 5593.133064375028, 5949.286085669747, 6010.33886272501, 6014.939850601438, 6051.213342265477, 6055.424734650202, 5732.4267573244015, 5886.763779606331, 5907.2911250650195, 5930.703464826827, 5951.672658003851, 5552.918604825531, 5563.443655634404, 5612.7754889803955, 5624.971875140598, 5633.8309850704545, 4080.3471444568727, 4124.876253712393, 4131.380292956081, 4132.896677583084, 4149.190907772955, 5939.554533409925, 6010.909836352371, 6053.485453736482, 6070.2108725865355, 6104.236970378703, 5808.30300363959, 5808.680522571299, 5839.620424672383, 5857.882842343214, 5887.852803679943, 5652.089174075437, 5814.186013958134, 5834.15404766298, 5835.737391817293, 5847.947369473535, 5674.347450043298, 5718.199452076629, 5778.191053252464, 5787.450192231731, 5789.45000224978, 5878.559108066826, 5890.793822216373, 5895.056790913433, 5896.587238893408, 5904.52763778888, 5534.612577119724, 5673.177389278614, 5729.197912292366, 5729.312482502127, 5772.3650398456975], "value": 4409.051572646939, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.3189378727484, 678.4979115454563, 683.6650041479677, 684.7671791590858, 686.3925425997991, 12414.565490207833, 12716.68208294792, 12784.488620455182, 13485.05604607678, 14304.427822887072, 13817.654558636039, 14062.718745625081, 14150.221737804417, 14354.856451435482, 14364.92817535911, 834.1325021977136, 856.8928883889514, 857.3312816003496, 858.159004175908, 860.4063196394468, 869.5521806269776, 892.0366004714892, 904.4302089683523, 905.4386280506095, 910.0899100899101, 905.782612173077, 933.4166146158651, 936.1013427109982, 937.624950019994, 940.4592359393342, 903.2954295649371, 927.4064598656865, 928.8746019287445, 931.0224264522225, 935.4247138010109, 670.3999920071509, 680.2619158213345, 688.3529482286634, 689.2556039477403, 693.4002088193727, 12328.691782705504, 12689.175203611736, 12852.614421567368, 12930.09489335747, 13986.440542378394, 15647.843521564753, 15701.842981570266, 15822.841771582252, 16089.758653620205, 16142.75785863213, 12014.639560813102, 12153.359296495037, 12287.139900206988, 12300.753984920251, 12319.322437265946, 2866.5413533834485, 2893.3489964757973, 2914.373409716921, 2918.781091418131, 2943.5731818886356, 69933.0, 70736.0, 71640.28359716389, 72299.27700722979, 73088.99999999946, 11417.714557136138, 11600.535978560763, 11778.469968851423, 12383.071269654632, 12514.937425312997, 20195.899020505098, 21593.568128637653, 21728.456788580414, 21855.781442185693, 22102.557948840935, 6048.153258543719, 6186.381361863778, 6285.277193122758, 6286.9056964145575, 6453.548251622436, 3053.6946305369283, 3116.4857798463, 3123.703248191418, 3125.4842950912844, 3131.5928929239053, 3051.893183738603, 3148.307372378073, 3150.6061742282213, 3156.1005113542988, 3168.1762741687326, 729.3217307903594, 740.6000759589762, 740.7962810227231, 746.9290417410338, 749.8537785131956, 591.340655169483, 602.4638072115821, 604.8699529601157, 608.2154021312457, 629.2669040567779, 9038.412503187272, 9649.276304277068, 9675.951620241995, 9770.951145244228, 10281.94859025715, 577.5610535992676, 593.5251798561134, 595.4611076975344, 602.0337358539568, 607.7872744539465, 4301.6773741968855, 4486.842960496367, 4510.932336014962, 4517.2094883395275, 4596.816127354935, 64609.35390646127, 65141.67429162824, 65586.0, 66478.0, 68043.3195668037, 56602.7169864148, 57556.71221643865, 57972.0, 60534.0, 61282.69358653178, 52861.47138528642, 53008.20487692688, 53109.2033619496, 53237.7338113307, 53846.7307663467, 8782.385233033627, 9107.453552786854, 9152.130547597968, 9158.129977652112, 9396.201322887358, 25151.24546263615, 25532.872335638203, 25622.103226386986, 26203.082892098686, 26738.331541711614, 43288.350674739275, 43681.0, 44079.0, 44870.551294487945, 47716.284255735496, 14390.568282951528, 14757.335919883846, 14856.554303370916, 15017.474388396353, 15200.923995379952, 14242.145471271757, 14728.337224825123, 15005.024673396194, 15201.467948621745, 15685.45100921508, 14973.700525989201, 14976.251187440803, 14976.850231497981, 15033.0, 15372.84627153714, 12657.93671031639, 13396.0, 13638.93180534091, 13702.65743356424, 13779.931100344435, 12452.377381130726, 12667.113302069136, 13528.188308701116, 13576.524821631196, 13602.183868967893, 9275.350725449423, 9709.80580388374, 9882.25883058759, 9975.301728878909, 9981.700548983543, 9961.551730172016, 10131.848022279524, 10582.576696932036, 10705.0, 11252.774944501229], "value": 6752.828272257698, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 111.0, 110.0, 113.0, 112.0, 114.0, 113.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 132.0, 179.0, 129.0, 132.0, 123.0, 128.0, 147.0, 123.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 166.0, 165.0, 166.0, 169.0, 168.0, 166.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 107.0, 76.0, 76.0, 75.0, 75.0, 95.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 102.0, 84.0, 83.0, 83.0, 115.0, 82.0, 83.0, 103.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 118.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 120.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 153.0, 151.0, 150.0, 150.0, 150.0, 153.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 56.0, 58.0, 56.0, 56.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 90.0, 83.0, 84.0, 84.0, 85.0, 83.0, 84.0, 82.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 145.0, 133.0, 132.0, 134.0, 137.0, 131.0, 138.0, 185.0, 138.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 193.0, 195.0, 195.0, 191.0, 198.0, 199.0, 192.0, 197.0, 195.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 74.0, 75.0, 73.0, 75.0, 75.0, 71.0], "value": 74.5, "unit": "score"}]}]} 05:54:25 INFO - Return code: 0 05:54:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:54:25 INFO - # TBPL SUCCESS # 05:54:25 INFO - Running post-action listener: _resource_record_post_action 05:54:25 INFO - [mozharness: 2017-05-15 12:54:25.332955Z] Finished run-tests step (success) 05:54:25 INFO - Running post-run listener: _resource_record_post_run 05:54:25 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 383770624; Read time: 16; Write time: 209312 05:54:25 INFO - TinderboxPrint: CPU usage
13.3% 05:54:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:54:25 INFO - TinderboxPrint: I/O write bytes / time
383,770,624 / 209,312 05:54:25 INFO - TinderboxPrint: CPU idle
8,296.2 (86.7%) 05:54:25 INFO - TinderboxPrint: CPU user
1,215.5 (12.7%) 05:54:25 INFO - TinderboxPrint: Swap in / out
0 / 0 05:54:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 102723584; Read time: 0; Write time: 83184 05:54:25 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 281047040; Read time: 0; Write time: 126128 05:54:25 INFO - Running post-run listener: _upload_blobber_files 05:54:25 INFO - Blob upload gear active. 05:54:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:54:25 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 05:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:54:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:54:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:54:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:54:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:27 INFO - (blobuploader) - INFO - Done attempting. 05:54:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:54:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:54:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:31 INFO - (blobuploader) - INFO - Done attempting. 05:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:54:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:31 INFO - (blobuploader) - INFO - Done attempting. 05:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:32 INFO - (blobuploader) - INFO - Done attempting. 05:54:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:54:32 INFO - Return code: 0 05:54:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:54:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:54:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/489ad8718eb666e56ca257f46548dca52fdbdce0d8766aac5632fe9f9f1414a5f5a26ff96100fc4d57234a09c5aed2e9675de7d5879413e9284b36028ea01d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e5d4456b3a7076842411bcc6c20afe53da8d07f0483ea22f9700156bca391b8c63e6cbf631a96b1274fd6a85ce79927e1e437145df737374802aba2ee04d5e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a21979aaceb81a7360719d8c2a8ba255951dccf9d12f7cb9a8718bf5a370fcc211eaf1a2c609b5dc0993b49e2123aec1b17e31dc8ad2a9ea40e13531dd76002", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/105a00ecf232586c244c61fc20adab3a21c2001ff16e7a0ebecbabaec6e9e11125a8aec845183709244c30b463a45b363435212a84b8ac24aab7134e7235feec"} 05:54:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:54:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:54:32 INFO - Contents: 05:54:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/489ad8718eb666e56ca257f46548dca52fdbdce0d8766aac5632fe9f9f1414a5f5a26ff96100fc4d57234a09c5aed2e9675de7d5879413e9284b36028ea01d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e5d4456b3a7076842411bcc6c20afe53da8d07f0483ea22f9700156bca391b8c63e6cbf631a96b1274fd6a85ce79927e1e437145df737374802aba2ee04d5e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a21979aaceb81a7360719d8c2a8ba255951dccf9d12f7cb9a8718bf5a370fcc211eaf1a2c609b5dc0993b49e2123aec1b17e31dc8ad2a9ea40e13531dd76002", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/105a00ecf232586c244c61fc20adab3a21c2001ff16e7a0ebecbabaec6e9e11125a8aec845183709244c30b463a45b363435212a84b8ac24aab7134e7235feec"} 05:54:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:54:32 INFO - Copying logs to upload dir... 05:54:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:54:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.201064 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-15 05:54:32.419271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-15 05:54:32.423746) ========= 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=4300f881736b422476174874000001bc-1494848928.452438-2073740192 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-Non-PGO/sha512/489ad8718eb666e56ca257f46548dca52fdbdce0d8766aac5632fe9f9f1414a5f5a26ff96100fc4d57234a09c5aed2e9675de7d5879413e9284b36028ea01d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e5d4456b3a7076842411bcc6c20afe53da8d07f0483ea22f9700156bca391b8c63e6cbf631a96b1274fd6a85ce79927e1e437145df737374802aba2ee04d5e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a21979aaceb81a7360719d8c2a8ba255951dccf9d12f7cb9a8718bf5a370fcc211eaf1a2c609b5dc0993b49e2123aec1b17e31dc8ad2a9ea40e13531dd76002", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/105a00ecf232586c244c61fc20adab3a21c2001ff16e7a0ebecbabaec6e9e11125a8aec845183709244c30b463a45b363435212a84b8ac24aab7134e7235feec"} build_url:https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/FZfeLPyGR1ujk6QKz6BZJg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/489ad8718eb666e56ca257f46548dca52fdbdce0d8766aac5632fe9f9f1414a5f5a26ff96100fc4d57234a09c5aed2e9675de7d5879413e9284b36028ea01d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e5d4456b3a7076842411bcc6c20afe53da8d07f0483ea22f9700156bca391b8c63e6cbf631a96b1274fd6a85ce79927e1e437145df737374802aba2ee04d5e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a21979aaceb81a7360719d8c2a8ba255951dccf9d12f7cb9a8718bf5a370fcc211eaf1a2c609b5dc0993b49e2123aec1b17e31dc8ad2a9ea40e13531dd76002", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/105a00ecf232586c244c61fc20adab3a21c2001ff16e7a0ebecbabaec6e9e11125a8aec845183709244c30b463a45b363435212a84b8ac24aab7134e7235feec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-15 05:54:32.451868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 05:54:32.452161) ========= 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=4300f881736b422476174874000001bc-1494848928.452438-2073740192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 05:54:32.530910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-15 05:54:32.531203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-15 05:54:32.534519) ========= ========= Total master_lag: 0.18 =========