builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1495553756.0 results: success (0) revision: 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:55.996497) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:55.996929) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:55.997200) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:56.013059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:56.013334) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-23 08:35:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-05-23 08:35:56 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:56.143365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:56.143660) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020877 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:56.195876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-23 08:35:56.196187) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 --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 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 --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=d6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-23 08:35:56,313 truncating revision to first 12 chars 2017-05-23 08:35:56,314 Setting DEBUG logging. 2017-05-23 08:35:56,314 attempt 1/10 2017-05-23 08:35:56,314 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6dfa56094f0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-23 08:35:57,613 unpacking tar archive at: mozilla-central-6dfa56094f0c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.664358 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-23 08:35:57.878499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:57.878781) ========= script_repo_revision: 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:57.879144) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:57.879419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 08:35:57.887807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 12 secs) (at 2017-05-23 08:35:57.888087) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:35:58 INFO - MultiFileLogger online at 20170523 08:35:58 in /builds/slave/test 08:35:58 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 08:35:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:35:58 INFO - {'append_to_log': False, 08:35:58 INFO - 'base_work_dir': '/builds/slave/test', 08:35:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:35:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:35:58 INFO - 'branch': 'Firefox-Non-PGO', 08:35:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:58 INFO - 'config_files': ('talos/linux_config.py',), 08:35:58 INFO - 'default_actions': ('clobber', 08:35:58 INFO - 'read-buildbot-config', 08:35:58 INFO - 'download-and-extract', 08:35:58 INFO - 'populate-webroot', 08:35:58 INFO - 'create-virtualenv', 08:35:58 INFO - 'install', 08:35:58 INFO - 'run-tests'), 08:35:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:58 INFO - 'download_minidump_stackwalk': True, 08:35:58 INFO - 'download_symbols': 'ondemand', 08:35:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:58 INFO - 'gecko_profile': False, 08:35:58 INFO - 'gecko_profile_interval': 0, 08:35:58 INFO - 'installer_path': 'installer.exe', 08:35:58 INFO - 'log_level': 'info', 08:35:58 INFO - 'log_name': 'talos', 08:35:58 INFO - 'log_to_console': True, 08:35:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:35:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:35:58 INFO - 'opt_config_files': (), 08:35:58 INFO - 'pip_index': False, 08:35:58 INFO - 'suite': 'dromaeojs-e10s', 08:35:58 INFO - 'system_bits': '32', 08:35:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:58 INFO - 'title': 'talos-linux64-ix-034', 08:35:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:58 INFO - 'use_talos_json': True, 08:35:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:35:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:58 INFO - 'work_dir': 'build'} 08:35:58 INFO - [mozharness: 2017-05-23 15:35:58.102794Z] Running clobber step. 08:35:58 INFO - Running pre-action listener: _resource_record_pre_action 08:35:58 INFO - Running main action method: clobber 08:35:58 INFO - rmtree: /builds/slave/test/build 08:35:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:35:59 INFO - Running post-action listener: _resource_record_post_action 08:35:59 INFO - [mozharness: 2017-05-23 15:35:59.107201Z] Finished clobber step (success) 08:35:59 INFO - [mozharness: 2017-05-23 15:35:59.107302Z] Running read-buildbot-config step. 08:35:59 INFO - Running pre-action listener: _resource_record_pre_action 08:35:59 INFO - Running main action method: read_buildbot_config 08:35:59 INFO - Using buildbot properties: 08:35:59 INFO - { 08:35:59 INFO - "project": "", 08:35:59 INFO - "product": "firefox", 08:35:59 INFO - "who": "ffxbld@noreply.mozilla.org", 08:35:59 INFO - "installer_path": "public/build/target.tar.bz2", 08:35:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:35:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:35:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:35:59 INFO - "stage_platform": "linux64", 08:35:59 INFO - "basedir": "/builds/slave/test", 08:35:59 INFO - "buildnumber": 624, 08:35:59 INFO - "platform": "ubuntu64_hw", 08:35:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:35:59 INFO - "slavebuilddir": "test", 08:35:59 INFO - "taskId": "fXlFLeavQli7MD6XdoVYlg", 08:35:59 INFO - "branch": "mozilla-central", 08:35:59 INFO - "script_repo_revision": "production", 08:35:59 INFO - "revision": "6dfa56094f0cc291945dd3c24d0a4c2682d80ec7", 08:35:59 INFO - "slavename": "talos-linux64-ix-034", 08:35:59 INFO - "repo_path": "mozilla-central" 08:35:59 INFO - } 08:35:59 INFO - Finding installer, test and symbols from parent task. 08:35:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXlFLeavQli7MD6XdoVYlg'}, attempt #1 08:35:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXlFLeavQli7MD6XdoVYlg'}, attempt #1 08:36:00 INFO - Task dependencies: UMsWKuWATVqMJBAdxe6L0Q 08:36:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q'}, attempt #1 08:36:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.tar.bz2 08:36:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/test_packages.json 08:36:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.crashreporter-symbols.zip 08:36:00 INFO - Running post-action listener: _resource_record_post_action 08:36:00 INFO - [mozharness: 2017-05-23 15:36:00.512195Z] Finished read-buildbot-config step (success) 08:36:00 INFO - [mozharness: 2017-05-23 15:36:00.512508Z] Running download-and-extract step. 08:36:00 INFO - Running pre-action listener: _resource_record_pre_action 08:36:00 INFO - Running main action method: download_and_extract 08:36:00 INFO - mkdir: /builds/slave/test/build/tests 08:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:00 INFO - trying https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.test_packages.json 08:36:00 INFO - Downloading https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:36:01 INFO - Downloaded 989 bytes. 08:36:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:36:01 INFO - Using the following test package requirements: 08:36:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:36:01 INFO - u'common': [u'target.common.tests.zip'], 08:36:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:36:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:36:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:36:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:36:01 INFO - u'mozbase': [u'target.common.tests.zip'], 08:36:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:36:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:36:01 INFO - u'web-platform': [u'target.common.tests.zip', 08:36:01 INFO - u'target.web-platform.tests.tar.gz'], 08:36:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:36:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:36:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.common.tests.zip 08:36:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:36:01 INFO - Fetch https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.common.tests.zip into memory 08:37:08 INFO - Content-Length response header: 63522556 08:37:08 INFO - Bytes received: 63522556 08:37:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:37:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.common.tests.zip 08:37:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:37:19 INFO - Fetch https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.common.tests.zip into memory 08:37:23 INFO - Content-Length response header: 63522556 08:37:23 INFO - Bytes received: 63522556 08:37:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.talos.tests.zip 08:37:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:37:36 INFO - Fetch https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.talos.tests.zip into memory 08:37:49 INFO - Content-Length response header: 14410000 08:37:49 INFO - Bytes received: 14410000 08:37:49 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')]} 08:37:49 INFO - trying https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.tar.bz2 08:37:49 INFO - Downloading https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:38:43 INFO - Downloaded 54965995 bytes. 08:38:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.tar.bz2 08:38:43 INFO - mkdir: /builds/slave/test/properties 08:38:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:38:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:38:43 INFO - Contents: 08:38:43 INFO - build_url:https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.tar.bz2 08:38:43 INFO - Running post-action listener: _resource_record_post_action 08:38:43 INFO - Running post-action listener: set_extra_try_arguments 08:38:43 INFO - [mozharness: 2017-05-23 15:38:43.635139Z] Finished download-and-extract step (success) 08:38:43 INFO - [mozharness: 2017-05-23 15:38:43.635367Z] Running populate-webroot step. 08:38:43 INFO - Running pre-action listener: _resource_record_pre_action 08:38:43 INFO - Running main action method: populate_webroot 08:38:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:38:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:38:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:38:43 INFO - '--tppagecycles', 08:38:43 INFO - '7'], 08:38:43 INFO - 'tests': ['tsvgm']}}, 08:38:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:38:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:38:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:38:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:38:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:38:43 INFO - 'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:38:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:38:43 INFO - 'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['damp', 'tps']}, 08:38:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:38:43 INFO - 'tests': ['damp', 'tps']}, 08:38:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['dromaeo_dom']}, 08:38:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:38:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:38:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:38:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:38:43 INFO - 'tests': ['ts_paint', 'tp5o']}, 08:38:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['a11yr', 08:38:43 INFO - 'ts_paint', 08:38:43 INFO - 'tpaint', 08:38:43 INFO - 'sessionrestore', 08:38:43 INFO - 'sessionrestore_no_auto_restore', 08:38:43 INFO - 'tabpaint']}, 08:38:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:38:43 INFO - 'ts_paint', 08:38:43 INFO - 'tpaint', 08:38:43 INFO - 'sessionrestore', 08:38:43 INFO - 'sessionrestore_no_auto_restore', 08:38:43 INFO - 'tabpaint']}, 08:38:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:38:43 INFO - 'ts_paint', 08:38:43 INFO - 'tpaint', 08:38:43 INFO - 'sessionrestore', 08:38:43 INFO - 'sessionrestore_no_auto_restore', 08:38:43 INFO - 'tabpaint']}, 08:38:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:38:43 INFO - 'ts_paint', 08:38:43 INFO - 'tpaint', 08:38:43 INFO - 'sessionrestore', 08:38:43 INFO - 'sessionrestore_no_auto_restore', 08:38:43 INFO - 'tabpaint']}, 08:38:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['a11yr', 08:38:43 INFO - 'ts_paint', 08:38:43 INFO - 'tpaint', 08:38:43 INFO - 'sessionrestore', 08:38:43 INFO - 'sessionrestore_no_auto_restore', 08:38:43 INFO - 'tabpaint']}, 08:38:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['a11yr', 08:38:43 INFO - 'ts_paint', 08:38:43 INFO - 'tpaint', 08:38:43 INFO - 'sessionrestore', 08:38:43 INFO - 'sessionrestore_no_auto_restore', 08:38:43 INFO - 'tabpaint']}, 08:38:43 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:38:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:38:43 INFO - 'bloom_basic_ref']}, 08:38:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['tsvgx', 08:38:43 INFO - 'tsvgr_opacity', 08:38:43 INFO - 'tart', 08:38:43 INFO - 'tscrollx', 08:38:43 INFO - 'cart', 08:38:43 INFO - 'tsvg_static']}, 08:38:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:38:43 INFO - 'tsvgr_opacity', 08:38:43 INFO - 'tart', 08:38:43 INFO - 'tscrollx', 08:38:43 INFO - 'cart', 08:38:43 INFO - 'tsvg_static']}, 08:38:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:38:43 INFO - 'talos_options': ['--disable-e10s'], 08:38:43 INFO - 'tests': ['tp5o']}, 08:38:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:38:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:38:43 INFO - 'talos_options': ['--disable-e10s', 08:38:43 INFO - '--xperf_path', 08:38:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:43 INFO - 'tests': ['tp5n']}, 08:38:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:38:43 INFO - 'talos_options': ['--xperf_path', 08:38:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:43 INFO - 'tests': ['tp5n']}}, 08:38:43 INFO - 'talos.zip': {'path': '', 08:38:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:38:43 INFO - Running post-action listener: _resource_record_post_action 08:38:43 INFO - [mozharness: 2017-05-23 15:38:43.657790Z] Finished populate-webroot step (success) 08:38:43 INFO - [mozharness: 2017-05-23 15:38:43.657878Z] Running create-virtualenv step. 08:38:43 INFO - Running pre-action listener: _resource_record_pre_action 08:38:43 INFO - Running main action method: create_virtualenv 08:38:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:38:43 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 08:38:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:38:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:38:43 INFO - Using real prefix '/usr' 08:38:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:38:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:38:46 INFO - Installing pip.................done. 08:38:46 INFO - Return code: 0 08:38:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:38:46 INFO - Reading from file tmpfile_stdout 08:38:46 INFO - Output received: 08:38:46 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) 08:38:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:46 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:38:46 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 08:38:46 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 08:38:46 INFO - Using env: {'DISPLAY': ':0', 08:38:46 INFO - 'HOME': '/home/cltbld', 08:38:46 INFO - 'LANG': 'en_US.UTF-8', 08:38:46 INFO - 'LANGUAGE': 'en_US:en', 08:38:46 INFO - 'LOGNAME': 'cltbld', 08:38:46 INFO - 'MAIL': '/var/mail/cltbld', 08:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:46 INFO - 'MOZ_NO_REMOTE': '1', 08:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:46 INFO - 'NO_EM_RESTART': '1', 08:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:46 INFO - 'PWD': '/builds/slave/test', 08:38:46 INFO - 'SHELL': '/bin/bash', 08:38:46 INFO - 'SHLVL': '1', 08:38:46 INFO - 'TERM': 'linux', 08:38:46 INFO - 'TMOUT': '86400', 08:38:46 INFO - 'USER': 'cltbld', 08:38:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:46 INFO - '_': '/tools/buildbot/bin/python'} 08:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:46 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 08:38:46 INFO - Cleaning up... 08:38:46 INFO - Return code: 0 08:38:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:46 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:38:46 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 08:38:46 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 08:38:46 INFO - Using env: {'DISPLAY': ':0', 08:38:46 INFO - 'HOME': '/home/cltbld', 08:38:46 INFO - 'LANG': 'en_US.UTF-8', 08:38:46 INFO - 'LANGUAGE': 'en_US:en', 08:38:46 INFO - 'LOGNAME': 'cltbld', 08:38:46 INFO - 'MAIL': '/var/mail/cltbld', 08:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:46 INFO - 'MOZ_NO_REMOTE': '1', 08:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:46 INFO - 'NO_EM_RESTART': '1', 08:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:46 INFO - 'PWD': '/builds/slave/test', 08:38:46 INFO - 'SHELL': '/bin/bash', 08:38:46 INFO - 'SHLVL': '1', 08:38:46 INFO - 'TERM': 'linux', 08:38:46 INFO - 'TMOUT': '86400', 08:38:46 INFO - 'USER': 'cltbld', 08:38:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:46 INFO - '_': '/tools/buildbot/bin/python'} 08:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:46 INFO - Downloading/unpacking psutil>=3.1.1 08:38:46 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 08:38:46 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 08:38:46 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 08:38:46 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 08:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:38:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:48 INFO - Installing collected packages: psutil 08:38:48 INFO - Running setup.py install for psutil 08:38:48 INFO - building 'psutil._psutil_linux' extension 08:38:48 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 08:38:48 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 08:38:48 INFO - building 'psutil._psutil_posix' extension 08:38:48 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 08:38:48 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 08:38:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:48 INFO - Successfully installed psutil 08:38:48 INFO - Cleaning up... 08:38:48 INFO - Return code: 0 08:38:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:38:48 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')]} 08:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:48 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')]} 08:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:48 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:38:48 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 08:38:48 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 08:38:48 INFO - Using env: {'DISPLAY': ':0', 08:38:48 INFO - 'HOME': '/home/cltbld', 08:38:48 INFO - 'LANG': 'en_US.UTF-8', 08:38:48 INFO - 'LANGUAGE': 'en_US:en', 08:38:48 INFO - 'LOGNAME': 'cltbld', 08:38:48 INFO - 'MAIL': '/var/mail/cltbld', 08:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:48 INFO - 'MOZ_NO_REMOTE': '1', 08:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:48 INFO - 'NO_EM_RESTART': '1', 08:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:48 INFO - 'PWD': '/builds/slave/test', 08:38:48 INFO - 'SHELL': '/bin/bash', 08:38:48 INFO - 'SHLVL': '1', 08:38:48 INFO - 'TERM': 'linux', 08:38:48 INFO - 'TMOUT': '86400', 08:38:48 INFO - 'USER': 'cltbld', 08:38:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:48 INFO - '_': '/tools/buildbot/bin/python'} 08:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:38:48 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 08:38:48 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 08:38:48 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 08:38:48 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 08:38:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:38:49 INFO - Installing collected packages: mozsystemmonitor 08:38:49 INFO - Running setup.py install for mozsystemmonitor 08:38:50 INFO - Successfully installed mozsystemmonitor 08:38:50 INFO - Cleaning up... 08:38:50 INFO - Return code: 0 08:38:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:50 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:38:50 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 08:38:50 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 08:38:50 INFO - Using env: {'DISPLAY': ':0', 08:38:50 INFO - 'HOME': '/home/cltbld', 08:38:50 INFO - 'LANG': 'en_US.UTF-8', 08:38:50 INFO - 'LANGUAGE': 'en_US:en', 08:38:50 INFO - 'LOGNAME': 'cltbld', 08:38:50 INFO - 'MAIL': '/var/mail/cltbld', 08:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:50 INFO - 'MOZ_NO_REMOTE': '1', 08:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:50 INFO - 'NO_EM_RESTART': '1', 08:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:50 INFO - 'PWD': '/builds/slave/test', 08:38:50 INFO - 'SHELL': '/bin/bash', 08:38:50 INFO - 'SHLVL': '1', 08:38:50 INFO - 'TERM': 'linux', 08:38:50 INFO - 'TMOUT': '86400', 08:38:50 INFO - 'USER': 'cltbld', 08:38:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:50 INFO - '_': '/tools/buildbot/bin/python'} 08:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:50 INFO - Downloading/unpacking jsonschema==2.5.1 08:38:50 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 08:38:50 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 08:38:50 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 08:38:50 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 08:38:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:38:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:51 INFO - warning: no files found matching '*.txt' 08:38:51 INFO - no previously-included directories found matching 'build' 08:38:51 INFO - no previously-included directories found matching 'dist' 08:38:51 INFO - no previously-included directories found matching '.git*' 08:38:51 INFO - Installing collected packages: jsonschema, functools32 08:38:51 INFO - Running setup.py install for functools32 08:38:51 INFO - warning: no files found matching '*.txt' 08:38:51 INFO - no previously-included directories found matching 'build' 08:38:51 INFO - no previously-included directories found matching 'dist' 08:38:51 INFO - no previously-included directories found matching '.git*' 08:38:51 INFO - Successfully installed jsonschema functools32 08:38:51 INFO - Cleaning up... 08:38:51 INFO - Return code: 0 08:38:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:38:51 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')]} 08:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:51 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')]} 08:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:51 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:38:51 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 08:38:51 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 08:38:51 INFO - Using env: {'DISPLAY': ':0', 08:38:51 INFO - 'HOME': '/home/cltbld', 08:38:51 INFO - 'LANG': 'en_US.UTF-8', 08:38:51 INFO - 'LANGUAGE': 'en_US:en', 08:38:51 INFO - 'LOGNAME': 'cltbld', 08:38:51 INFO - 'MAIL': '/var/mail/cltbld', 08:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:51 INFO - 'MOZ_NO_REMOTE': '1', 08:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:51 INFO - 'NO_EM_RESTART': '1', 08:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:51 INFO - 'PWD': '/builds/slave/test', 08:38:51 INFO - 'SHELL': '/bin/bash', 08:38:51 INFO - 'SHLVL': '1', 08:38:51 INFO - 'TERM': 'linux', 08:38:51 INFO - 'TMOUT': '86400', 08:38:51 INFO - 'USER': 'cltbld', 08:38:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:51 INFO - '_': '/tools/buildbot/bin/python'} 08:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:38:51 INFO - Cleaning up... 08:38:51 INFO - Return code: 0 08:38:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38:51 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')]} 08:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:51 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')]} 08:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:51 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:38:51 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 08:38:51 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 08:38:51 INFO - Using env: {'DISPLAY': ':0', 08:38:51 INFO - 'HOME': '/home/cltbld', 08:38:51 INFO - 'LANG': 'en_US.UTF-8', 08:38:51 INFO - 'LANGUAGE': 'en_US:en', 08:38:51 INFO - 'LOGNAME': 'cltbld', 08:38:51 INFO - 'MAIL': '/var/mail/cltbld', 08:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:51 INFO - 'MOZ_NO_REMOTE': '1', 08:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:51 INFO - 'NO_EM_RESTART': '1', 08:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:51 INFO - 'PWD': '/builds/slave/test', 08:38:51 INFO - 'SHELL': '/bin/bash', 08:38:51 INFO - 'SHLVL': '1', 08:38:51 INFO - 'TERM': 'linux', 08:38:51 INFO - 'TMOUT': '86400', 08:38:51 INFO - 'USER': 'cltbld', 08:38:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:51 INFO - '_': '/tools/buildbot/bin/python'} 08:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:52 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 08:38:52 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 08:38:52 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 08:38:52 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 08:38:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:53 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 08:38:53 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 08:38:53 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 08:38:53 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 08:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:53 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 08:38:53 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 08:38:53 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 08:38:53 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 08:38:53 INFO - Downloading docopt-0.6.1.tar.gz 08:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:53 INFO - Running setup.py install for blobuploader 08:38:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:38:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:38:53 INFO - Running setup.py install for requests 08:38:54 INFO - Running setup.py install for docopt 08:38:54 INFO - Successfully installed blobuploader requests docopt 08:38:54 INFO - Cleaning up... 08:38:54 INFO - Return code: 0 08:38:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:54 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:38:54 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 08:38:54 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 08:38:54 INFO - Using env: {'DISPLAY': ':0', 08:38:54 INFO - 'HOME': '/home/cltbld', 08:38:54 INFO - 'LANG': 'en_US.UTF-8', 08:38:54 INFO - 'LANGUAGE': 'en_US:en', 08:38:54 INFO - 'LOGNAME': 'cltbld', 08:38:54 INFO - 'MAIL': '/var/mail/cltbld', 08:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:54 INFO - 'MOZ_NO_REMOTE': '1', 08:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:54 INFO - 'NO_EM_RESTART': '1', 08:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:54 INFO - 'PWD': '/builds/slave/test', 08:38:54 INFO - 'SHELL': '/bin/bash', 08:38:54 INFO - 'SHLVL': '1', 08:38:54 INFO - 'TERM': 'linux', 08:38:54 INFO - 'TMOUT': '86400', 08:38:54 INFO - 'USER': 'cltbld', 08:38:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:54 INFO - '_': '/tools/buildbot/bin/python'} 08:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:54 INFO - Running setup.py (path:/tmp/pip-Av_3h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:54 INFO - Running setup.py (path:/tmp/pip-KOYDye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:54 INFO - Running setup.py (path:/tmp/pip-OWwCWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:54 INFO - Running setup.py (path:/tmp/pip-xZFgXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:54 INFO - Running setup.py (path:/tmp/pip-nrBuXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:55 INFO - Running setup.py (path:/tmp/pip-OYBK7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:55 INFO - Running setup.py (path:/tmp/pip-cns__6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:55 INFO - Running setup.py (path:/tmp/pip-nSFgtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:55 INFO - Running setup.py (path:/tmp/pip-AwOYOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:55 INFO - Running setup.py (path:/tmp/pip-EutgBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:55 INFO - Running setup.py (path:/tmp/pip-0YnRSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:55 INFO - Running setup.py (path:/tmp/pip-QveDNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:55 INFO - Running setup.py (path:/tmp/pip-2wsnuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:55 INFO - Running setup.py (path:/tmp/pip-7f_srY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:55 INFO - Running setup.py (path:/tmp/pip-lALAKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:55 INFO - Running setup.py (path:/tmp/pip-u9aZ_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:55 INFO - Running setup.py (path:/tmp/pip-Bu8K_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:55 INFO - Running setup.py install for manifestparser 08:38:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Running setup.py install for mozcrash 08:38:56 INFO - Running setup.py install for mozdebug 08:38:56 INFO - Running setup.py install for mozdevice 08:38:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for mozfile 08:38:56 INFO - Running setup.py install for mozhttpd 08:38:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for mozinfo 08:38:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for mozInstall 08:38:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for mozleak 08:38:56 INFO - Running setup.py install for mozlog 08:38:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for moznetwork 08:38:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for mozprocess 08:38:57 INFO - Running setup.py install for mozprofile 08:38:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:57 INFO - Running setup.py install for mozrunner 08:38:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:57 INFO - Running setup.py install for mozscreenshot 08:38:57 INFO - Running setup.py install for moztest 08:38:57 INFO - Running setup.py install for mozversion 08:38:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:57 INFO - Cleaning up... 08:38:57 INFO - Return code: 0 08:38:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:57 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:38:57 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 08:38:57 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 08:38:57 INFO - Using env: {'DISPLAY': ':0', 08:38:57 INFO - 'HOME': '/home/cltbld', 08:38:57 INFO - 'LANG': 'en_US.UTF-8', 08:38:57 INFO - 'LANGUAGE': 'en_US:en', 08:38:57 INFO - 'LOGNAME': 'cltbld', 08:38:57 INFO - 'MAIL': '/var/mail/cltbld', 08:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:57 INFO - 'MOZ_NO_REMOTE': '1', 08:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:57 INFO - 'NO_EM_RESTART': '1', 08:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:57 INFO - 'PWD': '/builds/slave/test', 08:38:57 INFO - 'SHELL': '/bin/bash', 08:38:57 INFO - 'SHLVL': '1', 08:38:57 INFO - 'TERM': 'linux', 08:38:57 INFO - 'TMOUT': '86400', 08:38:57 INFO - 'USER': 'cltbld', 08:38:57 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:57 INFO - '_': '/tools/buildbot/bin/python'} 08:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:57 INFO - Running setup.py (path:/tmp/pip-OLPeS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:57 INFO - Running setup.py (path:/tmp/pip-eCRKbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:58 INFO - Running setup.py (path:/tmp/pip-dTINWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:58 INFO - Running setup.py (path:/tmp/pip-jS_P5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:58 INFO - Running setup.py (path:/tmp/pip-HLSAIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:58 INFO - Running setup.py (path:/tmp/pip-osfYI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:58 INFO - Running setup.py (path:/tmp/pip-Hwy5_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:58 INFO - Running setup.py (path:/tmp/pip-GXFHnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:58 INFO - Running setup.py (path:/tmp/pip-r6EKNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:58 INFO - Running setup.py (path:/tmp/pip-jmLN2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:58 INFO - Running setup.py (path:/tmp/pip-aSkMCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:58 INFO - Running setup.py (path:/tmp/pip-ccfn3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:58 INFO - Running setup.py (path:/tmp/pip-YULgav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:58 INFO - Running setup.py (path:/tmp/pip-XDQCWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:58 INFO - Running setup.py (path:/tmp/pip-emfGHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:58 INFO - Running setup.py (path:/tmp/pip-f28A4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:59 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)) 08:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:59 INFO - Running setup.py (path:/tmp/pip-pcSvWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:59 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)) 08:38:59 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)) 08:38:59 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)) 08:38:59 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)) 08:38:59 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)) 08:38:59 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)) 08:38:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:00 INFO - Downloading blessings-1.6.tar.gz 08:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:00 INFO - Installing collected packages: blessings 08:39:00 INFO - Running setup.py install for blessings 08:39:00 INFO - Successfully installed blessings 08:39:00 INFO - Cleaning up... 08:39:00 INFO - Return code: 0 08:39:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:00 INFO - Reading from file tmpfile_stdout 08:39:00 INFO - Current package versions: 08:39:00 INFO - argparse == 1.2.1 08:39:00 INFO - blessings == 1.6 08:39:00 INFO - blobuploader == 1.2.4 08:39:00 INFO - docopt == 0.6.1 08:39:00 INFO - functools32 == 3.2.3-2 08:39:00 INFO - jsonschema == 2.5.1 08:39:00 INFO - manifestparser == 1.1 08:39:00 INFO - mozInstall == 1.12 08:39:00 INFO - mozcrash == 1.0 08:39:00 INFO - mozdebug == 0.1 08:39:00 INFO - mozdevice == 0.50 08:39:00 INFO - mozfile == 1.2 08:39:00 INFO - mozhttpd == 0.7 08:39:00 INFO - mozinfo == 0.9 08:39:00 INFO - mozleak == 0.1 08:39:00 INFO - mozlog == 3.4 08:39:00 INFO - moznetwork == 0.27 08:39:00 INFO - mozprocess == 0.25 08:39:00 INFO - mozprofile == 0.28 08:39:00 INFO - mozrunner == 6.13 08:39:00 INFO - mozscreenshot == 0.1 08:39:00 INFO - mozsystemmonitor == 0.3 08:39:00 INFO - moztest == 0.8 08:39:00 INFO - mozversion == 1.4 08:39:00 INFO - psutil == 3.1.1 08:39:00 INFO - requests == 1.2.3 08:39:00 INFO - wsgiref == 0.1.2 08:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:00 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 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:39:00 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 08:39:00 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 08:39:00 INFO - Using env: {'DISPLAY': ':0', 08:39:00 INFO - 'HOME': '/home/cltbld', 08:39:00 INFO - 'LANG': 'en_US.UTF-8', 08:39:00 INFO - 'LANGUAGE': 'en_US:en', 08:39:00 INFO - 'LOGNAME': 'cltbld', 08:39:00 INFO - 'MAIL': '/var/mail/cltbld', 08:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:00 INFO - 'MOZ_NO_REMOTE': '1', 08:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:00 INFO - 'NO_EM_RESTART': '1', 08:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:00 INFO - 'PWD': '/builds/slave/test', 08:39:00 INFO - 'SHELL': '/bin/bash', 08:39:00 INFO - 'SHLVL': '1', 08:39:00 INFO - 'TERM': 'linux', 08:39:00 INFO - 'TMOUT': '86400', 08:39:00 INFO - 'USER': 'cltbld', 08:39:00 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:00 INFO - '_': '/tools/buildbot/bin/python'} 08:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 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)) 08:39:01 INFO - Cleaning up... 08:39:01 INFO - Return code: 0 08:39:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', '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 08:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:39:01 INFO - Using env: {'DISPLAY': ':0', 08:39:01 INFO - 'HOME': '/home/cltbld', 08:39:01 INFO - 'LANG': 'en_US.UTF-8', 08:39:01 INFO - 'LANGUAGE': 'en_US:en', 08:39:01 INFO - 'LOGNAME': 'cltbld', 08:39:01 INFO - 'MAIL': '/var/mail/cltbld', 08:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:01 INFO - 'MOZ_NO_REMOTE': '1', 08:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:01 INFO - 'NO_EM_RESTART': '1', 08:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:01 INFO - 'PWD': '/builds/slave/test', 08:39:01 INFO - 'SHELL': '/bin/bash', 08:39:01 INFO - 'SHLVL': '1', 08:39:01 INFO - 'TERM': 'linux', 08:39:01 INFO - 'TMOUT': '86400', 08:39:01 INFO - 'USER': 'cltbld', 08:39:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:01 INFO - '_': '/tools/buildbot/bin/python'} 08:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:39:01 INFO - Cleaning up... 08:39:01 INFO - Return code: 0 08:39:01 INFO - Running post-action listener: _resource_record_post_action 08:39:01 INFO - Running post-action listener: _start_resource_monitoring 08:39:01 INFO - Starting resource monitoring. 08:39:01 INFO - [mozharness: 2017-05-23 15:39:01.292423Z] Finished create-virtualenv step (success) 08:39:01 INFO - [mozharness: 2017-05-23 15:39:01.292877Z] Running install step. 08:39:01 INFO - Running pre-action listener: _resource_record_pre_action 08:39:01 INFO - Running main action method: install 08:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:01 INFO - Reading from file tmpfile_stdout 08:39:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:01 INFO - Reading from file tmpfile_stdout 08:39:01 INFO - Output received: 08:39:01 INFO - Usage: mozinstall [options] installer 08:39:01 INFO - Options: 08:39:01 INFO - -h, --help show this help message and exit 08:39:01 INFO - -d DEST, --destination=DEST 08:39:01 INFO - Directory to install application into. [default: 08:39:01 INFO - "/builds/slave/test"] 08:39:01 INFO - --app=APP Application being installed. [default: firefox] 08:39:01 INFO - mkdir: /builds/slave/test/build/application 08:39:01 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'] 08:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:39:17 INFO - Reading from file tmpfile_stdout 08:39:17 INFO - Output received: 08:39:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:39:17 INFO - Running post-action listener: _resource_record_post_action 08:39:17 INFO - [mozharness: 2017-05-23 15:39:17.267469Z] Finished install step (success) 08:39:17 INFO - [mozharness: 2017-05-23 15:39:17.267742Z] Running run-tests step. 08:39:17 INFO - Running pre-action listener: _resource_record_pre_action 08:39:17 INFO - Running main action method: run_tests 08:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:17 INFO - Python 2.7.3 08:39:17 INFO - Return code: 0 08:39:17 INFO - grabbing minidump binary from tooltool 08:39: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')]} 08:39:17 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 0x15727a0>, '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 0x15736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1573b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:17 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 08:39:17 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 08:39:17 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 08:39:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:17 INFO - Return code: 0 08:39:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:39:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:17 INFO - ENV: RUST_BACKTRACE is now 1 08:39:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:39:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:17 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/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 08:39:17 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/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 08:39:17 INFO - Using env: {'DISPLAY': ':0', 08:39:17 INFO - 'HOME': '/home/cltbld', 08:39:17 INFO - 'LANG': 'en_US.UTF-8', 08:39:17 INFO - 'LANGUAGE': 'en_US:en', 08:39:17 INFO - 'LOGNAME': 'cltbld', 08:39:17 INFO - 'MAIL': '/var/mail/cltbld', 08:39:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:17 INFO - 'MOZ_NO_REMOTE': '1', 08:39:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:17 INFO - 'NO_EM_RESTART': '1', 08:39:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:17 INFO - 'PWD': '/builds/slave/test', 08:39:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:17 INFO - 'RUST_BACKTRACE': '1', 08:39:17 INFO - 'SHELL': '/bin/bash', 08:39:17 INFO - 'SHLVL': '1', 08:39:17 INFO - 'TERM': 'linux', 08:39:17 INFO - 'TMOUT': '86400', 08:39:17 INFO - 'USER': 'cltbld', 08:39:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929', 08:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:17 INFO - '_': '/tools/buildbot/bin/python'} 08:39:17 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/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 08:39:17 INFO - mozversion application_buildid: 20170523150804 08:39:17 INFO - mozversion application_changeset: 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 08:39:17 INFO - mozversion application_display_name: Nightly 08:39:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:17 INFO - mozversion application_name: Firefox 08:39:17 INFO - mozversion application_remotingname: firefox 08:39:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:39:17 INFO - mozversion application_vendor: Mozilla 08:39:17 INFO - mozversion application_version: 55.0a1 08:39:17 INFO - mozversion platform_buildid: 20170523150804 08:39:17 INFO - mozversion platform_changeset: 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 08:39:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:39:17 INFO - mozversion platform_version: 55.0a1 08:39:17 INFO - using testdate: 1495553957 08:39:17 INFO - actual date: 1495553957 08:39:17 INFO - starting webserver on 'localhost:48372' 08:39:17 INFO - SUITE-START | Running 2 tests 08:39:17 INFO - TEST-START | dromaeo_css 08:39:17 INFO - operating with platform_type : linux_ 08:39:17 INFO - Initialising browser for dromaeo_css test... 08:39:17 INFO - TEST-INFO | started process 5912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_DwOd1/profile http://localhost:48372/getInfo.html) 08:39:18 INFO - PID 5912 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 08:39:22 INFO - PID 5912 | __metrics Screen width/height:1600/1200 08:39:22 INFO - PID 5912 | colorDepth:24 08:39:22 INFO - PID 5912 | Browser inner width/height: 1024/695 08:39:22 INFO - PID 5912 | __metrics 08:39:24 INFO - TEST-INFO | 5912: exit 0 08:39:24 INFO - Browser initialized. 08:39:24 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:24 INFO - TEST-INFO | started process 6073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_DwOd1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:36 INFO - PID 6073 | RSS: Main: 166555648 08:39:36 INFO - PID 6073 | 08:42:41 INFO - PID 6073 | Cycle 1(1): loaded http://localhost:48372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48372/tests/dromaeo/cssquery-ext.html) 08:42:42 INFO - PID 6073 | RSS: Main: 172449792 08:42:42 INFO - PID 6073 | 08:45:44 INFO - PID 6073 | Cycle 1(1): loaded http://localhost:48372/tests/dromaeo/cssquery-ext.html (next: http://localhost:48372/tests/dromaeo/cssquery-jquery.html) 08:45:45 INFO - PID 6073 | RSS: Main: 171417600 08:45:45 INFO - PID 6073 | 08:48:46 INFO - PID 6073 | Cycle 1(1): loaded http://localhost:48372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48372/tests/dromaeo/cssquery-mootools.html) 08:48:47 INFO - PID 6073 | RSS: Main: 173170688 08:48:47 INFO - PID 6073 | 08:51:49 INFO - PID 6073 | Cycle 1(1): loaded http://localhost:48372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48372/tests/dromaeo/cssquery-prototype.html) 08:51:49 INFO - PID 6073 | RSS: Main: 170541056 08:51:49 INFO - PID 6073 | 08:54:52 INFO - PID 6073 | Cycle 1(1): loaded http://localhost:48372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48372/tests/dromaeo/cssquery-yui.html) 08:54:53 INFO - PID 6073 | RSS: Main: 171352064 08:54:53 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | Cycle 1(1): loaded http://localhost:48372/tests/dromaeo/cssquery-yui.html (next: http://localhost:48372/tests/dromaeo/cssquery-dojo.html) 08:57:55 INFO - PID 6073 | RSS: Main: 177635328 08:57:55 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | __start_tp_report 08:57:55 INFO - PID 6073 | _x_x_mozilla_page_load 08:57:55 INFO - PID 6073 | _x_x_mozilla_page_load_details 08:57:55 INFO - PID 6073 | |i|pagename|runs| 08:57:55 INFO - PID 6073 | |0;dojo.html;2708.7697545708616;2731.453709258149;2747.2033110397974;2752.7109653486377;2759.1998320487046;5147.1764517677175;5178.4821517848195;5178.896422071556;5224.738763061846;5236.083685355066;5117.795288188478;5186.429492755794;5224.660397074197;5274.894502109955;5279.313689220396;4480.333668207737;4644.558766917137;4667.813287468497;4670.602998745094;4686.671932964694;4714.387129673155;4726.007538416937;4773.976130119345;4777.402824646919;4786.1863483207935;4591.104734576759;4640.907181856378;4654.394928659286;4689.507601701806;4708.882277943045;4685.601723853442;4689.812407503696;4691.272852707836;4691.859244222679;4726.787294571753;4629.097326021427;4643.4660014098135;4647.4190726158895;4669.859904202879;4681.625469962429;5126.282320475137;5176.844694659167;5180.430152683201;5223.6343455958095;5231.24146998683;5563.720344320788;5596.524295434852;5608.775648974036;5613.354464236624;5627.915581266243;5631.971840140773;5649.604527683023;5653.604247702662;5665.943340566624;5670.376258611549;5192.4547922468355;5247.475252474722;5256.474352564789;5260.000599886048;5279.788808447696;5737.483626473638;5847.883042339129;5896.410358964069;5901.468867801918;5918.171455996164;5532.474414930575;5563.443655634485;5587.580931430159;5592.888142237214;5604.047311956977;5557.749901254453;5606.24315717373;5618.634788738719;5625.521830644359;5706.771729130788;5528.44715528444;5552.806146678484;5566.109422492382;5599.776008959596;5619.072852979212;5537.252470916455;5542.8337149885565;5553.611247212656;5556.749946252428;5560.805371811967;4664.137134630104;4705.270683044134;4725.787339569659;4728.621710263171;4768.094062128184;3995.940060899031;4025.939610905839;4074.246264441088;4099.159672267178;4099.8975025624595;4784.40194975628;4787.880302992453;4789.257665061921;4798.5441383068555;4824.951750482521;5592.692401917852;5686.744096515667;5698.572607054488;5729.2265544151005;5762.683052432157;4701.459332176843;4724.858254252309;4756.405449318835;4774.331593576902;4788.449328327218;5023.497650234947;5024.824131155392;5025.120603894304;5027.120253955543;5066.518680725325;5204.089284375219;5204.895902082013;5211.9478805211465;5216.452272511332;5217.50433708797;5480.588955828249;5555.833325000256;5607;5705.144228365612;5719.5710321726865;5188.092083885381;5197.116490196751;5206.8958620828125;5223.033738758342;5260.815871444481;5565.860853478695;5576.9163462547285;5591.720413979204;5595.496405323541;5623.325200975745;5594.216809646734;5614.466625670555;5651.689157096399;5689.573282003949;5730.369659337386;5491.121420572849;5516.558675306046;5518.199861020049;5543.501084902378;5580.079286917613;5385.057614917452;5482.753276102505;5485.122380419114;5490.258815059916;5510.3938566758425;5332.06688829461;5353.009693206769;5391.433899440659;5434.184872269191;5456.7544460498575;5507.752151153288;5510.421405752339;5510.531604813636;5537.889242215214;5558.944410556004;5348.384935732285;5350.946490535045;5376.784928602969;5383.919241211307;5392.245085687929 08:57:55 INFO - PID 6073 | |1;ext.html;631.9304876463589;668.121420332263;687.8314812870846;1193.123054554902;1195.515816094481;33138.17154571134;33797.78921002507;33834.15414614633;34061;34336;31964.360712785787;32021.519677204862;32097.35805283893;32135.19662008445;32425.189370265754;6416.999999999988;6497.285298617148;6503.317151699074;6505.967470162643;6514.2508611509575;6440.710168042426;6445.967770161143;6483.4489068429;6492.026196070604;6554.606723596576;6525.086487891699;6635.303293154222;6783.559068660546;6787;6804.047433359309;6724.125863637721;6749.595024298534;6761.966190169067;6806.965965170167;6825.590464572141;6815.863682726318;6845.691943862538;6878.55289406192;6897.448204143657;6897.48268879836;31541.52687709686;31721.20696982594;31818.363632727214;31875.203119921956;31935.361292774247;2685.3957859481657;2706.5534186859145;2721.4012917158193;2725.223311356274;2728.4133911209187;23946.880265598735;23984;24153.87923060391;24219.273421797374;24297.878510607512;2983.612130423031;2984.567237750514;2991.356858275481;2993.4162838246552;3001.039667306463;142556;142967;143589.2820535901;155437.22281388633;157493.2125339366;38177.23645527074;38542.80728596395;38567.42148867769;38573.42139867904;38627;40117.39530418809;40227;40302.19395612071;40312.56561778202;40427.59572404297;11924.642260732191;11987.520499179935;12003.459844307026;12043.638690839114;12153.878461215452;9700.27247956406;9742.464164471023;9751.561179746928;9796.069373409515;9812.852807207897;12218.633440996784;12268.877311226952;12369.505219791108;12369.814452783216;12505.312207828474;5208.635395522277;5262;5274.736263186825;5300.363956325188;5308.708021058802;872.3152325424511;888.5157589113949;891.6656253904786;908.6683360573343;936.9297302702324;20503.69244461334;21137.577248454945;21160.14531594293;21175.68236476454;21663.45841353979;967.1778987860403;968.6803354893009;988.6885631026347;994.7363948553639;1007.8185926533295;10752.892471075189;11215.383153926612;11248.381339026268;11293.435328233556;11297.774044519063;185366;186042;186093;186883;187548;38595.2280954385;38920.22159556793;39116.41325380121;39270;39511.209775804324;1177.31127290536;1215.775081609905;1222.584321330752;1224.2287358963974;1235.6416639174718;19470.415887523395;19835.30576429818;19956.60086798227;21049.263275785273;23929.760702392752;36910.26179476449;37418.43872341863;37558.43662345012;37900;38685.41971870368;162714.1864290671;163618;164896;164981;164988.17505912393;28433.43133137284;29325.26686832846;29742.958996435886;29896.850515747283;29996;35093.03763387325;35237.82381088078;35296.47055294224;36093.63906360903;36324;27029;27472.862635686695;27809.582856257577;27928.30179245535;29077;26872.32819179536;27169.320766980985;27565.17304480869;27781.305467363476;28702.56946145768;29871.253218669706;30469.847650761603;30522.389552208388;30927.226819329695;30937.535936960514;26675.733242668102;26924.192274231806;27138.32154196161;27591.31021724473;27971.300717482227;20256.79743202549;22871.348046999206;22980.54038919179;23010.654840177747;23418.64872026955 08:57:55 INFO - PID 6073 | |2;jquery.html;386.3297179393753;389.7973054011914;392.11577891853864;397.3681845865074;410.3106780608578;12765.297908615023;15590.688186236268;16661.66676666466;17209.7418538722;17213.569660758487;17727.55681107973;17944.820551794477;18099.366522171727;18168.63662726748;18176.545586360313;5223.738813059351;5353.116735738598;5430.945690543103;5554.583406244527;5581.776728930838;5404.189371594272;5428.83713488596;5435.93999170162;5461.317335333083;5465.289512363387;5289.814856480024;5323.574114070884;5323.973380133113;5398.406175320732;5429.239906413086;5314;5318.46815318467;5328.653637513568;5350.678959262456;5371.167469042285;4666.626669866402;4780.330753694486;4794.640401969831;4804.951950480486;4841.7337046462435;20758.896205519028;20896;20965.5806883863;21000.684989725167;21257.8937105315;1624.3340230505437;1638.942637007699;1655.7764701765348;1656.3788579282768;1657.7264751316018;13506.459741610324;13932.164070155723;14135.15189088658;14405.85594144066;14593.927030364886;1944.36808037387;2001.2495314257153;2021.353166986565;2038.5617092325222;2040.4286799696108;83323.5833820833;85959.57020214859;87764;88311;89825.55087224588;10189.949050254701;10378.169746420419;10402.58389664405;10429.791404172025;10583.206259530565;13391.330433478288;13622.161008263758;13791.689994401271;13804.723905522034;13849.238291894042;7007.649617519103;7041.471889608198;7237.335412854967;7270.745523906638;7272.527285726516;6550.246721627074;6560.671966401756;6634.568753031134;6811.080504131978;6820.931790682129;6586.209654841354;6613;6663.900041499382;6737.326267373322;6838.350356716104;1971.7204626838234;1983.8611297209056;2026.797320267991;2046.6213750456213;2134.8612340198147;836.1220718245818;866.8569686001865;870.2863651805459;874.1302404107953;902.1294450854825;16030.919845400698;16173.757393639105;16639.916800415922;16738.4141555045;16925.492235232963;868.4745728834091;876.5310558850985;878.4948654523674;878.5547773912007;884.5798245833178;8887.422317549339;9270.814583708423;9342.439453632804;9423.858642120374;9446.291528135418;344986;375823;381873;384149;388142;79307;80355.19644803595;81147.59426202832;82055.58972205101;84657.15342846616;1065.5631191211567;1079.3901445683164;1120.9943950280197;1123.393367581497;1124.9100071994221;16408.589785255463;16649.750253745962;17225.138743063046;17291.56771080733;17504.299828007246;38814.41778373383;39152.608473916036;39261.41107883327;39771;39998;49129.50870491249;49591;49712.751436242586;49932;49957.50042499528;7825.530468171928;7849.921500785147;7939.166387529226;8023.518588884685;8063.596820159086;12317.75364492723;12513.687157821127;12523.812142818048;12794.68013299675;12805.167664101804;10141.543630536496;10397.16822654201;10519.631812886511;10650.786984260427;10930.344179349264;10508.789824203626;10635.89364106349;10638.89361106379;10777.407242601732;10801.513931872927;11496.425178740863;11683.474243659226;11750.58872939443;11872.525098995944;12059.51761929513;7640.847183056197;7805.921940780519;7846.960765196138;7900.091489478784;8215;10530.104941080093;10880.727981800203;11006.009459148716;11020.724481888017;11322.37726925027 08:57:55 INFO - PID 6073 | |3;mootools.html;1212.0969877441305;1244.4835393311776;1269.289198049093;1272.1985149355905;1279.1813239526698;9652.42085474871;9712.077352651488;10037.749056273587;10094.596216151345;10278;10116.443595602239;10299.53652085656;10323.12253458455;10327.741806454842;10362.740931476717;2251.6509940959177;2283.1438210671;2289.404754763765;2291.9885400572975;2293.0483849202647;2184;2235.7093577834858;2242.876641784709;2245.5621153875;2246.494538728781;2241.1483636218213;2246.269962262263;2288.7596802335765;2290.7594702556244;2300.148944890393;2093.6859471079306;2154.192177933275;2186.2348178137686;2193.0898677049004;2204.9669254961186;2040.9081591328427;2128.372130221588;2163.3077415227135;2186;2189.200941656284;9778.608855645765;9875.506224688737;9889.159421449185;9897.257705672104;9919.851202231972;5203.713795741232;5329.920051199235;5352.197170424429;5361.169018802092;5383.703896285702;3136.5138403547485;3329.300846822146;3399.1502124468884;3403.523506709038;3411.1472131967007;1020.7805321855836;1032.917366610677;1047.9109275711573;1088.7332603512111;1090.0244281368211;14367.784483232655;14503.782443263359;14504.202268875208;14515.346809393497;14544.490942817056;4346.673999450054;4418.403515525427;4517.93828450314;4604.861854144381;4643.791029403685;10449.529771160316;10453.425061621683;10477.10944569705;10519.579216831242;10530.10494107994;5295.4969277918535;5309.150535914235;5332.200169974535;5335.493128152819;5338.039152952506;4816.567633345138;4823.710577365369;4874.707517548887;4977.751112444364;5013.423456302499;3608.9458658120147;3632.5822530408814;3674.1733110050027;3744.64425879541;3756.1736417988;1036.108946306176;1036.5387402605918;1048.114343379843;1051.6161601015574;1052.9157667386592;629.6536904702396;660.6993817812884;662.9734810607619;663.3101574362609;664.92353379362;4890.799140386769;4899.902001959941;4934.062528119646;4958.851234462972;5036.546710796046;523.1786095829511;527.5673947363202;534.7593582887716;535.7910414938177;545.5499213149168;3540.8406621702084;3603.3513967486106;3671.706263498914;3683.1896982664307;3809.4285857121654;12319.199252048587;13022.153560018569;13028.80456793149;13045.608631741063;13162;12513;12672.366381680878;12904.548340808027;13034.674133146747;13071.215727056217;7273.745418910313;7437.925620743723;7445.9627701861145;7451.664675089634;7494.475386722877;5600.327960644749;5861.794837180678;5986.820395388146;6055.788047418319;6197.03945888388;11150.665480035612;11575.131865109983;11696.239744416585;11749.060075193793;11968.102392320438;11474.212098469727;11799.35103569312;11850.525978960744;11862;11865.11011674145;8110.635021423932;8187.426880118334;8294.9631296088;8314.293285070595;8356.498610083414;8834.955825220834;9374.250059995047;9516.524173791422;9518.762030949281;9597.9040209597;8090.676372945016;8100;8187.181281872004;8191.426600137933;8510.74467765968;7722.266384693445;7902.525848449111;8003.919960800317;8092.473989190684;8240.711575094843;6706.530542862148;6751.93248067513;6785.5250132490255;6789.558678685869;6797.864042719217;4626.560476754703;4724.503927087606;4826.251930950708;4830.106430310404;4888.9755551222015;4982.202847544376;4989.326440930428;5030.773615187252;5067.746612669278;5094.235864620188 08:57:55 INFO - PID 6073 | |4;prototype.html;369.890882189754;378.4266835743847;385.7878167008145;391.77864506553794;393.64571885303235;5517.724113794315;5537.861553461165;5560.388357280696;5561.193626924093;5581.274434323543;5335.359756829176;5342.545883599899;5355.946440535594;5424.159255315422;5450.91823622646;4240.872773816775;4247.638950689196;4253.723507971979;4256.829726810924;4263.424437700902;4261.509926358477;4280.336547835091;4280.336547835091;4280.443542339507;4281.7002809803325;4176.561461046592;4255.191513612419;4258.552851950547;4262.78686065697;4264.5095813981325;4227.852025179135;4229.788510574459;4239.427677263576;4254.468191476066;4265.125649241913;3809.5428548574073;3810.580836108026;3813.809309534512;3822.3502004659276;3830.731848770587;5220.608454365938;5365.704886231256;5376.354837419534;5396.9730151348995;5410.945890541084;4977.850664480072;4979.253112033188;5037.697738135724;5054.671446355975;5056.367954005749;5813.360530341659;5815.912761308584;5823.854403639901;5826.854328641775;5841.532677385841;3824.694024478035;3984.5417776955733;4268.103698223377;4277.165952639237;4279.838681465871;5933.851653708649;6168.475679567242;6176.938230617726;6190.1952746142715;6203.348648391944;4029.5768944261017;4061.411095391211;4069.491313585802;4076.9796151019054;4080.489938757655;4139.689523285705;4140.91718165635;4161.812718427678;4170.749755014709;4179.853705120367;4742.775302037573;4781.569658730731;4816.975915120472;4822.855314340575;4832.758362081881;5845.240118784616;5854;5855.560832937546;5858.623223542464;5891.1457838614015;1426.3795249066482;1432.957011289663;1433.2045714628273;1434.8421673615894;1437.0300047467917;900.8243392538524;936.8032713130183;949.4350861237552;958.7075941837667;959;4965.808206030527;4979.726115063706;4985.925211121764;5011.924821127686;5036.093503169464;6049.21360223177;6052.727627256784;6061.636301821904;6064.877997570376;6068.787592434332;4843.2735089736825;4959.603231741452;5018.673786203958;5027.572656324253;5045.369328833895;3206.342699746593;3219.388316219911;3233.935321293561;3240.189952511872;3243.772935894512;5347.572194224453;5582.162675598693;5605.80379686709;5606.103023516218;5614.69119198448;6224.439800417984;6270.028145637433;6285.842853928689;6288.779892703734;6332.461740752087;5632.295963004624;5635.12655538384;5640.943590564124;5653.265075540154;5661.858453538694;5882.970375220542;6055.455009049207;6108.083787431743;6128.111423843428;6156.384361563808;6031.336552979256;6031.879362412815;6034.09488576717;6044.576879618385;6055.939440605537;5431.972840135774;5543.1685247213245;5618.353889302619;5621.353544342453;5643.576731745217;4105.815238314342;4128.195001974586;4129.442525259172;4142.647874930664;4156.418101465858;5983.521318294613;6116.418940200674;6136.140940268277;6136.785212517719;6143.293521245114;5849.707514624337;5854.853628659318;5865.266841644794;5878.648540583629;5897.321807991964;5855.94144058554;5884.411558844081;5918.644881306963;5933.436323549256;5933.851653708692;5747.683877386784;5771.278590176228;5793.073108302651;5842.766289348378;5851.327097383855;5893.469587737124;5954.851128721643;5966.134910437875;5983.640981541122;5987.31145918225;5668.5465162787705;5729.885402292014;5759.280089988752;5760.481556659921;5767.788764359531 08:57:55 INFO - PID 6073 | |5;yui.html;660.3561527510681;680.8331958670124;733.0214164090938;736.2085757810354;769.0655853138437;11903.702407439818;12231.694207644803;12329.691757706061;13799;13970.37133329;14274.214918179496;14310.856891431082;14355.856441435608;14426.35081421336;14693.706125877476;834.0866750907746;841.949483031017;845.4927043773748;846.5132548784443;847.8134810341714;904.7376260884336;906.4742449379344;906.5467266366817;908.0193391137556;911.2709832134266;919.0855099176329;927.7309580221728;928.9721308360727;929.8465753150722;931.6366617019368;915.3318077803208;918.6600957645713;921.5530467723216;923.3029063057382;928.1785619726556;684.6029303004245;685.0443631134589;690.2958981838497;691.6126968897433;693.6323748413349;13456.327183640877;13578.25319607431;13587.252701101435;13711.314434278247;13904.721905561933;14372.281385930766;14459.638509037253;14730.337134828958;14739.92630036843;14751.70496590073;11724.882751172465;11917.404129793562;11959.222650527689;12052.698682532919;12061.457234424472;2912.1700315410008;2927.8096923700105;2929.545920382323;2936.207224049516;2937.588737576741;69443.65278173628;71720.6413967932;71964.64017679878;72054.27945720528;72791.27208727898;10529.157667386591;11034.172437067253;11143.164262680331;11160.609378671708;11178.490903728056;19667;20148.39554813358;20858.269960551308;20961.68557471639;21093.261735839173;6070.3929607038945;6235.719392627343;6256.874862502816;6344.080108384258;6411.775587854496;2875.9424811503654;2914.9943269571963;2933.779966502478;2936.1778701963485;2937.4418860416454;3266.248762784573;3351.3464874349756;3352.8994130176134;3352.983235083858;3358.5633867597057;695.0720787748312;712.6116266634697;728.2644529025616;730.7844185965153;734.8089496730888;575.2952633024595;582.2866987939825;588.0532342927883;589.1163255117324;605.1769593353036;9516.33385662997;9980.850287245697;9996.000399959947;10051.296409251428;10073.1437827784;584.5153310591136;590.1236663554618;606.7936901453438;613.9662318572432;636.4208570201095;4089.2230476209425;4491.214037543416;4492.438445194351;4583.816647334136;4620;55688.72155639196;56426.71786641041;56937.43062569321;57975.71012144996;59671.10493342603;48997;49504;49866;50171.74914125406;50929.490705093216;46173.76913115413;46682.29976550354;46703.29945050827;46856.5314346859;46859.76570117127;10197.9490102549;10384.792304153723;10521.842172367267;10885.836712449478;10888.40113793749;24131.758682413652;24468.14361497339;24760.25719228426;25247.495050099264;25752.484950301263;29981.250468737584;30091;30262.243443914078;30898;42634.57365426306;13034.47862085506;13114.60656180316;13382.130161539859;13459.192448453125;13499.595012149652;14748.557543273719;15075.623109422353;15161.696766064397;15259;15445.691086178438;13590.116642418212;13700.177989320673;13750.174989500261;13915.025948183935;14027.579172624837;13633.113847599874;13738.244396557886;13762.449502019806;13925.234112123526;14099;12795.488180472677;13396.531121410704;13742.587722368346;13833;13975.301234938415;10280.280380373302;10629.840552391875;10735.785284294427;10927.508262128382;11296.43517824089;10945.398003109905;11502.53989840397;11630.825537616773;11644.767104658029;11705.414729263674 08:57:55 INFO - PID 6073 | __end_tp_report 08:57:55 INFO - PID 6073 | __start_cc_report 08:57:55 INFO - PID 6073 | _x_x_mozilla_cycle_collect,273 08:57:55 INFO - PID 6073 | __end_cc_report 08:57:55 INFO - PID 6073 | __startTimestamp1495555075519__endTimestamp 08:57:55 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | ------- Summary: start ------- 08:57:55 INFO - PID 6073 | Number of tests: 6 08:57:55 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | [#0] dojo.html Cycles:165 Average:5152.87 Median:5274.89 stddev:600.91 (11.4%) stddev-sans-first:571.35 08:57:55 INFO - PID 6073 | Values: 2708.8 2731.5 2747.2 2752.7 2759.2 5147.2 5178.5 5178.9 5224.7 5236.1 5117.8 5186.4 5224.7 5274.9 5279.3 4480.3 4644.6 4667.8 4670.6 4686.7 4714.4 4726.0 4774.0 4777.4 4786.2 4591.1 4640.9 4654.4 4689.5 4708.9 4685.6 4689.8 4691.3 4691.9 4726.8 4629.1 4643.5 4647.4 4669.9 4681.6 5126.3 5176.8 5180.4 5223.6 5231.2 5563.7 5596.5 5608.8 5613.4 5627.9 5632.0 5649.6 5653.6 5665.9 5670.4 5192.5 5247.5 5256.5 5260.0 5279.8 5737.5 5847.9 5896.4 5901.5 5918.2 5532.5 5563.4 5587.6 5592.9 5604.0 5557.7 5606.2 5618.6 5625.5 5706.8 5528.4 5552.8 5566.1 5599.8 5619.1 5537.3 5542.8 5553.6 5556.7 5560.8 4664.1 4705.3 4725.8 4728.6 4768.1 3995.9 4025.9 4074.2 4099.2 4099.9 4784.4 4787.9 4789.3 4798.5 4825.0 5592.7 5686.7 5698.6 5729.2 5762.7 4701.5 4724.9 4756.4 4774.3 4788.4 5023.5 5024.8 5025.1 5027.1 5066.5 5204.1 5204.9 5211.9 5216.5 5217.5 5480.6 5555.8 5607.0 5705.1 5719.6 5188.1 5197.1 5206.9 5223.0 5260.8 5565.9 5576.9 5591.7 5595.5 5623.3 5594.2 5614.5 5651.7 5689.6 5730.4 5491.1 5516.6 5518.2 5543.5 5580.1 5385.1 5482.8 5485.1 5490.3 5510.4 5332.1 5353.0 5391.4 5434.2 5456.8 5507.8 5510.4 5510.5 5537.9 5558.9 5348.4 5350.9 5376.8 5383.9 5392.2 08:57:55 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | [#1] ext.html Cycles:180 Average:30912.97 Median:30724.81 stddev:43176.21 (140.5%) stddev-sans-first:43237.45 08:57:55 INFO - PID 6073 | Values: 631.9 668.1 687.8 1193.1 1195.5 33138.2 33797.8 33834.2 34061.0 34336.0 31964.4 32021.5 32097.4 32135.2 32425.2 6417.0 6497.3 6503.3 6506.0 6514.3 6440.7 6446.0 6483.4 6492.0 6554.6 6525.1 6635.3 6783.6 6787.0 6804.0 6724.1 6749.6 6762.0 6807.0 6825.6 6815.9 6845.7 6878.6 6897.4 6897.5 31541.5 31721.2 31818.4 31875.2 31935.4 2685.4 2706.6 2721.4 2725.2 2728.4 23946.9 23984.0 24153.9 24219.3 24297.9 2983.6 2984.6 2991.4 2993.4 3001.0 142556.0 142967.0 143589.3 155437.2 157493.2 38177.2 38542.8 38567.4 38573.4 38627.0 40117.4 40227.0 40302.2 40312.6 40427.6 11924.6 11987.5 12003.5 12043.6 12153.9 9700.3 9742.5 9751.6 9796.1 9812.9 12218.6 12268.9 12369.5 12369.8 12505.3 5208.6 5262.0 5274.7 5300.4 5308.7 872.3 888.5 891.7 908.7 936.9 20503.7 21137.6 21160.1 21175.7 21663.5 967.2 968.7 988.7 994.7 1007.8 10752.9 11215.4 11248.4 11293.4 11297.8 185366.0 186042.0 186093.0 186883.0 187548.0 38595.2 38920.2 39116.4 39270.0 39511.2 1177.3 1215.8 1222.6 1224.2 1235.6 19470.4 19835.3 19956.6 21049.3 23929.8 36910.3 37418.4 37558.4 37900.0 38685.4 162714.2 163618.0 164896.0 164981.0 164988.2 28433.4 29325.3 29743.0 29896.9 29996.0 35093.0 35237.8 35296.5 36093.6 36324.0 27029.0 27472.9 27809.6 27928.3 29077.0 26872.3 27169.3 27565.2 27781.3 28702.6 29871.3 30469.8 30522.4 30927.2 30937.5 26675.7 26924.2 27138.3 27591.3 27971.3 20256.8 22871.3 22980.5 23010.7 23418.6 08:57:55 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | [#2] jquery.html Cycles:180 Average:24906.07 Median:213478.21 stddev:62535.03 (29.3%) stddev-sans-first:62683.36 08:57:55 INFO - PID 6073 | Values: 386.3 389.8 392.1 397.4 410.3 12765.3 15590.7 16661.7 17209.7 17213.6 17727.6 17944.8 18099.4 18168.6 18176.5 5223.7 5353.1 5430.9 5554.6 5581.8 5404.2 5428.8 5435.9 5461.3 5465.3 5289.8 5323.6 5324.0 5398.4 5429.2 5314.0 5318.5 5328.7 5350.7 5371.2 4666.6 4780.3 4794.6 4805.0 4841.7 20758.9 20896.0 20965.6 21000.7 21257.9 1624.3 1638.9 1655.8 1656.4 1657.7 13506.5 13932.2 14135.2 14405.9 14593.9 1944.4 2001.2 2021.4 2038.6 2040.4 83323.6 85959.6 87764.0 88311.0 89825.6 10189.9 10378.2 10402.6 10429.8 10583.2 13391.3 13622.2 13791.7 13804.7 13849.2 7007.6 7041.5 7237.3 7270.7 7272.5 6550.2 6560.7 6634.6 6811.1 6820.9 6586.2 6613.0 6663.9 6737.3 6838.4 1971.7 1983.9 2026.8 2046.6 2134.9 836.1 866.9 870.3 874.1 902.1 16030.9 16173.8 16639.9 16738.4 16925.5 868.5 876.5 878.5 878.6 884.6 8887.4 9270.8 9342.4 9423.9 9446.3 344986.0 375823.0 381873.0 384149.0 388142.0 79307.0 80355.2 81147.6 82055.6 84657.2 1065.6 1079.4 1121.0 1123.4 1124.9 16408.6 16649.8 17225.1 17291.6 17504.3 38814.4 39152.6 39261.4 39771.0 39998.0 49129.5 49591.0 49712.8 49932.0 49957.5 7825.5 7849.9 7939.2 8023.5 8063.6 12317.8 12513.7 12523.8 12794.7 12805.2 10141.5 10397.2 10519.6 10650.8 10930.3 10508.8 10635.9 10638.9 10777.4 10801.5 11496.4 11683.5 11750.6 11872.5 12059.5 7640.8 7805.9 7847.0 7900.1 8215.0 10530.1 10880.7 11006.0 11020.7 11322.4 08:57:55 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | [#3] mootools.html Cycles:180 Average:6092.48 Median:3750.41 stddev:3941.46 (105.1%) stddev-sans-first:3935.46 08:57:55 INFO - PID 6073 | Values: 1212.1 1244.5 1269.3 1272.2 1279.2 9652.4 9712.1 10037.7 10094.6 10278.0 10116.4 10299.5 10323.1 10327.7 10362.7 2251.7 2283.1 2289.4 2292.0 2293.0 2184.0 2235.7 2242.9 2245.6 2246.5 2241.1 2246.3 2288.8 2290.8 2300.1 2093.7 2154.2 2186.2 2193.1 2205.0 2040.9 2128.4 2163.3 2186.0 2189.2 9778.6 9875.5 9889.2 9897.3 9919.9 5203.7 5329.9 5352.2 5361.2 5383.7 3136.5 3329.3 3399.2 3403.5 3411.1 1020.8 1032.9 1047.9 1088.7 1090.0 14367.8 14503.8 14504.2 14515.3 14544.5 4346.7 4418.4 4517.9 4604.9 4643.8 10449.5 10453.4 10477.1 10519.6 10530.1 5295.5 5309.2 5332.2 5335.5 5338.0 4816.6 4823.7 4874.7 4977.8 5013.4 3608.9 3632.6 3674.2 3744.6 3756.2 1036.1 1036.5 1048.1 1051.6 1052.9 629.7 660.7 663.0 663.3 664.9 4890.8 4899.9 4934.1 4958.9 5036.5 523.2 527.6 534.8 535.8 545.5 3540.8 3603.4 3671.7 3683.2 3809.4 12319.2 13022.2 13028.8 13045.6 13162.0 12513.0 12672.4 12904.5 13034.7 13071.2 7273.7 7437.9 7446.0 7451.7 7494.5 5600.3 5861.8 5986.8 6055.8 6197.0 11150.7 11575.1 11696.2 11749.1 11968.1 11474.2 11799.4 11850.5 11862.0 11865.1 8110.6 8187.4 8295.0 8314.3 8356.5 8835.0 9374.3 9516.5 9518.8 9597.9 8090.7 8100.0 8187.2 8191.4 8510.7 7722.3 7902.5 8003.9 8092.5 8240.7 6706.5 6751.9 6785.5 6789.6 6797.9 4626.6 4724.5 4826.3 4830.1 4889.0 4982.2 4989.3 5030.8 5067.7 5094.2 08:57:55 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | [#4] prototype.html Cycles:180 Average:4827.52 Median:5441.45 stddev:1434.26 (26.4%) stddev-sans-first:1398.72 08:57:55 INFO - PID 6073 | Values: 369.9 378.4 385.8 391.8 393.6 5517.7 5537.9 5560.4 5561.2 5581.3 5335.4 5342.5 5355.9 5424.2 5450.9 4240.9 4247.6 4253.7 4256.8 4263.4 4261.5 4280.3 4280.3 4280.4 4281.7 4176.6 4255.2 4258.6 4262.8 4264.5 4227.9 4229.8 4239.4 4254.5 4265.1 3809.5 3810.6 3813.8 3822.4 3830.7 5220.6 5365.7 5376.4 5397.0 5410.9 4977.9 4979.3 5037.7 5054.7 5056.4 5813.4 5815.9 5823.9 5826.9 5841.5 3824.7 3984.5 4268.1 4277.2 4279.8 5933.9 6168.5 6176.9 6190.2 6203.3 4029.6 4061.4 4069.5 4077.0 4080.5 4139.7 4140.9 4161.8 4170.7 4179.9 4742.8 4781.6 4817.0 4822.9 4832.8 5845.2 5854.0 5855.6 5858.6 5891.1 1426.4 1433.0 1433.2 1434.8 1437.0 900.8 936.8 949.4 958.7 959.0 4965.8 4979.7 4985.9 5011.9 5036.1 6049.2 6052.7 6061.6 6064.9 6068.8 4843.3 4959.6 5018.7 5027.6 5045.4 3206.3 3219.4 3233.9 3240.2 3243.8 5347.6 5582.2 5605.8 5606.1 5614.7 6224.4 6270.0 6285.8 6288.8 6332.5 5632.3 5635.1 5640.9 5653.3 5661.9 5883.0 6055.5 6108.1 6128.1 6156.4 6031.3 6031.9 6034.1 6044.6 6055.9 5432.0 5543.2 5618.4 5621.4 5643.6 4105.8 4128.2 4129.4 4142.6 4156.4 5983.5 6116.4 6136.1 6136.8 6143.3 5849.7 5854.9 5865.3 5878.6 5897.3 5855.9 5884.4 5918.6 5933.4 5933.9 5747.7 5771.3 5793.1 5842.8 5851.3 5893.5 5954.9 5966.1 5983.6 5987.3 5668.5 5729.9 5759.3 5760.5 5767.8 08:57:55 INFO - PID 6073 | 08:57:55 INFO - PID 6073 | [#5] yui.html Cycles:180 Average:14481.65 Median:2937.52 stddev:16907.33 (575.6%) stddev-sans-first:16922.90 08:57:55 INFO - PID 6073 | Values: 660.4 680.8 733.0 736.2 769.1 11903.7 12231.7 12329.7 13799.0 13970.4 14274.2 14310.9 14355.9 14426.4 14693.7 834.1 841.9 845.5 846.5 847.8 904.7 906.5 906.5 908.0 911.3 919.1 927.7 929.0 929.8 931.6 915.3 918.7 921.6 923.3 928.2 684.6 685.0 690.3 691.6 693.6 13456.3 13578.3 13587.3 13711.3 13904.7 14372.3 14459.6 14730.3 14739.9 14751.7 11724.9 11917.4 11959.2 12052.7 12061.5 2912.2 2927.8 2929.5 2936.2 2937.6 69443.7 71720.6 71964.6 72054.3 72791.3 10529.2 11034.2 11143.2 11160.6 11178.5 19667.0 20148.4 20858.3 20961.7 21093.3 6070.4 6235.7 6256.9 6344.1 6411.8 2875.9 2915.0 2933.8 2936.2 2937.4 3266.2 3351.3 3352.9 3353.0 3358.6 695.1 712.6 728.3 730.8 734.8 575.3 582.3 588.1 589.1 605.2 9516.3 9980.9 9996.0 10051.3 10073.1 584.5 590.1 606.8 614.0 636.4 4089.2 4491.2 4492.4 4583.8 4620.0 55688.7 56426.7 56937.4 57975.7 59671.1 48997.0 49504.0 49866.0 50171.7 50929.5 46173.8 46682.3 46703.3 46856.5 46859.8 10197.9 10384.8 10521.8 10885.8 10888.4 24131.8 24468.1 24760.3 25247.5 25752.5 29981.3 30091.0 30262.2 30898.0 42634.6 13034.5 13114.6 13382.1 13459.2 13499.6 14748.6 15075.6 15161.7 15259.0 15445.7 13590.1 13700.2 13750.2 13915.0 14027.6 13633.1 13738.2 13762.4 13925.2 14099.0 12795.5 13396.5 13742.6 13833.0 13975.3 10280.3 10629.8 10735.8 10927.5 11296.4 10945.4 11502.5 11630.8 11644.8 11705.4 08:57:55 INFO - PID 6073 | -------- Summary: end -------- 08:57:55 INFO - PID 6073 | 08:57:56 INFO - TEST-INFO | 6073: exit 0 08:57:56 INFO - TEST-OK | dromaeo_css | took 1118860ms 08:57:56 INFO - TEST-START | kraken 08:57:56 INFO - operating with platform_type : linux_ 08:57:56 INFO - Initialising browser for kraken test... 08:57:56 INFO - TEST-INFO | started process 6476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSFqq0l/profile http://localhost:48372/getInfo.html) 08:57:56 INFO - PID 6476 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 08:58:00 INFO - PID 6476 | __metrics Screen width/height:1600/1200 08:58:00 INFO - PID 6476 | colorDepth:24 08:58:00 INFO - PID 6476 | Browser inner width/height: 1024/695 08:58:00 INFO - PID 6476 | __metrics 08:58:02 INFO - TEST-INFO | 6476: exit 0 08:58:02 INFO - Browser initialized. 08:58:02 INFO - Running cycle 1/1 for kraken test... 08:58:02 INFO - TEST-INFO | started process 6640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSFqq0l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:14 INFO - PID 6640 | RSS: Main: 166232064 08:58:14 INFO - PID 6640 | 08:58:16 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48372/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:17 INFO - PID 6640 | RSS: Main: 170909696 08:58:17 INFO - PID 6640 | 08:58:20 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48372/tests/kraken/driver.html?testName=audio-dft) 08:58:21 INFO - PID 6640 | RSS: Main: 170266624 08:58:21 INFO - PID 6640 | 08:58:24 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48372/tests/kraken/driver.html?testName=audio-fft) 08:58:24 INFO - PID 6640 | RSS: Main: 165515264 08:58:24 INFO - PID 6640 | 08:58:26 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48372/tests/kraken/driver.html?testName=audio-oscillator) 08:58:27 INFO - PID 6640 | RSS: Main: 165900288 08:58:27 INFO - PID 6640 | 08:58:29 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:30 INFO - PID 6640 | RSS: Main: 166162432 08:58:30 INFO - PID 6640 | 08:58:33 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48372/tests/kraken/driver.html?testName=imaging-darkroom) 08:58:34 INFO - PID 6640 | RSS: Main: 171229184 08:58:34 INFO - PID 6640 | 08:58:37 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48372/tests/kraken/driver.html?testName=imaging-desaturate) 08:58:38 INFO - PID 6640 | RSS: Main: 168161280 08:58:38 INFO - PID 6640 | 08:58:41 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48372/tests/kraken/driver.html?testName=json-parse-financial) 08:58:41 INFO - PID 6640 | RSS: Main: 169156608 08:58:41 INFO - PID 6640 | 08:58:43 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:58:43 INFO - PID 6640 | RSS: Main: 169594880 08:58:43 INFO - PID 6640 | 08:58:45 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48372/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:46 INFO - PID 6640 | RSS: Main: 169414656 08:58:46 INFO - PID 6640 | 08:58:48 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:49 INFO - PID 6640 | RSS: Main: 168861696 08:58:49 INFO - PID 6640 | 08:58:51 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:52 INFO - PID 6640 | RSS: Main: 169222144 08:58:52 INFO - PID 6640 | 08:58:55 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:56 INFO - PID 6640 | RSS: Main: 169398272 08:58:56 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | Cycle 1(1): loaded http://localhost:48372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48372/tests/kraken/driver.html?testName=ai-astar) 08:58:58 INFO - PID 6640 | RSS: Main: 170471424 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | __start_tp_report 08:58:58 INFO - PID 6640 | _x_x_mozilla_page_load 08:58:58 INFO - PID 6640 | _x_x_mozilla_page_load_details 08:58:58 INFO - PID 6640 | |i|pagename|runs| 08:58:58 INFO - PID 6640 | |0;ai-astar;105;111;112;110;111;112;114;113;111;113 08:58:58 INFO - PID 6640 | |1;audio-beat-detection;155;125;125;175;124;132;130;124;150;123 08:58:58 INFO - PID 6640 | |2;audio-dft;163;165;163;163;165;167;169;170;164;164 08:58:58 INFO - PID 6640 | |3;audio-fft;74;76;75;115;75;75;75;76;109;74 08:58:58 INFO - PID 6640 | |4;audio-oscillator;83;86;104;84;84;83;99;84;83;106 08:58:58 INFO - PID 6640 | |5;imaging-gaussian-blur;114;114;115;115;114;114;115;114;114;118 08:58:58 INFO - PID 6640 | |6;imaging-darkroom;149;151;150;152;151;151;151;151;151;150 08:58:58 INFO - PID 6640 | |7;imaging-desaturate;95;95;95;94;94;95;95;95;94;95 08:58:58 INFO - PID 6640 | |8;json-parse-financial;54;56;53;54;54;55;55;55;54;55 08:58:58 INFO - PID 6640 | |9;json-stringify-tinderbox;57;57;56;56;57;56;57;57;56;57 08:58:58 INFO - PID 6640 | |10;stanford-crypto-aes;84;82;84;83;82;81;82;86;82;82 08:58:58 INFO - PID 6640 | |11;stanford-crypto-ccm;140;144;146;141;135;141;135;133;214;134 08:58:58 INFO - PID 6640 | |12;stanford-crypto-pbkdf2;209;197;200;201;194;196;197;197;198;200 08:58:58 INFO - PID 6640 | |13;stanford-crypto-sha256-iterative;72;73;72;71;72;74;76;72;72;71 08:58:58 INFO - PID 6640 | __end_tp_report 08:58:58 INFO - PID 6640 | __start_cc_report 08:58:58 INFO - PID 6640 | _x_x_mozilla_cycle_collect,767 08:58:58 INFO - PID 6640 | __end_cc_report 08:58:58 INFO - PID 6640 | __startTimestamp1495555138548__endTimestamp 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | ------- Summary: start ------- 08:58:58 INFO - PID 6640 | Number of tests: 14 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.49 (2.2%) stddev-sans-first:1.27 08:58:58 INFO - PID 6640 | Values: 105.0 111.0 112.0 110.0 111.0 112.0 114.0 113.0 111.0 113.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:131.00 stddev:17.73 (13.5%) stddev-sans-first:17.46 08:58:58 INFO - PID 6640 | Values: 155.0 125.0 125.0 175.0 124.0 132.0 130.0 124.0 150.0 123.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:2.54 (1.5%) stddev-sans-first:2.55 08:58:58 INFO - PID 6640 | Values: 163.0 165.0 163.0 163.0 165.0 167.0 169.0 170.0 164.0 164.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.68 (20.9%) stddev-sans-first:16.33 08:58:58 INFO - PID 6640 | Values: 74.0 76.0 75.0 115.0 75.0 75.0 75.0 76.0 109.0 74.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:84.00 stddev:9.44 (11.2%) stddev-sans-first:9.71 08:58:58 INFO - PID 6640 | Values: 83.0 86.0 104.0 84.0 84.0 83.0 99.0 84.0 83.0 106.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.25 (1.1%) stddev-sans-first:1.30 08:58:58 INFO - PID 6640 | Values: 114.0 114.0 115.0 115.0 114.0 114.0 115.0 114.0 114.0 118.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.60 08:58:58 INFO - PID 6640 | Values: 149.0 151.0 150.0 152.0 151.0 151.0 151.0 151.0 151.0 150.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:58:58 INFO - PID 6640 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 08:58:58 INFO - PID 6640 | Values: 54.0 56.0 53.0 54.0 54.0 55.0 55.0 55.0 54.0 55.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:57.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 08:58:58 INFO - PID 6640 | Values: 57.0 57.0 56.0 56.0 57.0 56.0 57.0 57.0 56.0 57.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:1.48 (1.8%) stddev-sans-first:1.50 08:58:58 INFO - PID 6640 | Values: 84.0 82.0 84.0 83.0 82.0 81.0 82.0 86.0 82.0 82.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:141.00 stddev:24.19 (17.2%) stddev-sans-first:25.55 08:58:58 INFO - PID 6640 | Values: 140.0 144.0 146.0 141.0 135.0 141.0 135.0 133.0 214.0 134.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.90 Median:199.00 stddev:4.12 (2.1%) stddev-sans-first:2.22 08:58:58 INFO - PID 6640 | Values: 209.0 197.0 200.0 201.0 194.0 196.0 197.0 197.0 198.0 200.0 08:58:58 INFO - PID 6640 | 08:58:58 INFO - PID 6640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.00 stddev:1.51 (2.1%) stddev-sans-first:1.59 08:58:58 INFO - PID 6640 | Values: 72.0 73.0 72.0 71.0 72.0 74.0 76.0 72.0 72.0 71.0 08:58:58 INFO - PID 6640 | -------- Summary: end -------- 08:58:58 INFO - PID 6640 | 08:58:59 INFO - TEST-INFO | 6640: exit 0 08:58:59 INFO - TEST-OK | kraken | took 63271ms 08:58:59 INFO - SUITE-END | took 1182s 08:58:59 INFO - Completed test suite (00:19:42) 08:58:59 INFO - javascript benchmark 08:58:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6614.921444982957, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2708.7697545708616, 2731.453709258149, 2747.2033110397974, 2752.7109653486377, 2759.1998320487046, 5147.1764517677175, 5178.4821517848195, 5178.896422071556, 5224.738763061846, 5236.083685355066, 5117.795288188478, 5186.429492755794, 5224.660397074197, 5274.894502109955, 5279.313689220396, 4480.333668207737, 4644.558766917137, 4667.813287468497, 4670.602998745094, 4686.671932964694, 4714.387129673155, 4726.007538416937, 4773.976130119345, 4777.402824646919, 4786.1863483207935, 4591.104734576759, 4640.907181856378, 4654.394928659286, 4689.507601701806, 4708.882277943045, 4685.601723853442, 4689.812407503696, 4691.272852707836, 4691.859244222679, 4726.787294571753, 4629.097326021427, 4643.4660014098135, 4647.4190726158895, 4669.859904202879, 4681.625469962429, 5126.282320475137, 5176.844694659167, 5180.430152683201, 5223.6343455958095, 5231.24146998683, 5563.720344320788, 5596.524295434852, 5608.775648974036, 5613.354464236624, 5627.915581266243, 5631.971840140773, 5649.604527683023, 5653.604247702662, 5665.943340566624, 5670.376258611549, 5192.4547922468355, 5247.475252474722, 5256.474352564789, 5260.000599886048, 5279.788808447696, 5737.483626473638, 5847.883042339129, 5896.410358964069, 5901.468867801918, 5918.171455996164, 5532.474414930575, 5563.443655634485, 5587.580931430159, 5592.888142237214, 5604.047311956977, 5557.749901254453, 5606.24315717373, 5618.634788738719, 5625.521830644359, 5706.771729130788, 5528.44715528444, 5552.806146678484, 5566.109422492382, 5599.776008959596, 5619.072852979212, 5537.252470916455, 5542.8337149885565, 5553.611247212656, 5556.749946252428, 5560.805371811967, 4664.137134630104, 4705.270683044134, 4725.787339569659, 4728.621710263171, 4768.094062128184, 3995.940060899031, 4025.939610905839, 4074.246264441088, 4099.159672267178, 4099.8975025624595, 4784.40194975628, 4787.880302992453, 4789.257665061921, 4798.5441383068555, 4824.951750482521, 5592.692401917852, 5686.744096515667, 5698.572607054488, 5729.2265544151005, 5762.683052432157, 4701.459332176843, 4724.858254252309, 4756.405449318835, 4774.331593576902, 4788.449328327218, 5023.497650234947, 5024.824131155392, 5025.120603894304, 5027.120253955543, 5066.518680725325, 5204.089284375219, 5204.895902082013, 5211.9478805211465, 5216.452272511332, 5217.50433708797, 5480.588955828249, 5555.833325000256, 5607.0, 5705.144228365612, 5719.5710321726865, 5188.092083885381, 5197.116490196751, 5206.8958620828125, 5223.033738758342, 5260.815871444481, 5565.860853478695, 5576.9163462547285, 5591.720413979204, 5595.496405323541, 5623.325200975745, 5594.216809646734, 5614.466625670555, 5651.689157096399, 5689.573282003949, 5730.369659337386, 5491.121420572849, 5516.558675306046, 5518.199861020049, 5543.501084902378, 5580.079286917613, 5385.057614917452, 5482.753276102505, 5485.122380419114, 5490.258815059916, 5510.3938566758425, 5332.06688829461, 5353.009693206769, 5391.433899440659, 5434.184872269191, 5456.7544460498575, 5507.752151153288, 5510.421405752339, 5510.531604813636, 5537.889242215214, 5558.944410556004, 5348.384935732285, 5350.946490535045, 5376.784928602969, 5383.919241211307, 5392.245085687929], "value": 5109.639691570848, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.9304876463589, 668.121420332263, 687.8314812870846, 1193.123054554902, 1195.515816094481, 33138.17154571134, 33797.78921002507, 33834.15414614633, 34061.0, 34336.0, 31964.360712785787, 32021.519677204862, 32097.35805283893, 32135.19662008445, 32425.189370265754, 6416.999999999988, 6497.285298617148, 6503.317151699074, 6505.967470162643, 6514.2508611509575, 6440.710168042426, 6445.967770161143, 6483.4489068429, 6492.026196070604, 6554.606723596576, 6525.086487891699, 6635.303293154222, 6783.559068660546, 6787.0, 6804.047433359309, 6724.125863637721, 6749.595024298534, 6761.966190169067, 6806.965965170167, 6825.590464572141, 6815.863682726318, 6845.691943862538, 6878.55289406192, 6897.448204143657, 6897.48268879836, 31541.52687709686, 31721.20696982594, 31818.363632727214, 31875.203119921956, 31935.361292774247, 2685.3957859481657, 2706.5534186859145, 2721.4012917158193, 2725.223311356274, 2728.4133911209187, 23946.880265598735, 23984.0, 24153.87923060391, 24219.273421797374, 24297.878510607512, 2983.612130423031, 2984.567237750514, 2991.356858275481, 2993.4162838246552, 3001.039667306463, 142556.0, 142967.0, 143589.2820535901, 155437.22281388633, 157493.2125339366, 38177.23645527074, 38542.80728596395, 38567.42148867769, 38573.42139867904, 38627.0, 40117.39530418809, 40227.0, 40302.19395612071, 40312.56561778202, 40427.59572404297, 11924.642260732191, 11987.520499179935, 12003.459844307026, 12043.638690839114, 12153.878461215452, 9700.27247956406, 9742.464164471023, 9751.561179746928, 9796.069373409515, 9812.852807207897, 12218.633440996784, 12268.877311226952, 12369.505219791108, 12369.814452783216, 12505.312207828474, 5208.635395522277, 5262.0, 5274.736263186825, 5300.363956325188, 5308.708021058802, 872.3152325424511, 888.5157589113949, 891.6656253904786, 908.6683360573343, 936.9297302702324, 20503.69244461334, 21137.577248454945, 21160.14531594293, 21175.68236476454, 21663.45841353979, 967.1778987860403, 968.6803354893009, 988.6885631026347, 994.7363948553639, 1007.8185926533295, 10752.892471075189, 11215.383153926612, 11248.381339026268, 11293.435328233556, 11297.774044519063, 185366.0, 186042.0, 186093.0, 186883.0, 187548.0, 38595.2280954385, 38920.22159556793, 39116.41325380121, 39270.0, 39511.209775804324, 1177.31127290536, 1215.775081609905, 1222.584321330752, 1224.2287358963974, 1235.6416639174718, 19470.415887523395, 19835.30576429818, 19956.60086798227, 21049.263275785273, 23929.760702392752, 36910.26179476449, 37418.43872341863, 37558.43662345012, 37900.0, 38685.41971870368, 162714.1864290671, 163618.0, 164896.0, 164981.0, 164988.17505912393, 28433.43133137284, 29325.26686832846, 29742.958996435886, 29896.850515747283, 29996.0, 35093.03763387325, 35237.82381088078, 35296.47055294224, 36093.63906360903, 36324.0, 27029.0, 27472.862635686695, 27809.582856257577, 27928.30179245535, 29077.0, 26872.32819179536, 27169.320766980985, 27565.17304480869, 27781.305467363476, 28702.56946145768, 29871.253218669706, 30469.847650761603, 30522.389552208388, 30927.226819329695, 30937.535936960514, 26675.733242668102, 26924.192274231806, 27138.32154196161, 27591.31021724473, 27971.300717482227, 20256.79743202549, 22871.348046999206, 22980.54038919179, 23010.654840177747, 23418.64872026955], "value": 14394.52018495291, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3297179393753, 389.7973054011914, 392.11577891853864, 397.3681845865074, 410.3106780608578, 12765.297908615023, 15590.688186236268, 16661.66676666466, 17209.7418538722, 17213.569660758487, 17727.55681107973, 17944.820551794477, 18099.366522171727, 18168.63662726748, 18176.545586360313, 5223.738813059351, 5353.116735738598, 5430.945690543103, 5554.583406244527, 5581.776728930838, 5404.189371594272, 5428.83713488596, 5435.93999170162, 5461.317335333083, 5465.289512363387, 5289.814856480024, 5323.574114070884, 5323.973380133113, 5398.406175320732, 5429.239906413086, 5314.0, 5318.46815318467, 5328.653637513568, 5350.678959262456, 5371.167469042285, 4666.626669866402, 4780.330753694486, 4794.640401969831, 4804.951950480486, 4841.7337046462435, 20758.896205519028, 20896.0, 20965.5806883863, 21000.684989725167, 21257.8937105315, 1624.3340230505437, 1638.942637007699, 1655.7764701765348, 1656.3788579282768, 1657.7264751316018, 13506.459741610324, 13932.164070155723, 14135.15189088658, 14405.85594144066, 14593.927030364886, 1944.36808037387, 2001.2495314257153, 2021.353166986565, 2038.5617092325222, 2040.4286799696108, 83323.5833820833, 85959.57020214859, 87764.0, 88311.0, 89825.55087224588, 10189.949050254701, 10378.169746420419, 10402.58389664405, 10429.791404172025, 10583.206259530565, 13391.330433478288, 13622.161008263758, 13791.689994401271, 13804.723905522034, 13849.238291894042, 7007.649617519103, 7041.471889608198, 7237.335412854967, 7270.745523906638, 7272.527285726516, 6550.246721627074, 6560.671966401756, 6634.568753031134, 6811.080504131978, 6820.931790682129, 6586.209654841354, 6613.0, 6663.900041499382, 6737.326267373322, 6838.350356716104, 1971.7204626838234, 1983.8611297209056, 2026.797320267991, 2046.6213750456213, 2134.8612340198147, 836.1220718245818, 866.8569686001865, 870.2863651805459, 874.1302404107953, 902.1294450854825, 16030.919845400698, 16173.757393639105, 16639.916800415922, 16738.4141555045, 16925.492235232963, 868.4745728834091, 876.5310558850985, 878.4948654523674, 878.5547773912007, 884.5798245833178, 8887.422317549339, 9270.814583708423, 9342.439453632804, 9423.858642120374, 9446.291528135418, 344986.0, 375823.0, 381873.0, 384149.0, 388142.0, 79307.0, 80355.19644803595, 81147.59426202832, 82055.58972205101, 84657.15342846616, 1065.5631191211567, 1079.3901445683164, 1120.9943950280197, 1123.393367581497, 1124.9100071994221, 16408.589785255463, 16649.750253745962, 17225.138743063046, 17291.56771080733, 17504.299828007246, 38814.41778373383, 39152.608473916036, 39261.41107883327, 39771.0, 39998.0, 49129.50870491249, 49591.0, 49712.751436242586, 49932.0, 49957.50042499528, 7825.530468171928, 7849.921500785147, 7939.166387529226, 8023.518588884685, 8063.596820159086, 12317.75364492723, 12513.687157821127, 12523.812142818048, 12794.68013299675, 12805.167664101804, 10141.543630536496, 10397.16822654201, 10519.631812886511, 10650.786984260427, 10930.344179349264, 10508.789824203626, 10635.89364106349, 10638.89361106379, 10777.407242601732, 10801.513931872927, 11496.425178740863, 11683.474243659226, 11750.58872939443, 11872.525098995944, 12059.51761929513, 7640.847183056197, 7805.921940780519, 7846.960765196138, 7900.091489478784, 8215.0, 10530.104941080093, 10880.727981800203, 11006.009459148716, 11020.724481888017, 11322.37726925027], "value": 8650.700997421964, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.0969877441305, 1244.4835393311776, 1269.289198049093, 1272.1985149355905, 1279.1813239526698, 9652.42085474871, 9712.077352651488, 10037.749056273587, 10094.596216151345, 10278.0, 10116.443595602239, 10299.53652085656, 10323.12253458455, 10327.741806454842, 10362.740931476717, 2251.6509940959177, 2283.1438210671, 2289.404754763765, 2291.9885400572975, 2293.0483849202647, 2184.0, 2235.7093577834858, 2242.876641784709, 2245.5621153875, 2246.494538728781, 2241.1483636218213, 2246.269962262263, 2288.7596802335765, 2290.7594702556244, 2300.148944890393, 2093.6859471079306, 2154.192177933275, 2186.2348178137686, 2193.0898677049004, 2204.9669254961186, 2040.9081591328427, 2128.372130221588, 2163.3077415227135, 2186.0, 2189.200941656284, 9778.608855645765, 9875.506224688737, 9889.159421449185, 9897.257705672104, 9919.851202231972, 5203.713795741232, 5329.920051199235, 5352.197170424429, 5361.169018802092, 5383.703896285702, 3136.5138403547485, 3329.300846822146, 3399.1502124468884, 3403.523506709038, 3411.1472131967007, 1020.7805321855836, 1032.917366610677, 1047.9109275711573, 1088.7332603512111, 1090.0244281368211, 14367.784483232655, 14503.782443263359, 14504.202268875208, 14515.346809393497, 14544.490942817056, 4346.673999450054, 4418.403515525427, 4517.93828450314, 4604.861854144381, 4643.791029403685, 10449.529771160316, 10453.425061621683, 10477.10944569705, 10519.579216831242, 10530.10494107994, 5295.4969277918535, 5309.150535914235, 5332.200169974535, 5335.493128152819, 5338.039152952506, 4816.567633345138, 4823.710577365369, 4874.707517548887, 4977.751112444364, 5013.423456302499, 3608.9458658120147, 3632.5822530408814, 3674.1733110050027, 3744.64425879541, 3756.1736417988, 1036.108946306176, 1036.5387402605918, 1048.114343379843, 1051.6161601015574, 1052.9157667386592, 629.6536904702396, 660.6993817812884, 662.9734810607619, 663.3101574362609, 664.92353379362, 4890.799140386769, 4899.902001959941, 4934.062528119646, 4958.851234462972, 5036.546710796046, 523.1786095829511, 527.5673947363202, 534.7593582887716, 535.7910414938177, 545.5499213149168, 3540.8406621702084, 3603.3513967486106, 3671.706263498914, 3683.1896982664307, 3809.4285857121654, 12319.199252048587, 13022.153560018569, 13028.80456793149, 13045.608631741063, 13162.0, 12513.0, 12672.366381680878, 12904.548340808027, 13034.674133146747, 13071.215727056217, 7273.745418910313, 7437.925620743723, 7445.9627701861145, 7451.664675089634, 7494.475386722877, 5600.327960644749, 5861.794837180678, 5986.820395388146, 6055.788047418319, 6197.03945888388, 11150.665480035612, 11575.131865109983, 11696.239744416585, 11749.060075193793, 11968.102392320438, 11474.212098469727, 11799.35103569312, 11850.525978960744, 11862.0, 11865.11011674145, 8110.635021423932, 8187.426880118334, 8294.9631296088, 8314.293285070595, 8356.498610083414, 8834.955825220834, 9374.250059995047, 9516.524173791422, 9518.762030949281, 9597.9040209597, 8090.676372945016, 8100.0, 8187.181281872004, 8191.426600137933, 8510.74467765968, 7722.266384693445, 7902.525848449111, 8003.919960800317, 8092.473989190684, 8240.711575094843, 6706.530542862148, 6751.93248067513, 6785.5250132490255, 6789.558678685869, 6797.864042719217, 4626.560476754703, 4724.503927087606, 4826.251930950708, 4830.106430310404, 4888.9755551222015, 4982.202847544376, 4989.326440930428, 5030.773615187252, 5067.746612669278, 5094.235864620188], "value": 4543.20904279527, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.890882189754, 378.4266835743847, 385.7878167008145, 391.77864506553794, 393.64571885303235, 5517.724113794315, 5537.861553461165, 5560.388357280696, 5561.193626924093, 5581.274434323543, 5335.359756829176, 5342.545883599899, 5355.946440535594, 5424.159255315422, 5450.91823622646, 4240.872773816775, 4247.638950689196, 4253.723507971979, 4256.829726810924, 4263.424437700902, 4261.509926358477, 4280.336547835091, 4280.336547835091, 4280.443542339507, 4281.7002809803325, 4176.561461046592, 4255.191513612419, 4258.552851950547, 4262.78686065697, 4264.5095813981325, 4227.852025179135, 4229.788510574459, 4239.427677263576, 4254.468191476066, 4265.125649241913, 3809.5428548574073, 3810.580836108026, 3813.809309534512, 3822.3502004659276, 3830.731848770587, 5220.608454365938, 5365.704886231256, 5376.354837419534, 5396.9730151348995, 5410.945890541084, 4977.850664480072, 4979.253112033188, 5037.697738135724, 5054.671446355975, 5056.367954005749, 5813.360530341659, 5815.912761308584, 5823.854403639901, 5826.854328641775, 5841.532677385841, 3824.694024478035, 3984.5417776955733, 4268.103698223377, 4277.165952639237, 4279.838681465871, 5933.851653708649, 6168.475679567242, 6176.938230617726, 6190.1952746142715, 6203.348648391944, 4029.5768944261017, 4061.411095391211, 4069.491313585802, 4076.9796151019054, 4080.489938757655, 4139.689523285705, 4140.91718165635, 4161.812718427678, 4170.749755014709, 4179.853705120367, 4742.775302037573, 4781.569658730731, 4816.975915120472, 4822.855314340575, 4832.758362081881, 5845.240118784616, 5854.0, 5855.560832937546, 5858.623223542464, 5891.1457838614015, 1426.3795249066482, 1432.957011289663, 1433.2045714628273, 1434.8421673615894, 1437.0300047467917, 900.8243392538524, 936.8032713130183, 949.4350861237552, 958.7075941837667, 959.0, 4965.808206030527, 4979.726115063706, 4985.925211121764, 5011.924821127686, 5036.093503169464, 6049.21360223177, 6052.727627256784, 6061.636301821904, 6064.877997570376, 6068.787592434332, 4843.2735089736825, 4959.603231741452, 5018.673786203958, 5027.572656324253, 5045.369328833895, 3206.342699746593, 3219.388316219911, 3233.935321293561, 3240.189952511872, 3243.772935894512, 5347.572194224453, 5582.162675598693, 5605.80379686709, 5606.103023516218, 5614.69119198448, 6224.439800417984, 6270.028145637433, 6285.842853928689, 6288.779892703734, 6332.461740752087, 5632.295963004624, 5635.12655538384, 5640.943590564124, 5653.265075540154, 5661.858453538694, 5882.970375220542, 6055.455009049207, 6108.083787431743, 6128.111423843428, 6156.384361563808, 6031.336552979256, 6031.879362412815, 6034.09488576717, 6044.576879618385, 6055.939440605537, 5431.972840135774, 5543.1685247213245, 5618.353889302619, 5621.353544342453, 5643.576731745217, 4105.815238314342, 4128.195001974586, 4129.442525259172, 4142.647874930664, 4156.418101465858, 5983.521318294613, 6116.418940200674, 6136.140940268277, 6136.785212517719, 6143.293521245114, 5849.707514624337, 5854.853628659318, 5865.266841644794, 5878.648540583629, 5897.321807991964, 5855.94144058554, 5884.411558844081, 5918.644881306963, 5933.436323549256, 5933.851653708692, 5747.683877386784, 5771.278590176228, 5793.073108302651, 5842.766289348378, 5851.327097383855, 5893.469587737124, 5954.851128721643, 5966.134910437875, 5983.640981541122, 5987.31145918225, 5668.5465162787705, 5729.885402292014, 5759.280089988752, 5760.481556659921, 5767.788764359531], "value": 4379.875538040694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.3561527510681, 680.8331958670124, 733.0214164090938, 736.2085757810354, 769.0655853138437, 11903.702407439818, 12231.694207644803, 12329.691757706061, 13799.0, 13970.37133329, 14274.214918179496, 14310.856891431082, 14355.856441435608, 14426.35081421336, 14693.706125877476, 834.0866750907746, 841.949483031017, 845.4927043773748, 846.5132548784443, 847.8134810341714, 904.7376260884336, 906.4742449379344, 906.5467266366817, 908.0193391137556, 911.2709832134266, 919.0855099176329, 927.7309580221728, 928.9721308360727, 929.8465753150722, 931.6366617019368, 915.3318077803208, 918.6600957645713, 921.5530467723216, 923.3029063057382, 928.1785619726556, 684.6029303004245, 685.0443631134589, 690.2958981838497, 691.6126968897433, 693.6323748413349, 13456.327183640877, 13578.25319607431, 13587.252701101435, 13711.314434278247, 13904.721905561933, 14372.281385930766, 14459.638509037253, 14730.337134828958, 14739.92630036843, 14751.70496590073, 11724.882751172465, 11917.404129793562, 11959.222650527689, 12052.698682532919, 12061.457234424472, 2912.1700315410008, 2927.8096923700105, 2929.545920382323, 2936.207224049516, 2937.588737576741, 69443.65278173628, 71720.6413967932, 71964.64017679878, 72054.27945720528, 72791.27208727898, 10529.157667386591, 11034.172437067253, 11143.164262680331, 11160.609378671708, 11178.490903728056, 19667.0, 20148.39554813358, 20858.269960551308, 20961.68557471639, 21093.261735839173, 6070.3929607038945, 6235.719392627343, 6256.874862502816, 6344.080108384258, 6411.775587854496, 2875.9424811503654, 2914.9943269571963, 2933.779966502478, 2936.1778701963485, 2937.4418860416454, 3266.248762784573, 3351.3464874349756, 3352.8994130176134, 3352.983235083858, 3358.5633867597057, 695.0720787748312, 712.6116266634697, 728.2644529025616, 730.7844185965153, 734.8089496730888, 575.2952633024595, 582.2866987939825, 588.0532342927883, 589.1163255117324, 605.1769593353036, 9516.33385662997, 9980.850287245697, 9996.000399959947, 10051.296409251428, 10073.1437827784, 584.5153310591136, 590.1236663554618, 606.7936901453438, 613.9662318572432, 636.4208570201095, 4089.2230476209425, 4491.214037543416, 4492.438445194351, 4583.816647334136, 4620.0, 55688.72155639196, 56426.71786641041, 56937.43062569321, 57975.71012144996, 59671.10493342603, 48997.0, 49504.0, 49866.0, 50171.74914125406, 50929.490705093216, 46173.76913115413, 46682.29976550354, 46703.29945050827, 46856.5314346859, 46859.76570117127, 10197.9490102549, 10384.792304153723, 10521.842172367267, 10885.836712449478, 10888.40113793749, 24131.758682413652, 24468.14361497339, 24760.25719228426, 25247.495050099264, 25752.484950301263, 29981.250468737584, 30091.0, 30262.243443914078, 30898.0, 42634.57365426306, 13034.47862085506, 13114.60656180316, 13382.130161539859, 13459.192448453125, 13499.595012149652, 14748.557543273719, 15075.623109422353, 15161.696766064397, 15259.0, 15445.691086178438, 13590.116642418212, 13700.177989320673, 13750.174989500261, 13915.025948183935, 14027.579172624837, 13633.113847599874, 13738.244396557886, 13762.449502019806, 13925.234112123526, 14099.0, 12795.488180472677, 13396.531121410704, 13742.587722368346, 13833.0, 13975.301234938415, 10280.280380373302, 10629.840552391875, 10735.785284294427, 10927.508262128382, 11296.43517824089, 10945.398003109905, 11502.53989840397, 11630.825537616773, 11644.767104658029, 11705.414729263674], "value": 6616.877056925265, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 112.0, 110.0, 111.0, 112.0, 114.0, 113.0, 111.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 125.0, 175.0, 124.0, 132.0, 130.0, 124.0, 150.0, 123.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 163.0, 165.0, 167.0, 169.0, 170.0, 164.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 115.0, 75.0, 75.0, 75.0, 76.0, 109.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 104.0, 84.0, 84.0, 83.0, 99.0, 84.0, 83.0, 106.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 118.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 150.0, 152.0, 151.0, 151.0, 151.0, 151.0, 151.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 57.0, 56.0, 57.0, 57.0, 56.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 83.0, 82.0, 81.0, 82.0, 86.0, 82.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 146.0, 141.0, 135.0, 141.0, 135.0, 133.0, 214.0, 134.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 197.0, 200.0, 201.0, 194.0, 196.0, 197.0, 197.0, 198.0, 200.0], "value": 198.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 71.0, 72.0, 74.0, 76.0, 72.0, 72.0, 71.0], "value": 72.5, "unit": "score"}]}]} 08:58:59 INFO - Return code: 0 08:58:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:58:59 INFO - # TBPL SUCCESS # 08:58:59 INFO - Running post-action listener: _resource_record_post_action 08:58:59 INFO - [mozharness: 2017-05-23 15:58:59.867384Z] Finished run-tests step (success) 08:58:59 INFO - Running post-run listener: _resource_record_post_run 08:58:59 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 618496; Write bytes: 315518976; Read time: 136; Write time: 271968 08:58:59 INFO - TinderboxPrint: CPU usage
13.3% 08:58:59 INFO - TinderboxPrint: I/O read bytes / time
618,496 / 136 08:58:59 INFO - TinderboxPrint: I/O write bytes / time
315,518,976 / 271,968 08:58:59 INFO - TinderboxPrint: CPU idle
8,290.8 (86.7%) 08:58:59 INFO - TinderboxPrint: CPU user
1,214.5 (12.7%) 08:58:59 INFO - TinderboxPrint: Swap in / out
0 / 0 08:58:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 9347072; Read time: 0; Write time: 5892 08:58:59 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 618496; Write bytes: 306171904; Read time: 136; Write time: 266076 08:59:00 INFO - Running post-run listener: _upload_blobber_files 08:59:00 INFO - Blob upload gear active. 08:59:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:00 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 08:59:00 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'] 08:59:00 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 08:59:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:59:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:59:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:01 INFO - (blobuploader) - INFO - Done attempting. 08:59:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:59:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:59:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:02 INFO - (blobuploader) - INFO - Done attempting. 08:59:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:59:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:04 INFO - (blobuploader) - INFO - Done attempting. 08:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:59:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:10 INFO - (blobuploader) - INFO - Done attempting. 08:59:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:59:10 INFO - Return code: 0 08:59:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:59:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:59:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7681a78d3fdae18109a472556a72193ae2d367938dd68061edff9c279e14e7ad7f5265dcaed513bde88c9a25ffbcd2eb71759b102ba2a770ec7af06b49152ed5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e05a3e19a9e0160b5f90fa0ba4e8cbea28a1b822e92c2e05de0540f1dc21b3cf7fd5af3c18f975d27c22edade5ec55a4167bd1ac17cfd27904ca98833c0cc9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dddddbc89c1c6dfaafc969c6aea43d1ef29a68ab352bc5aca5cbe662deacd4ca11cb337b810ce1cae6c5eec1617f8c47511e6d2748e315f0a61e54745ffb1a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/463c98295a54ceb4b2c2ff7079986244575a44fe36055b6459c0d56c44281e5f2c9e3c51a6c87faa9db4bef6f0270f0ce54e24f11382472cae0a075e5a171a64"} 08:59:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:59:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:59:10 INFO - Contents: 08:59:10 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7681a78d3fdae18109a472556a72193ae2d367938dd68061edff9c279e14e7ad7f5265dcaed513bde88c9a25ffbcd2eb71759b102ba2a770ec7af06b49152ed5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e05a3e19a9e0160b5f90fa0ba4e8cbea28a1b822e92c2e05de0540f1dc21b3cf7fd5af3c18f975d27c22edade5ec55a4167bd1ac17cfd27904ca98833c0cc9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dddddbc89c1c6dfaafc969c6aea43d1ef29a68ab352bc5aca5cbe662deacd4ca11cb337b810ce1cae6c5eec1617f8c47511e6d2748e315f0a61e54745ffb1a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/463c98295a54ceb4b2c2ff7079986244575a44fe36055b6459c0d56c44281e5f2c9e3c51a6c87faa9db4bef6f0270f0ce54e24f11382472cae0a075e5a171a64"} 08:59:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:59:10 INFO - Copying logs to upload dir... 08:59:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:59:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1392.192019 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 12 secs) (at 2017-05-23 08:59:10.104181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 08:59:10.108820) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7681a78d3fdae18109a472556a72193ae2d367938dd68061edff9c279e14e7ad7f5265dcaed513bde88c9a25ffbcd2eb71759b102ba2a770ec7af06b49152ed5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e05a3e19a9e0160b5f90fa0ba4e8cbea28a1b822e92c2e05de0540f1dc21b3cf7fd5af3c18f975d27c22edade5ec55a4167bd1ac17cfd27904ca98833c0cc9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dddddbc89c1c6dfaafc969c6aea43d1ef29a68ab352bc5aca5cbe662deacd4ca11cb337b810ce1cae6c5eec1617f8c47511e6d2748e315f0a61e54745ffb1a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/463c98295a54ceb4b2c2ff7079986244575a44fe36055b6459c0d56c44281e5f2c9e3c51a6c87faa9db4bef6f0270f0ce54e24f11382472cae0a075e5a171a64"} build_url:https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/UMsWKuWATVqMJBAdxe6L0Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7681a78d3fdae18109a472556a72193ae2d367938dd68061edff9c279e14e7ad7f5265dcaed513bde88c9a25ffbcd2eb71759b102ba2a770ec7af06b49152ed5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e05a3e19a9e0160b5f90fa0ba4e8cbea28a1b822e92c2e05de0540f1dc21b3cf7fd5af3c18f975d27c22edade5ec55a4167bd1ac17cfd27904ca98833c0cc9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dddddbc89c1c6dfaafc969c6aea43d1ef29a68ab352bc5aca5cbe662deacd4ca11cb337b810ce1cae6c5eec1617f8c47511e6d2748e315f0a61e54745ffb1a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/463c98295a54ceb4b2c2ff7079986244575a44fe36055b6459c0d56c44281e5f2c9e3c51a6c87faa9db4bef6f0270f0ce54e24f11382472cae0a075e5a171a64"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 08:59:10.132897) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:59:10.133246) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1495551697.502356-439778929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:59:10.215355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 08:59:10.218726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 08:59:10.219050) ========= ========= Total master_lag: 0.18 =========