builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1494981789.11 results: success (0) revision: 41958333867b0f537271dbd4cb4ba9e8a67a85a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:09.114516) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:09.114998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:09.115275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:09.136029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:09.139430) ========= 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=1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 17:43:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.1M=0s 2017-05-16 17:43:09 (31.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127664 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:09.279968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:09.280252) ========= 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=1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018798 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:09.337847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 17:43:09.338527) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 41958333867b0f537271dbd4cb4ba9e8a67a85a8 --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 41958333867b0f537271dbd4cb4ba9e8a67a85a8 --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=1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 17:43:10,106 truncating revision to first 12 chars 2017-05-16 17:43:10,106 Setting DEBUG logging. 2017-05-16 17:43:10,107 attempt 1/10 2017-05-16 17:43:10,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/41958333867b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 17:43:11,529 unpacking tar archive at: mozilla-central-41958333867b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.758168 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 17:43:11.112751) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:11.113055) ========= script_repo_revision: 41958333867b0f537271dbd4cb4ba9e8a67a85a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:11.116488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:11.116768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 17:43:11.126850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-16 17:43:11.127241) ========= /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=1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:43:11 INFO - MultiFileLogger online at 20170516 17:43:11 in /builds/slave/test 17:43:11 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 17:43:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:11 INFO - {'append_to_log': False, 17:43:11 INFO - 'base_work_dir': '/builds/slave/test', 17:43:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:43:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:11 INFO - 'branch': 'Firefox-Non-PGO', 17:43:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:11 INFO - 'config_files': ('talos/linux_config.py',), 17:43:11 INFO - 'default_actions': ('clobber', 17:43:11 INFO - 'read-buildbot-config', 17:43:11 INFO - 'download-and-extract', 17:43:11 INFO - 'populate-webroot', 17:43:11 INFO - 'create-virtualenv', 17:43:11 INFO - 'install', 17:43:11 INFO - 'run-tests'), 17:43:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:11 INFO - 'download_minidump_stackwalk': True, 17:43:11 INFO - 'download_symbols': 'ondemand', 17:43:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:11 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:11 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:11 INFO - 'gecko_profile': False, 17:43:11 INFO - 'gecko_profile_interval': 0, 17:43:11 INFO - 'installer_path': 'installer.exe', 17:43:11 INFO - 'log_level': 'info', 17:43:11 INFO - 'log_name': 'talos', 17:43:11 INFO - 'log_to_console': True, 17:43:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:43:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:43:11 INFO - 'opt_config_files': (), 17:43:11 INFO - 'pip_index': False, 17:43:11 INFO - 'suite': 'dromaeojs-e10s', 17:43:11 INFO - 'system_bits': '32', 17:43:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:11 INFO - 'title': 'talos-linux64-ix-027', 17:43:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:11 INFO - 'use_talos_json': True, 17:43:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:11 INFO - 'work_dir': 'build'} 17:43:11 INFO - [mozharness: 2017-05-17 00:43:11.992614Z] Running clobber step. 17:43:11 INFO - Running pre-action listener: _resource_record_pre_action 17:43:11 INFO - Running main action method: clobber 17:43:11 INFO - rmtree: /builds/slave/test/build 17:43:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:12 INFO - Running post-action listener: _resource_record_post_action 17:43:12 INFO - [mozharness: 2017-05-17 00:43:12.991036Z] Finished clobber step (success) 17:43:12 INFO - [mozharness: 2017-05-17 00:43:12.991136Z] Running read-buildbot-config step. 17:43:12 INFO - Running pre-action listener: _resource_record_pre_action 17:43:12 INFO - Running main action method: read_buildbot_config 17:43:12 INFO - Using buildbot properties: 17:43:12 INFO - { 17:43:12 INFO - "project": "", 17:43:12 INFO - "product": "firefox", 17:43:12 INFO - "who": "ryanvm@gmail.com", 17:43:12 INFO - "installer_path": "public/build/target.tar.bz2", 17:43:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:43:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:43:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:43:12 INFO - "stage_platform": "linux64", 17:43:12 INFO - "basedir": "/builds/slave/test", 17:43:12 INFO - "buildnumber": 609, 17:43:12 INFO - "platform": "ubuntu64_hw", 17:43:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:43:12 INFO - "slavebuilddir": "test", 17:43:12 INFO - "taskId": "HVNAhHCrQYuPY3m4pvYM3A", 17:43:12 INFO - "branch": "mozilla-central", 17:43:12 INFO - "script_repo_revision": "production", 17:43:12 INFO - "revision": "41958333867b0f537271dbd4cb4ba9e8a67a85a8", 17:43:12 INFO - "slavename": "talos-linux64-ix-027", 17:43:12 INFO - "repo_path": "mozilla-central" 17:43:12 INFO - } 17:43:12 INFO - Finding installer, test and symbols from parent task. 17:43:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVNAhHCrQYuPY3m4pvYM3A'}, attempt #1 17:43:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVNAhHCrQYuPY3m4pvYM3A'}, attempt #1 17:43:13 INFO - Task dependencies: O1TwBxoTRXKxEK1SCn9Txw 17:43:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw'}, attempt #1 17:43:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.tar.bz2 17:43:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/test_packages.json 17:43:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.crashreporter-symbols.zip 17:43:14 INFO - Running post-action listener: _resource_record_post_action 17:43:14 INFO - [mozharness: 2017-05-17 00:43:14.357326Z] Finished read-buildbot-config step (success) 17:43:14 INFO - [mozharness: 2017-05-17 00:43:14.357583Z] Running download-and-extract step. 17:43:14 INFO - Running pre-action listener: _resource_record_pre_action 17:43:14 INFO - Running main action method: download_and_extract 17:43:14 INFO - mkdir: /builds/slave/test/build/tests 17:43:14 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')]} 17:43:14 INFO - trying https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.test_packages.json 17:43:14 INFO - Downloading https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:43:14 INFO - Downloaded 986 bytes. 17:43:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:43:14 INFO - Using the following test package requirements: 17:43:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:43:14 INFO - u'common': [u'target.common.tests.zip'], 17:43:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:43:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:43:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:43:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:43:14 INFO - u'mozbase': [u'target.common.tests.zip'], 17:43:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:43:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:43:14 INFO - u'web-platform': [u'target.common.tests.zip', 17:43:14 INFO - u'target.web-platform.tests.zip'], 17:43:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:43:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:43:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.common.tests.zip 17:43:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:43:14 INFO - Fetch https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.common.tests.zip into memory 17:43:16 INFO - Content-Length response header: 62450171 17:43:16 INFO - Bytes received: 62450171 17:43:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:43:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.common.tests.zip 17:43:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:43:26 INFO - Fetch https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.common.tests.zip into memory 17:43:28 INFO - Content-Length response header: 62450171 17:43:28 INFO - Bytes received: 62450171 17:43:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.talos.tests.zip 17:43:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:43:40 INFO - Fetch https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.talos.tests.zip into memory 17:43:41 INFO - Content-Length response header: 14410069 17:43:41 INFO - Bytes received: 14410069 17:43:41 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')]} 17:43:41 INFO - trying https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.tar.bz2 17:43:41 INFO - Downloading https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:43:44 INFO - Downloaded 63397219 bytes. 17:43:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.tar.bz2 17:43:44 INFO - mkdir: /builds/slave/test/properties 17:43:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:44 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:44 INFO - Contents: 17:43:44 INFO - build_url:https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.tar.bz2 17:43:44 INFO - Running post-action listener: _resource_record_post_action 17:43:44 INFO - Running post-action listener: set_extra_try_arguments 17:43:44 INFO - [mozharness: 2017-05-17 00:43:44.706483Z] Finished download-and-extract step (success) 17:43:44 INFO - [mozharness: 2017-05-17 00:43:44.706711Z] Running populate-webroot step. 17:43:44 INFO - Running pre-action listener: _resource_record_pre_action 17:43:44 INFO - Running main action method: populate_webroot 17:43:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:44 INFO - '--tppagecycles', 17:43:44 INFO - '7'], 17:43:44 INFO - 'tests': ['tsvgm']}}, 17:43:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:43:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:43:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:43:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:43:44 INFO - 'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:43:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:43:44 INFO - 'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['damp', 'tps']}, 17:43:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:43:44 INFO - 'tests': ['damp', 'tps']}, 17:43:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['dromaeo_dom']}, 17:43:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:43:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:43:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:43:44 INFO - 'tests': ['ts_paint', 'tp5o']}, 17:43:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other-e10s': {'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:43:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:43:44 INFO - 'bloom_basic_ref']}, 17:43:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['tsvgx', 17:43:44 INFO - 'tsvgr_opacity', 17:43:44 INFO - 'tart', 17:43:44 INFO - 'tscrollx', 17:43:44 INFO - 'cart', 17:43:44 INFO - 'tsvg_static']}, 17:43:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:43:44 INFO - 'tsvgr_opacity', 17:43:44 INFO - 'tart', 17:43:44 INFO - 'tscrollx', 17:43:44 INFO - 'cart', 17:43:44 INFO - 'tsvg_static']}, 17:43:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:43:44 INFO - 'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['tp5o']}, 17:43:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:43:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:43:44 INFO - 'talos_options': ['--disable-e10s', 17:43:44 INFO - '--xperf_path', 17:43:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:44 INFO - 'tests': ['tp5n']}, 17:43:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:43:44 INFO - 'talos_options': ['--xperf_path', 17:43:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:44 INFO - 'tests': ['tp5n']}}, 17:43:44 INFO - 'talos.zip': {'path': '', 17:43:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:44 INFO - Running post-action listener: _resource_record_post_action 17:43:44 INFO - [mozharness: 2017-05-17 00:43:44.727192Z] Finished populate-webroot step (success) 17:43:44 INFO - [mozharness: 2017-05-17 00:43:44.727281Z] Running create-virtualenv step. 17:43:44 INFO - Running pre-action listener: _resource_record_pre_action 17:43:44 INFO - Running main action method: create_virtualenv 17:43:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:44 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 17:43:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:44 INFO - Using real prefix '/usr' 17:43:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:45 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:47 INFO - Installing pip.................done. 17:43:47 INFO - Return code: 0 17:43:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:43:47 INFO - Reading from file tmpfile_stdout 17:43:47 INFO - Output received: 17:43:47 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) 17:43:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:47 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')]} 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:47 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')]} 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:47 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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:43:47 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 17:43:47 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 17:43:47 INFO - Using env: {'DISPLAY': ':0', 17:43:47 INFO - 'HOME': '/home/cltbld', 17:43:47 INFO - 'LANG': 'en_US.UTF-8', 17:43:47 INFO - 'LANGUAGE': 'en_US:en', 17:43:47 INFO - 'LOGNAME': 'cltbld', 17:43:47 INFO - 'MAIL': '/var/mail/cltbld', 17:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:47 INFO - 'MOZ_NO_REMOTE': '1', 17:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:47 INFO - 'NO_EM_RESTART': '1', 17:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:47 INFO - 'PWD': '/builds/slave/test', 17:43:47 INFO - 'SHELL': '/bin/bash', 17:43:47 INFO - 'SHLVL': '1', 17:43:47 INFO - 'TERM': 'linux', 17:43:47 INFO - 'TMOUT': '86400', 17:43:47 INFO - 'USER': 'cltbld', 17:43:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:47 INFO - '_': '/tools/buildbot/bin/python'} 17:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:47 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 17:43:47 INFO - Cleaning up... 17:43:47 INFO - Return code: 0 17:43:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:43:47 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')]} 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:47 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')]} 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:47 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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:43:47 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 17:43:47 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 17:43:47 INFO - Using env: {'DISPLAY': ':0', 17:43:47 INFO - 'HOME': '/home/cltbld', 17:43:47 INFO - 'LANG': 'en_US.UTF-8', 17:43:47 INFO - 'LANGUAGE': 'en_US:en', 17:43:47 INFO - 'LOGNAME': 'cltbld', 17:43:47 INFO - 'MAIL': '/var/mail/cltbld', 17:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:47 INFO - 'MOZ_NO_REMOTE': '1', 17:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:47 INFO - 'NO_EM_RESTART': '1', 17:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:47 INFO - 'PWD': '/builds/slave/test', 17:43:47 INFO - 'SHELL': '/bin/bash', 17:43:47 INFO - 'SHLVL': '1', 17:43:47 INFO - 'TERM': 'linux', 17:43:47 INFO - 'TMOUT': '86400', 17:43:47 INFO - 'USER': 'cltbld', 17:43:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:47 INFO - '_': '/tools/buildbot/bin/python'} 17:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:47 INFO - Downloading/unpacking psutil>=3.1.1 17:43:47 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 17:43:47 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 17:43:47 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 17:43:47 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 17:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:49 INFO - Installing collected packages: psutil 17:43:49 INFO - Running setup.py install for psutil 17:43:49 INFO - building 'psutil._psutil_linux' extension 17:43:49 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 17:43:49 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 17:43:49 INFO - building 'psutil._psutil_posix' extension 17:43:49 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 17:43:49 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 17:43:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:49 INFO - Successfully installed psutil 17:43:49 INFO - Cleaning up... 17:43:49 INFO - Return code: 0 17:43:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43: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')]} 17:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:49 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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:43:49 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 17:43:49 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 17:43:49 INFO - Using env: {'DISPLAY': ':0', 17:43:49 INFO - 'HOME': '/home/cltbld', 17:43:49 INFO - 'LANG': 'en_US.UTF-8', 17:43:49 INFO - 'LANGUAGE': 'en_US:en', 17:43:49 INFO - 'LOGNAME': 'cltbld', 17:43:49 INFO - 'MAIL': '/var/mail/cltbld', 17:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:49 INFO - 'MOZ_NO_REMOTE': '1', 17:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:49 INFO - 'NO_EM_RESTART': '1', 17:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:49 INFO - 'PWD': '/builds/slave/test', 17:43:49 INFO - 'SHELL': '/bin/bash', 17:43:49 INFO - 'SHLVL': '1', 17:43:49 INFO - 'TERM': 'linux', 17:43:49 INFO - 'TMOUT': '86400', 17:43:49 INFO - 'USER': 'cltbld', 17:43:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:49 INFO - '_': '/tools/buildbot/bin/python'} 17:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:43:49 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 17:43:49 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 17:43:49 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 17:43:49 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 17:43:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:43:51 INFO - Installing collected packages: mozsystemmonitor 17:43:51 INFO - Running setup.py install for mozsystemmonitor 17:43:51 INFO - Successfully installed mozsystemmonitor 17:43:51 INFO - Cleaning up... 17:43:51 INFO - Return code: 0 17:43:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43: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')]} 17:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43: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', '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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:43: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:43: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 jsonschema==2.5.1 17:43:51 INFO - Using env: {'DISPLAY': ':0', 17:43:51 INFO - 'HOME': '/home/cltbld', 17:43:51 INFO - 'LANG': 'en_US.UTF-8', 17:43:51 INFO - 'LANGUAGE': 'en_US:en', 17:43:51 INFO - 'LOGNAME': 'cltbld', 17:43:51 INFO - 'MAIL': '/var/mail/cltbld', 17:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:51 INFO - 'MOZ_NO_REMOTE': '1', 17:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:51 INFO - 'NO_EM_RESTART': '1', 17:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:51 INFO - 'PWD': '/builds/slave/test', 17:43:51 INFO - 'SHELL': '/bin/bash', 17:43:51 INFO - 'SHLVL': '1', 17:43:51 INFO - 'TERM': 'linux', 17:43:51 INFO - 'TMOUT': '86400', 17:43:51 INFO - 'USER': 'cltbld', 17:43:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:51 INFO - '_': '/tools/buildbot/bin/python'} 17:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:51 INFO - Downloading/unpacking jsonschema==2.5.1 17:43: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 17:43: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 17:43: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 17:43: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 17:43:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:43:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:43: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 17:43: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 17:43: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 17:43: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 17:43:52 INFO - Downloading functools32-3.2.3-2.tar.gz 17:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:43:52 INFO - warning: no files found matching '*.txt' 17:43:52 INFO - no previously-included directories found matching 'build' 17:43:52 INFO - no previously-included directories found matching 'dist' 17:43:52 INFO - no previously-included directories found matching '.git*' 17:43:52 INFO - Installing collected packages: jsonschema, functools32 17:43:52 INFO - Running setup.py install for functools32 17:43:52 INFO - warning: no files found matching '*.txt' 17:43:52 INFO - no previously-included directories found matching 'build' 17:43:52 INFO - no previously-included directories found matching 'dist' 17:43:52 INFO - no previously-included directories found matching '.git*' 17:43:52 INFO - Successfully installed jsonschema functools32 17:43:52 INFO - Cleaning up... 17:43:52 INFO - Return code: 0 17:43:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:52 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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:43:52 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 17:43:52 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 17:43:52 INFO - Using env: {'DISPLAY': ':0', 17:43:52 INFO - 'HOME': '/home/cltbld', 17:43:52 INFO - 'LANG': 'en_US.UTF-8', 17:43:52 INFO - 'LANGUAGE': 'en_US:en', 17:43:52 INFO - 'LOGNAME': 'cltbld', 17:43:52 INFO - 'MAIL': '/var/mail/cltbld', 17:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:52 INFO - 'MOZ_NO_REMOTE': '1', 17:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:52 INFO - 'NO_EM_RESTART': '1', 17:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:52 INFO - 'PWD': '/builds/slave/test', 17:43:52 INFO - 'SHELL': '/bin/bash', 17:43:52 INFO - 'SHLVL': '1', 17:43:52 INFO - 'TERM': 'linux', 17:43:52 INFO - 'TMOUT': '86400', 17:43:52 INFO - 'USER': 'cltbld', 17:43:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:52 INFO - '_': '/tools/buildbot/bin/python'} 17:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:43:53 INFO - Cleaning up... 17:43:53 INFO - Return code: 0 17:43:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:43:53 INFO - Using env: {'DISPLAY': ':0', 17:43:53 INFO - 'HOME': '/home/cltbld', 17:43:53 INFO - 'LANG': 'en_US.UTF-8', 17:43:53 INFO - 'LANGUAGE': 'en_US:en', 17:43:53 INFO - 'LOGNAME': 'cltbld', 17:43:53 INFO - 'MAIL': '/var/mail/cltbld', 17:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:53 INFO - 'MOZ_NO_REMOTE': '1', 17:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:53 INFO - 'NO_EM_RESTART': '1', 17:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:53 INFO - 'PWD': '/builds/slave/test', 17:43:53 INFO - 'SHELL': '/bin/bash', 17:43:53 INFO - 'SHLVL': '1', 17:43:53 INFO - 'TERM': 'linux', 17:43:53 INFO - 'TMOUT': '86400', 17:43:53 INFO - 'USER': 'cltbld', 17:43:53 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:53 INFO - '_': '/tools/buildbot/bin/python'} 17:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:53 INFO - Downloading/unpacking blobuploader==1.2.4 17:43: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 17:43: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 17:43: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 17:43: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 17:43:54 INFO - Downloading blobuploader-1.2.4.tar.gz 17:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:43:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:43:54 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 17:43:54 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 17:43:54 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 17:43:54 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 17:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:43:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:43:54 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 17:43:54 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 17:43:54 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 17:43:54 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 17:43:54 INFO - Downloading docopt-0.6.1.tar.gz 17:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:43:54 INFO - Installing collected packages: blobuploader, requests, docopt 17:43:54 INFO - Running setup.py install for blobuploader 17:43:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:43:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:43:55 INFO - Running setup.py install for requests 17:43:55 INFO - Running setup.py install for docopt 17:43:55 INFO - Successfully installed blobuploader requests docopt 17:43:55 INFO - Cleaning up... 17:43:55 INFO - Return code: 0 17:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:55 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')]} 17:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:55 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')]} 17:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:55 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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:43:55 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 17:43:55 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 17:43:55 INFO - Using env: {'DISPLAY': ':0', 17:43:55 INFO - 'HOME': '/home/cltbld', 17:43:55 INFO - 'LANG': 'en_US.UTF-8', 17:43:55 INFO - 'LANGUAGE': 'en_US:en', 17:43:55 INFO - 'LOGNAME': 'cltbld', 17:43:55 INFO - 'MAIL': '/var/mail/cltbld', 17:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:55 INFO - 'MOZ_NO_REMOTE': '1', 17:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:55 INFO - 'NO_EM_RESTART': '1', 17:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:55 INFO - 'PWD': '/builds/slave/test', 17:43:55 INFO - 'SHELL': '/bin/bash', 17:43:55 INFO - 'SHLVL': '1', 17:43:55 INFO - 'TERM': 'linux', 17:43:55 INFO - 'TMOUT': '86400', 17:43:55 INFO - 'USER': 'cltbld', 17:43:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:55 INFO - '_': '/tools/buildbot/bin/python'} 17:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:55 INFO - Running setup.py (path:/tmp/pip-j2uTh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:55 INFO - Running setup.py (path:/tmp/pip-H06S6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:55 INFO - Running setup.py (path:/tmp/pip-fqqviD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:55 INFO - Running setup.py (path:/tmp/pip-6v54r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:56 INFO - Running setup.py (path:/tmp/pip-4kimkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:56 INFO - Running setup.py (path:/tmp/pip-5c9IIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:56 INFO - Running setup.py (path:/tmp/pip-ATUg1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:56 INFO - Running setup.py (path:/tmp/pip-3YeySW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:56 INFO - Running setup.py (path:/tmp/pip-IUdgmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:56 INFO - Running setup.py (path:/tmp/pip-HkMjgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:56 INFO - Running setup.py (path:/tmp/pip-0fJdX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:56 INFO - Running setup.py (path:/tmp/pip-uddRNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:56 INFO - Running setup.py (path:/tmp/pip-WGd65y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:56 INFO - Running setup.py (path:/tmp/pip-8GzvRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:56 INFO - Running setup.py (path:/tmp/pip-ckJzWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:56 INFO - Running setup.py (path:/tmp/pip-xOInf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:56 INFO - Running setup.py (path:/tmp/pip-5uop5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:56 INFO - Running setup.py install for manifestparser 17:43:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozcrash 17:43:57 INFO - Running setup.py install for mozdebug 17:43:57 INFO - Running setup.py install for mozdevice 17:43:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozfile 17:43:57 INFO - Running setup.py install for mozhttpd 17:43:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozinfo 17:43:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozInstall 17:43:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozleak 17:43:57 INFO - Running setup.py install for mozlog 17:43:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for moznetwork 17:43:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Running setup.py install for mozprocess 17:43:58 INFO - Running setup.py install for mozprofile 17:43:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Running setup.py install for mozrunner 17:43:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Running setup.py install for mozscreenshot 17:43:58 INFO - Running setup.py install for moztest 17:43:58 INFO - Running setup.py install for mozversion 17:43:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:58 INFO - Cleaning up... 17:43:58 INFO - Return code: 0 17:43:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:58 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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:43:58 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 17:43:58 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 17:43:58 INFO - Using env: {'DISPLAY': ':0', 17:43:58 INFO - 'HOME': '/home/cltbld', 17:43:58 INFO - 'LANG': 'en_US.UTF-8', 17:43:58 INFO - 'LANGUAGE': 'en_US:en', 17:43:58 INFO - 'LOGNAME': 'cltbld', 17:43:58 INFO - 'MAIL': '/var/mail/cltbld', 17:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:58 INFO - 'MOZ_NO_REMOTE': '1', 17:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:58 INFO - 'NO_EM_RESTART': '1', 17:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:58 INFO - 'PWD': '/builds/slave/test', 17:43:58 INFO - 'SHELL': '/bin/bash', 17:43:58 INFO - 'SHLVL': '1', 17:43:58 INFO - 'TERM': 'linux', 17:43:58 INFO - 'TMOUT': '86400', 17:43:58 INFO - 'USER': 'cltbld', 17:43:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:58 INFO - '_': '/tools/buildbot/bin/python'} 17:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:58 INFO - Running setup.py (path:/tmp/pip-rim43p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:59 INFO - Running setup.py (path:/tmp/pip-Rsz2E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:59 INFO - Running setup.py (path:/tmp/pip-ahABKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:59 INFO - Running setup.py (path:/tmp/pip-Wc3oGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:59 INFO - Running setup.py (path:/tmp/pip-K3P9_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:59 INFO - Running setup.py (path:/tmp/pip-AYmoiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:59 INFO - Running setup.py (path:/tmp/pip-Q9U1tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:59 INFO - Running setup.py (path:/tmp/pip-ADr4K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:59 INFO - Running setup.py (path:/tmp/pip-N9Uv8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:59 INFO - Running setup.py (path:/tmp/pip-WsmLE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:59 INFO - Running setup.py (path:/tmp/pip-EZjb3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:59 INFO - Running setup.py (path:/tmp/pip-6TeX59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:59 INFO - Running setup.py (path:/tmp/pip-nw6XqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:59 INFO - Running setup.py (path:/tmp/pip-xReDuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:59 INFO - Running setup.py (path:/tmp/pip-1ByApT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:00 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)) 17:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:00 INFO - Running setup.py (path:/tmp/pip-RKRW_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:00 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)) 17:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:00 INFO - Running setup.py (path:/tmp/pip-LHQxVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:01 INFO - Downloading blessings-1.6.tar.gz 17:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:01 INFO - Installing collected packages: blessings 17:44:01 INFO - Running setup.py install for blessings 17:44:01 INFO - Successfully installed blessings 17:44:01 INFO - Cleaning up... 17:44:01 INFO - Return code: 0 17:44:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:01 INFO - Reading from file tmpfile_stdout 17:44:01 INFO - Current package versions: 17:44:01 INFO - argparse == 1.2.1 17:44:01 INFO - blessings == 1.6 17:44:01 INFO - blobuploader == 1.2.4 17:44:01 INFO - docopt == 0.6.1 17:44:01 INFO - functools32 == 3.2.3-2 17:44:01 INFO - jsonschema == 2.5.1 17:44:01 INFO - manifestparser == 1.1 17:44:01 INFO - mozInstall == 1.12 17:44:01 INFO - mozcrash == 1.0 17:44:01 INFO - mozdebug == 0.1 17:44:01 INFO - mozdevice == 0.50 17:44:01 INFO - mozfile == 1.2 17:44:01 INFO - mozhttpd == 0.7 17:44:01 INFO - mozinfo == 0.9 17:44:01 INFO - mozleak == 0.1 17:44:01 INFO - mozlog == 3.4 17:44:01 INFO - moznetwork == 0.27 17:44:01 INFO - mozprocess == 0.25 17:44:01 INFO - mozprofile == 0.28 17:44:01 INFO - mozrunner == 6.13 17:44:01 INFO - mozscreenshot == 0.1 17:44:01 INFO - mozsystemmonitor == 0.3 17:44:01 INFO - moztest == 0.8 17:44:01 INFO - mozversion == 1.4 17:44:01 INFO - psutil == 3.1.1 17:44:01 INFO - requests == 1.2.3 17:44:01 INFO - wsgiref == 0.1.2 17:44:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44: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')]} 17:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:01 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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:44:01 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 17:44:01 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 17:44:01 INFO - Using env: {'DISPLAY': ':0', 17:44:01 INFO - 'HOME': '/home/cltbld', 17:44:01 INFO - 'LANG': 'en_US.UTF-8', 17:44:01 INFO - 'LANGUAGE': 'en_US:en', 17:44:01 INFO - 'LOGNAME': 'cltbld', 17:44:01 INFO - 'MAIL': '/var/mail/cltbld', 17:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:01 INFO - 'MOZ_NO_REMOTE': '1', 17:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:01 INFO - 'NO_EM_RESTART': '1', 17:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:01 INFO - 'PWD': '/builds/slave/test', 17:44:01 INFO - 'SHELL': '/bin/bash', 17:44:01 INFO - 'SHLVL': '1', 17:44:01 INFO - 'TERM': 'linux', 17:44:01 INFO - 'TMOUT': '86400', 17:44:01 INFO - 'USER': 'cltbld', 17:44:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:01 INFO - '_': '/tools/buildbot/bin/python'} 17:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44: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)) 17:44: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)) 17:44: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)) 17:44: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)) 17:44: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)) 17:44: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)) 17:44: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)) 17:44: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)) 17:44: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)) 17:44: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)) 17:44: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)) 17:44:01 INFO - Cleaning up... 17:44:01 INFO - Return code: 0 17:44:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44: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')]} 17:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44: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 0x28541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, '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': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', '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 17:44: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 17:44: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 17:44:01 INFO - Using env: {'DISPLAY': ':0', 17:44:01 INFO - 'HOME': '/home/cltbld', 17:44:01 INFO - 'LANG': 'en_US.UTF-8', 17:44:01 INFO - 'LANGUAGE': 'en_US:en', 17:44:01 INFO - 'LOGNAME': 'cltbld', 17:44:01 INFO - 'MAIL': '/var/mail/cltbld', 17:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:01 INFO - 'MOZ_NO_REMOTE': '1', 17:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:01 INFO - 'NO_EM_RESTART': '1', 17:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:01 INFO - 'PWD': '/builds/slave/test', 17:44:01 INFO - 'SHELL': '/bin/bash', 17:44:01 INFO - 'SHLVL': '1', 17:44:01 INFO - 'TERM': 'linux', 17:44:01 INFO - 'TMOUT': '86400', 17:44:01 INFO - 'USER': 'cltbld', 17:44:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:01 INFO - '_': '/tools/buildbot/bin/python'} 17:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:02 INFO - Cleaning up... 17:44:02 INFO - Return code: 0 17:44:02 INFO - Running post-action listener: _resource_record_post_action 17:44:02 INFO - Running post-action listener: _start_resource_monitoring 17:44:02 INFO - Starting resource monitoring. 17:44:02 INFO - [mozharness: 2017-05-17 00:44:02.204558Z] Finished create-virtualenv step (success) 17:44:02 INFO - [mozharness: 2017-05-17 00:44:02.205017Z] Running install step. 17:44:02 INFO - Running pre-action listener: _resource_record_pre_action 17:44:02 INFO - Running main action method: install 17:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:02 INFO - Reading from file tmpfile_stdout 17:44:02 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:02 INFO - Reading from file tmpfile_stdout 17:44:02 INFO - Output received: 17:44:02 INFO - Usage: mozinstall [options] installer 17:44:02 INFO - Options: 17:44:02 INFO - -h, --help show this help message and exit 17:44:02 INFO - -d DEST, --destination=DEST 17:44:02 INFO - Directory to install application into. [default: 17:44:02 INFO - "/builds/slave/test"] 17:44:02 INFO - --app=APP Application being installed. [default: firefox] 17:44:02 INFO - mkdir: /builds/slave/test/build/application 17:44:02 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'] 17:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:44:18 INFO - Reading from file tmpfile_stdout 17:44:18 INFO - Output received: 17:44:18 INFO - /builds/slave/test/build/application/firefox/firefox 17:44:18 INFO - Running post-action listener: _resource_record_post_action 17:44:18 INFO - [mozharness: 2017-05-17 00:44:18.404605Z] Finished install step (success) 17:44:18 INFO - [mozharness: 2017-05-17 00:44:18.404897Z] Running run-tests step. 17:44:18 INFO - Running pre-action listener: _resource_record_pre_action 17:44:18 INFO - Running main action method: run_tests 17:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:18 INFO - Python 2.7.3 17:44:18 INFO - Return code: 0 17:44:18 INFO - grabbing minidump binary from tooltool 17:44:18 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')]} 17:44:18 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 0x2bc47a0>, '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 0x2bc56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:18 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 17:44:18 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 17:44:18 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 17:44:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:18 INFO - Return code: 0 17:44:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:44:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:18 INFO - ENV: RUST_BACKTRACE is now 1 17:44:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:44:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:18 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/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:44:18 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/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 17:44:18 INFO - Using env: {'DISPLAY': ':0', 17:44:18 INFO - 'HOME': '/home/cltbld', 17:44:18 INFO - 'LANG': 'en_US.UTF-8', 17:44:18 INFO - 'LANGUAGE': 'en_US:en', 17:44:18 INFO - 'LOGNAME': 'cltbld', 17:44:18 INFO - 'MAIL': '/var/mail/cltbld', 17:44:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:18 INFO - 'MOZ_NO_REMOTE': '1', 17:44:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:18 INFO - 'NO_EM_RESTART': '1', 17:44:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:18 INFO - 'PWD': '/builds/slave/test', 17:44:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:18 INFO - 'RUST_BACKTRACE': '1', 17:44:18 INFO - 'SHELL': '/bin/bash', 17:44:18 INFO - 'SHLVL': '1', 17:44:18 INFO - 'TERM': 'linux', 17:44:18 INFO - 'TMOUT': '86400', 17:44:18 INFO - 'USER': 'cltbld', 17:44:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057', 17:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:18 INFO - '_': '/tools/buildbot/bin/python'} 17:44:18 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/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:44:18 INFO - mozversion application_buildid: 20170517001032 17:44:18 INFO - mozversion application_changeset: 41958333867b0f537271dbd4cb4ba9e8a67a85a8 17:44:18 INFO - mozversion application_display_name: Nightly 17:44:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:18 INFO - mozversion application_name: Firefox 17:44:18 INFO - mozversion application_remotingname: firefox 17:44:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:44:18 INFO - mozversion application_vendor: Mozilla 17:44:18 INFO - mozversion application_version: 55.0a1 17:44:18 INFO - mozversion platform_buildid: 20170517001032 17:44:18 INFO - mozversion platform_changeset: 41958333867b0f537271dbd4cb4ba9e8a67a85a8 17:44:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:44:18 INFO - mozversion platform_version: 55.0a1 17:44:18 INFO - using testdate: 1494981858 17:44:18 INFO - actual date: 1494981858 17:44:18 INFO - starting webserver on 'localhost:53025' 17:44:18 INFO - SUITE-START | Running 2 tests 17:44:18 INFO - TEST-START | dromaeo_css 17:44:18 INFO - operating with platform_type : linux_ 17:44:18 INFO - Initialising browser for dromaeo_css test... 17:44:18 INFO - TEST-INFO | started process 26657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb1gYGQ/profile http://localhost:53025/getInfo.html) 17:44:19 INFO - PID 26657 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 17:44:22 INFO - PID 26657 | __metrics Screen width/height:1600/1200 17:44:22 INFO - PID 26657 | colorDepth:24 17:44:22 INFO - PID 26657 | Browser inner width/height: 1024/695 17:44:22 INFO - PID 26657 | __metrics 17:44:24 INFO - TEST-INFO | 26657: exit 0 17:44:24 INFO - Browser initialized. 17:44:24 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:24 INFO - TEST-INFO | started process 26825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb1gYGQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:35 INFO - PID 26825 | RSS: Main: 161513472 17:44:35 INFO - PID 26825 | 17:47:40 INFO - PID 26825 | Cycle 1(1): loaded http://localhost:53025/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53025/tests/dromaeo/cssquery-ext.html) 17:47:43 INFO - PID 26825 | RSS: Main: 167976960 17:47:43 INFO - PID 26825 | 17:50:45 INFO - PID 26825 | Cycle 1(1): loaded http://localhost:53025/tests/dromaeo/cssquery-ext.html (next: http://localhost:53025/tests/dromaeo/cssquery-jquery.html) 17:50:46 INFO - PID 26825 | RSS: Main: 167456768 17:50:46 INFO - PID 26825 | 17:53:48 INFO - PID 26825 | Cycle 1(1): loaded http://localhost:53025/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53025/tests/dromaeo/cssquery-mootools.html) 17:53:48 INFO - PID 26825 | RSS: Main: 170881024 17:53:48 INFO - PID 26825 | 17:56:50 INFO - PID 26825 | Cycle 1(1): loaded http://localhost:53025/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53025/tests/dromaeo/cssquery-prototype.html) 17:56:51 INFO - PID 26825 | RSS: Main: 167198720 17:56:51 INFO - PID 26825 | 17:59:53 INFO - PID 26825 | Cycle 1(1): loaded http://localhost:53025/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53025/tests/dromaeo/cssquery-yui.html) 17:59:54 INFO - PID 26825 | RSS: Main: 166666240 17:59:54 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | Cycle 1(1): loaded http://localhost:53025/tests/dromaeo/cssquery-yui.html (next: http://localhost:53025/tests/dromaeo/cssquery-dojo.html) 18:02:56 INFO - PID 26825 | RSS: Main: 175837184 18:02:56 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | __start_tp_report 18:02:56 INFO - PID 26825 | _x_x_mozilla_page_load 18:02:56 INFO - PID 26825 | _x_x_mozilla_page_load_details 18:02:56 INFO - PID 26825 | |i|pagename|runs| 18:02:56 INFO - PID 26825 | |0;dojo.html;2713.1724823928707;2713.8100332976674;2737.3430376709593;2743.2593199836056;2749.9312517187072;5094.872628184297;5105.055564720529;5130.666506677064;5156.071907056728;5180.404253510843;5171.250168725542;5225.503577160173;5232.816851410202;5253.080710875591;5258.737063146837;4590.586847183753;4624.14453326134;4655.138799322136;4696.483386827446;4698.671093023489;4606.239970404896;4622.907541849161;4641.721496710191;4656.045510670321;4715.3162791395225;4577.702449340783;4602.585767280961;4647.9535204647855;4649.000464900046;4670.299455081731;4603.401557797499;4625.537446255347;4647.024124933734;4671.813127474897;4681.672282940195;4550.317452382136;4597.977010114962;4601.102784956935;4612.331211974245;4662.6269898408045;5104.566111880495;5179.663321884103;5191;5195.896082078338;5239.842804715865;5555.333359996826;5555.472230138171;5647.43525647436;5664.150377443417;5682.090865461548;5661.433856614347;5663.631863928873;5671.262735844314;5687.118496633028;5736.856578585527;5255.474452554752;5259.079661059376;5267.367915850123;5276.472352764769;5340;5605;5656.632318899258;5678.205051292823;5680.460356266148;5788.82633520995;5481.342238931274;5490.368607610176;5554.861128471821;5557.110862262019;5568.025595520768;5655.519280861091;5704.229928959538;5719.799807006735;5730.598858079978;5734.942650573525;5616.69108199053;5632.070708333161;5640.182173584807;5647.49172574462;5651.039323314964;5607.971960140255;5624.606277560613;5635.267415235993;5639.041362968305;5641.492265696107;4548.636109111263;4602.240630296031;4612;4650.465196502446;4653.115907977473;3961.8217180226384;3977.2642061218767;3983;4018.0557568971267;4031.254217969685;4795.160846851787;4798.640101992295;4801.135795556834;4808.471068182497;4828.227483602677;5529.612927095145;5580.2745643066955;5663.66018038919;5667.951428985651;5713.428657134254;4818.084563932842;4833.975830120898;4834.661573689878;4841.588464980446;4877.829275975324;4916.680415772963;4954.677945933503;4957.355543779286;4974.477679843637;5019.447860735243;5228.921566176587;5247.842564723064;5284.9471505284455;5310.867228319323;5319.867003324948;5623.803166889139;5634.492895639412;5635.154726791015;5661.122526008476;5694.174344720075;5234.816781412632;5260.710660913686;5288.7355632219005;5289.074411977966;5292.867678307919;5509.5041446270025;5529.364123125892;5566.888662226814;5592.524635406036;5595.132754423071;5675.517581005661;5680.204771331934;5688;5690.829275121753;5694.601377903507;5404.675719456845;5505.339359276913;5509.173623956439;5510.311211098613;5514.448555144614;5417.377001644862;5450.345958485007;5455.563554915677;5466.098093814635;5498.092814685532;5304.336957880265;5393.6763794172475;5394.1099718546;5402.837914862561;5413.10683737179;5508.228847961209;5508.283923089973;5508.641938274;5518.365387980433;5528.502434780889;5211.270422140828;5373.758180881791;5378.865528361822;5379.54273886724;5384.057789886832 18:02:56 INFO - PID 26825 | |1;ext.html;727.0729819480163;750.2235186581889;1143.8055530559805;1154.2209008918978;1189.0428205294734;32864.83567582162;33411.832940835324;33436;33506.1623459413;33552.32895342092;32093.51859722106;32462.67537324626;32518.187045323877;32540.837295813486;32576.67423325766;6475.935240647604;6747.359000894907;6880.655967201645;6909.170899492068;6916.619585922772;6777.2545020048;6795.626240556768;6852.725890964381;6857.485688573352;6860.931390686104;6828.6927088281145;6836.794896153098;6892.758753443631;6903.551269167513;6907.758228462005;6774.356436138559;6806.727730890759;6824.078749368821;6829.385355317995;6868.347506986828;6798.286179951084;6840.521163518556;6842;6843.0419741236265;6849.2465828758795;30210.69789302101;30267.09198724042;30356.241093972607;30379.544306835192;30520;2841.5737639354056;2900.0429858146763;2900.318425170083;2911.4177164567172;2912.3738396244908;23581.292561223017;23595.528089438114;23662.17182398608;23706.407339816644;23758.881205594033;3091.48990416581;3101.7673674474504;3126.4059828632485;3151.889683861054;3152.1489197916435;144580;144592.2770386152;144641;145042;145322;35064;37682.62317376846;37808.24383512315;37920.620793791706;38003.619963800564;39051.82844514669;39098.60901391006;39202;39224.41163382552;39230;12259.57091501811;12262.509499619915;12273.447694853752;12286.631401057983;12381.690457738629;9854.11312981835;9866.80266394668;9870.703878883645;9909.355891867006;9947.502624868728;11795.233309835005;11797.941010295066;11851.940740296242;11939.343336116423;12128.69678258033;5000.199968005102;5033.974830125826;5227.3988491323225;5252.816151434681;5287.656302340336;867.9392442529089;891.3938521805105;902.4089221559889;914.5792935249726;931.3108299858056;20071.698924516142;20250.493737656678;20918.26786062511;20933.26733564318;21049.368518944455;977.237754551451;985.2905907746555;988.3081842710131;991.7966816802539;999.1058003087196;10347.482625868826;10548.683539493828;10841.620543280947;10877.129829613612;11034.889651103547;170014;170066;170428;170486;170564;37368.25263494715;37730.245395091944;37851.43222851659;37881.62118378781;37898.81050594785;1191.7139886427194;1204.3616883051996;1207.9033677305795;1214.6295379909213;1217.11150859871;19031;19373.128209230337;19992.300269490497;20112.698309525662;20562.177512899318;27645.447091057664;27708.445831083667;27739;27807.721922780514;27881.581776272968;141868;143175;143176;143421;144097;27039.594406084318;27132.457350852477;27449.86275068612;28280.71719282863;28478;33271;33664.108780963725;33870.83064584661;34011;34226;25569.872150639127;25733.3566660835;25784;26313.73686263113;27052.864735676983;25537.87231063833;25832.354191145372;26075.608865867405;27146.592801108392;27442.47416085209;28764.712352876202;29536.556951646173;29581.408371832873;30007.69992300049;30100.54849177308;26213.344666383495;26257.868710656323;26526.5410402422;26656.733432665424;26878.596821047307;19401;21826.126954921627;21917;21951.890240549335;21961.121555137615 18:02:56 INFO - PID 26825 | |2;jquery.html;409.6784024540736;413.3365947654017;430.3673599808281;435.1970614216769;437.8445651793614;13829.446822127127;16617.58456038598;17247.137643117825;17351.479455616336;17352.392666256685;17645.647087058253;17928.551786205353;18212.180451879663;18706.53233669159;18756.968366739824;5277.393099793515;5340.49265319794;5506.174073888908;5526.281583394153;5544.667319960795;5420;5495.780168793243;5517.613767036309;5532.1425179097105;5534.225208470817;5250.343707036621;5439.5104440600335;5451.890962180754;5464.590155738316;5540.113581826909;5385.81149659762;5419.132938729785;5434.701091439969;5439.265699130626;5455.863603409926;4775.665703400763;4928.359313289286;4940.901181976376;4952.653314268003;4974.900501989976;20522.281720139872;21143.788562114336;21550.568988620296;21593.568128637497;21716.565668686537;1623.2127418202163;1666.7833181686303;1673.4059408909784;1673.983260167395;1678.924448399825;14565.417383304655;14846.406143754344;15003.1748253846;15106.697866042727;15286.388544458208;2076.179908935977;2100.2859027930576;2129.084493667722;2147.4094623978376;2174.7825217478285;78740;78896.81654775183;79054.604726976;80318.59840700818;80376.19623803746;10924.836127458095;11091.667249982513;11155.609553665583;11244.49399777012;11574.537018519333;15489.457868974758;15497;15592.142432166112;15606.84393156054;15609.921950390175;7386.113666360071;7403.85192296151;7447.813804654818;7634.083909930844;7646.847063058819;6673.399394054559;6708.396244338033;6855.691493882788;6855.862882742417;6890.965545172342;7204.603746793977;7385.3722433592675;7387.81530461732;7388.261173882676;7402.1117465904435;2181.4001149683645;2192.9122835086737;2205.1730601024615;2211.7677643847487;2321.1063740460045;834.5743670727973;869.4696235296464;870.0690261420347;870.3733312015339;892.3842548641417;16200.837991620168;16236.80041578995;16502.092384918946;16957.915210423867;17011.31954721822;865.5758678247613;873.5806812729925;877.4121338703085;879.2634546770078;889.6797153024905;8731.432456890281;9201.171894529525;9226.58480368385;9318.534073296309;10863.891361086446;360218;361605;368510;373991;376357;78311;79824.20175798167;81250.59374703089;81615.5919220412;82297.17702822895;1054.8417737339307;1067.2795862792584;1097.3032124600936;1102.7739313440725;1110.8944650258213;16972.915135424242;17317.913410432866;17759.73360399621;17808.3767068152;17884.374046908295;38464.2307153861;38806.41790373203;39600.80199599099;39838.203235935696;40358.596414036656;48991.51008489869;49531.54216120567;51021.7448912753;51555.22667160071;52305.21542176794;7978.84042319162;8059.83880322402;8293.83412331762;8456.746297611082;8535.146485351663;12632.494700211888;12774.552890648783;12817.42321595549;12849.164804287691;13165.47338106465;10884.510197040994;11147.498362573542;11158.776824463303;11175.49710263024;11578.434395170287;9920.156786672926;10157.136643385395;10275.075243228146;10410.73973150647;10446.52990615409;10828.783424331627;10851.565937362733;10867.239293249397;11236.831447528457;11493.597724079616;7891.921080789119;8029.5583742894705;8082.434229603871;8136.87794683092;8199.877001845096;10282.434466104436;10400.635977740743;10401.25354543114;10509.789804204025;10510 18:02:56 INFO - PID 26825 | |3;mootools.html;1237.752449510098;1307.5750381126131;1321.2799024531623;1329.5745361484328;1335.3189873164686;9944.602215911364;10316.329438586496;10323.690289291315;10505.369677819317;10734.355938643686;10550.630727924525;10608.310459820126;10744.301620394668;10804.72988175296;10837.403942783143;2336.123953517431;2341.5668101401297;2357.5874222011166;2357.8349515533832;2374.430136767172;2168.1327469012363;2225.254539729193;2234.9217777377794;2235.1394713035434;2244.753077161511;2091.0381224636685;2092.257248676721;2106.24175296893;2115.1116531056914;2128.659414493681;2216.246476198084;2235.519363336882;2256.6615007748887;2266.637338025916;2293.7706229377095;2080.791920807907;2083.468715477559;2115.2490865742748;2272.7727227277305;2276.6357382818837;10219.233557483145;10226.488675566266;10235.846462303072;10261;10304.175665946706;5610.438956104398;5784.392638772911;5797.333306669702;5838.1534677471955;5874.647521148745;3383.712384447325;3584.605693373727;3628.5282913221376;3676.871309504181;3692.612275711065;1104.817705078661;1111.1166622535022;1133.7675776465805;1158.2008414194179;1163.0288708928056;15096.924515377354;15184.848151518565;15191.164485953268;15210.695786084216;15250.999999999889;4842.6368022398465;5050.696958182521;5067.8986420271385;5068.619853511002;5163.40620828602;10719;10875.510602022929;10961.177911656498;10971.177161712743;10982.231243812856;5532.2531458253425;5564.805231816867;5564.86087847799;5573.359063707644;5577.386487486373;4925.162722337212;5089.949100509021;5145.125328694131;5167.3799144102195;5187.170052791535;3780.4707340972286;3842.3275926712713;3866.478025466582;3918.6081391860585;3946.506686664167;1133.5749094089717;1140.2987162894926;1140.363578265192;1156;1156.0866915137115;711.8327193109615;732.3335764454321;733.9449541284425;748.1097493982144;752.4356732450663;5513.669179849222;5612.607117501817;5635.887282254414;5705.286839145107;5710.8001219957105;536.3778017499682;554.7004617506501;554.7974989128938;556.6771272661846;560.5879678436346;3472.2708231271718;3895.8636447724193;3957.168994511185;3978.7214894957656;4038.838446462167;12924;13560.457581696819;13676.111052781538;13846.30768461573;13880.097793643381;12923.806142907864;13478.056536042579;13652;13657.658558536115;13675.931620341835;7645.235476452311;7999;7999.280064794197;8006.599670016476;8069.314108300743;5864.237649105589;5930.762769489172;5934.7922822701;5987.191729116514;6215.875682486416;11643.243189192675;11883.702907427383;12098.75802483963;12188.085893557842;12221.388930553614;12283.938580307042;12350.62948111558;12383.62849114528;12526.436310365872;12786.552470663482;7610;7633.274838890296;7669.424793140425;7686.846263074819;7725.459217854921;9143;9221.446713197229;9397.248220142508;9399.671011514563;9414.67048653294;7786.805329866798;7921.32668723165;7961.164077771982;7989.760307190793;8177.223163799429;7757.961210193913;7797.181295963842;7829.7259595913865;7953.761387158394;7959.243871832166;6772.93227067723;6778.593284402951;6852.6916288768125;6862.9313706862295;6867.244603093556;4966.776495057658;5041.1430056889685;5087.287779710918;5264.263003179634;5296.602754793329;5269.1832765921345;5300.602454815981;5418.431064738304;5421.566274698093;5444.754986025718 18:02:56 INFO - PID 26825 | |4;prototype.html;353.9681428671419;369.75780863534385;372.20534159569314;372.7260463559284;374.32808109443545;5344.625876188668;5465.972670136649;5487.314085739283;5508.656603095002;5518.503334699876;5192.92210616841;5316.484801831479;5323.22813192087;5343.1718083697;5357.383900851403;4032.3145065338817;4044.332685106961;4047.575004624516;4058.269511487931;4059.309917314049;3883.6310550497656;4037.2934736421157;4066.8373265069363;4068.8982775430554;4075.7554546727292;3992.2614316351423;4000.4199391088273;4006.338954072589;4006.83972641094;4022.658074063708;3968.940465893014;3991.361382178852;3997.8600748973645;4000.5199376074765;4023.3160362738404;3489.790612563229;3491.7555771096036;3492.703120234783;3510.2628448025944;3519.560054993126;5234.7644356004075;5248.186531087687;5266.947330526684;5271.262023316739;5304.443033481506;4703.9294410583525;4714.457837348715;4718.268668356411;4720.150372932871;4743.407074115736;5504.311961004874;5655.981923253813;5673.375928647845;5693.3452652945025;5713.371529131834;3876.282887665791;3876.4379165021196;3895.629915158084;3899.688024958025;3918.3338832398563;5824.388439213864;5975.193348897887;6001.15983762278;6020.969895150496;6044.637321760664;3914.9038269284647;3955.0310174006977;3963.365861462152;3970.0868800175544;3974.2647610192207;4020.718549701493;4032.0927791246736;4032.6572241359813;4042.535108462506;4044.676425885922;4468.670840223989;4599.770011499411;4692.882677933079;4694.43666759991;4700.694454860423;5685.260916080883;5689;5694.747155625756;5700.4299570043495;5709.457601527848;1381.7443772901845;1387.5213051497217;1391.554702495212;1393.958181254564;1396.615930619088;878.2929741558107;922.2022950148073;928.0580211085753;938.7559234598917;942.0814705661925;4961.479044700327;4965.864678188414;4971.4282857471135;4975.825846095369;4983.875403114878;5886.646071403601;5911.261092363455;5914.260717410324;5921.200637913913;5942.61373010753;4823.517648235148;4969.950300497021;4976.656302798224;4979.875503112451;4991.825286114969;3111.8910838120555;3115.5482455044344;3139.01121146838;3156.9684303156673;3167.6990685884803;5556.721953950614;5582.358028826656;5598.552115830724;5601.411851755588;5605.32736071674;5808.941910580925;6011.368806275365;6071.362506936708;6083.7870674526175;6085.817425477243;5550.500454959073;5563.276774019432;5569.944300556943;5571.972140139354;5586.273784408082;5765.740541675718;5896.587238893237;5903.26209223847;5911.3201981772645;5983.072623743326;5852.122181672783;5855.7364918579615;5870.178175055581;5873.2658417697785;5895.263092113486;5425.620206585501;5555.50000499957;5559.499645031967;5571.832845014656;5606.393027242352;3987.342088555356;3994.940075898806;4003.7197396181987;4005.6595189409227;4012.0972781124015;5831.241938547962;5968.492678122235;5970.149253731406;5979.402059793986;5983.551233657406;5711.200431939449;5758.280214973129;5771.7402716877;5784.595078344475;5788.27646544182;5721.771129154788;5735;5757.280339957505;5763.366029736641;5780.768769249183;5359.732013399393;5628.662280263197;5648.971755141198;5667.914981275367;5699.173619825185;5780.075187969905;5781.537477001746;5786.1899334094105;5794.565407594363;5808.215890854681;5490.286262785812;5576.832695019156;5614.635048721983;5622.269105016322;5638.85902852432 18:02:56 INFO - PID 26825 | |5;yui.html;670.2158474584735;670.5038271678959;677.1062197898773;679.2426444514367;682.0587589127006;12262.202956807812;12648.114631975754;12723.109382343227;13636;14158.221297828615;15377.769333460006;15413.922930385332;15418.074915505078;15558.299876505556;15562.299696513655;843.2031730015138;864.7276108025983;874.1171416868976;875.8335916175938;877.9517126558037;871.790770215147;875.5272153037353;876.837785009772;880.0275695356635;880.5905254056862;899.4018977380034;905.302916754099;906.1934877958622;906.6101576322179;909.3316412436886;843.6372359885247;891.0465801592298;906.2025417632441;907.7458311672775;909.4361495872569;652.1912828093177;660.2802944790154;662.1888186970971;663.4824836627438;663.4891133826975;12938.22370657754;13008.674783130402;13077.346132693423;13090.541831035964;13093.279869607168;14933.551993440215;15920.363185472566;16120.274587643467;16134.112623805804;16263.10552919589;11464.71338216543;11813.468393922294;11855.46650400734;11940.40297985106;11991;2870.3828676834373;2897.9710202897913;2900.376419069889;2905.694902035277;2932.178989882836;71612.6419367905;71714.28285717129;71891.28108718898;72033.63983180103;73254.26745732581;10334.121599664113;11543.249688770371;11702.122340824471;11734.88265117355;11736.823947640793;16358.509244722678;21402.048272144857;21880.562388752136;21912.671309930363;21979.450513736963;6450.838729031811;6578.736850525926;6589.143411356493;6604.702788374535;6620.3710647488415;3165.271987442901;3204.0548038328748;3208.246062175387;3216.903492895217;3219.517072439153;3544.858205671744;3572.3034008368118;3613.5663720353728;3672.59601443841;3674.81625918703;724.8043028382307;737.2222305467676;738.1732459645125;738.5421038955882;741.6477173342619;588.808637192914;598.099859711132;607.8237311179709;608.1394826320707;618.7030225491699;9485.857712134324;9507.714768556954;9535.427874327563;9856.112949834549;9930.602775889029;611.1413464082971;612.2499937576433;615.7875532941129;623.5385814497239;634.5716641267127;4194;4339.674524410619;4364.563543645673;4370.278903980808;4455.22033644111;63664;63679.36320636734;64599.67700161469;66738;67697.66151169213;54436;54714;55915;55971;56640.43359566434;50971.7451412748;52423;53066.73466632642;53645;53801.1929821053;8429.126416948011;8690;8708.909861633289;8739.38824282294;8788.736337909873;25852.35369115787;26976.595351069358;27312;27875.303117421416;28647;42597.57402425936;43306;44197;44742.55257447384;45211.7739411314;13645.863541364459;13712.108712933627;13814.516491922734;13862.376193071537;14030.228337441538;15278.930474866653;15481;15572.143532105843;15960.361585536448;16139.273732681822;13179.538716144889;13405.798913016508;13615.387307570985;13753.793693094813;13797.448102075805;14145.222012788983;14219.431222751387;14432.206228657524;14926.253687315373;15064.623384415478;13396.928245740122;13414.12808167466;13542.932285338511;13654.044216904722;14010.299485025504;9800.411975281506;9858.950705246429;10490.475476226311;11196.944015280198;11260.549578016788;10909.127269818237;11319.886801131883;11403.771924561297;11421.543138274375;11506.30962142274 18:02:56 INFO - PID 26825 | __end_tp_report 18:02:56 INFO - PID 26825 | __start_cc_report 18:02:56 INFO - PID 26825 | _x_x_mozilla_cycle_collect,284 18:02:56 INFO - PID 26825 | __end_cc_report 18:02:56 INFO - PID 26825 | __startTimestamp1494982976572__endTimestamp 18:02:56 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | ------- Summary: start ------- 18:02:56 INFO - PID 26825 | Number of tests: 6 18:02:56 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | [#0] dojo.html Cycles:165 Average:5142.86 Median:5292.87 stddev:610.41 (11.5%) stddev-sans-first:581.77 18:02:56 INFO - PID 26825 | Values: 2713.2 2713.8 2737.3 2743.3 2749.9 5094.9 5105.1 5130.7 5156.1 5180.4 5171.3 5225.5 5232.8 5253.1 5258.7 4590.6 4624.1 4655.1 4696.5 4698.7 4606.2 4622.9 4641.7 4656.0 4715.3 4577.7 4602.6 4648.0 4649.0 4670.3 4603.4 4625.5 4647.0 4671.8 4681.7 4550.3 4598.0 4601.1 4612.3 4662.6 5104.6 5179.7 5191.0 5195.9 5239.8 5555.3 5555.5 5647.4 5664.2 5682.1 5661.4 5663.6 5671.3 5687.1 5736.9 5255.5 5259.1 5267.4 5276.5 5340.0 5605.0 5656.6 5678.2 5680.5 5788.8 5481.3 5490.4 5554.9 5557.1 5568.0 5655.5 5704.2 5719.8 5730.6 5734.9 5616.7 5632.1 5640.2 5647.5 5651.0 5608.0 5624.6 5635.3 5639.0 5641.5 4548.6 4602.2 4612.0 4650.5 4653.1 3961.8 3977.3 3983.0 4018.1 4031.3 4795.2 4798.6 4801.1 4808.5 4828.2 5529.6 5580.3 5663.7 5668.0 5713.4 4818.1 4834.0 4834.7 4841.6 4877.8 4916.7 4954.7 4957.4 4974.5 5019.4 5228.9 5247.8 5284.9 5310.9 5319.9 5623.8 5634.5 5635.2 5661.1 5694.2 5234.8 5260.7 5288.7 5289.1 5292.9 5509.5 5529.4 5566.9 5592.5 5595.1 5675.5 5680.2 5688.0 5690.8 5694.6 5404.7 5505.3 5509.2 5510.3 5514.4 5417.4 5450.3 5455.6 5466.1 5498.1 5304.3 5393.7 5394.1 5402.8 5413.1 5508.2 5508.3 5508.6 5518.4 5528.5 5211.3 5373.8 5378.9 5379.5 5384.1 18:02:56 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | [#1] ext.html Cycles:180 Average:29062.19 Median:29794.55 stddev:39469.24 (132.5%) stddev-sans-first:39522.61 18:02:56 INFO - PID 26825 | Values: 727.1 750.2 1143.8 1154.2 1189.0 32864.8 33411.8 33436.0 33506.2 33552.3 32093.5 32462.7 32518.2 32540.8 32576.7 6475.9 6747.4 6880.7 6909.2 6916.6 6777.3 6795.6 6852.7 6857.5 6860.9 6828.7 6836.8 6892.8 6903.6 6907.8 6774.4 6806.7 6824.1 6829.4 6868.3 6798.3 6840.5 6842.0 6843.0 6849.2 30210.7 30267.1 30356.2 30379.5 30520.0 2841.6 2900.0 2900.3 2911.4 2912.4 23581.3 23595.5 23662.2 23706.4 23758.9 3091.5 3101.8 3126.4 3151.9 3152.1 144580.0 144592.3 144641.0 145042.0 145322.0 35064.0 37682.6 37808.2 37920.6 38003.6 39051.8 39098.6 39202.0 39224.4 39230.0 12259.6 12262.5 12273.4 12286.6 12381.7 9854.1 9866.8 9870.7 9909.4 9947.5 11795.2 11797.9 11851.9 11939.3 12128.7 5000.2 5034.0 5227.4 5252.8 5287.7 867.9 891.4 902.4 914.6 931.3 20071.7 20250.5 20918.3 20933.3 21049.4 977.2 985.3 988.3 991.8 999.1 10347.5 10548.7 10841.6 10877.1 11034.9 170014.0 170066.0 170428.0 170486.0 170564.0 37368.3 37730.2 37851.4 37881.6 37898.8 1191.7 1204.4 1207.9 1214.6 1217.1 19031.0 19373.1 19992.3 20112.7 20562.2 27645.4 27708.4 27739.0 27807.7 27881.6 141868.0 143175.0 143176.0 143421.0 144097.0 27039.6 27132.5 27449.9 28280.7 28478.0 33271.0 33664.1 33870.8 34011.0 34226.0 25569.9 25733.4 25784.0 26313.7 27052.9 25537.9 25832.4 26075.6 27146.6 27442.5 28764.7 29536.6 29581.4 30007.7 30100.5 26213.3 26257.9 26526.5 26656.7 26878.6 19401.0 21826.1 21917.0 21951.9 21961.1 18:02:56 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | [#2] jquery.html Cycles:180 Average:24706.67 Median:38635.32 stddev:61166.42 (158.3%) stddev-sans-first:61310.80 18:02:56 INFO - PID 26825 | Values: 409.7 413.3 430.4 435.2 437.8 13829.4 16617.6 17247.1 17351.5 17352.4 17645.6 17928.6 18212.2 18706.5 18757.0 5277.4 5340.5 5506.2 5526.3 5544.7 5420.0 5495.8 5517.6 5532.1 5534.2 5250.3 5439.5 5451.9 5464.6 5540.1 5385.8 5419.1 5434.7 5439.3 5455.9 4775.7 4928.4 4940.9 4952.7 4974.9 20522.3 21143.8 21550.6 21593.6 21716.6 1623.2 1666.8 1673.4 1674.0 1678.9 14565.4 14846.4 15003.2 15106.7 15286.4 2076.2 2100.3 2129.1 2147.4 2174.8 78740.0 78896.8 79054.6 80318.6 80376.2 10924.8 11091.7 11155.6 11244.5 11574.5 15489.5 15497.0 15592.1 15606.8 15609.9 7386.1 7403.9 7447.8 7634.1 7646.8 6673.4 6708.4 6855.7 6855.9 6891.0 7204.6 7385.4 7387.8 7388.3 7402.1 2181.4 2192.9 2205.2 2211.8 2321.1 834.6 869.5 870.1 870.4 892.4 16200.8 16236.8 16502.1 16957.9 17011.3 865.6 873.6 877.4 879.3 889.7 8731.4 9201.2 9226.6 9318.5 10863.9 360218.0 361605.0 368510.0 373991.0 376357.0 78311.0 79824.2 81250.6 81615.6 82297.2 1054.8 1067.3 1097.3 1102.8 1110.9 16972.9 17317.9 17759.7 17808.4 17884.4 38464.2 38806.4 39600.8 39838.2 40358.6 48991.5 49531.5 51021.7 51555.2 52305.2 7978.8 8059.8 8293.8 8456.7 8535.1 12632.5 12774.6 12817.4 12849.2 13165.5 10884.5 11147.5 11158.8 11175.5 11578.4 9920.2 10157.1 10275.1 10410.7 10446.5 10828.8 10851.6 10867.2 11236.8 11493.6 7891.9 8029.6 8082.4 8136.9 8199.9 10282.4 10400.6 10401.3 10509.8 10510.0 18:02:56 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | [#3] mootools.html Cycles:180 Average:6317.66 Median:3811.40 stddev:4085.96 (107.2%) stddev-sans-first:4079.59 18:02:56 INFO - PID 26825 | Values: 1237.8 1307.6 1321.3 1329.6 1335.3 9944.6 10316.3 10323.7 10505.4 10734.4 10550.6 10608.3 10744.3 10804.7 10837.4 2336.1 2341.6 2357.6 2357.8 2374.4 2168.1 2225.3 2234.9 2235.1 2244.8 2091.0 2092.3 2106.2 2115.1 2128.7 2216.2 2235.5 2256.7 2266.6 2293.8 2080.8 2083.5 2115.2 2272.8 2276.6 10219.2 10226.5 10235.8 10261.0 10304.2 5610.4 5784.4 5797.3 5838.2 5874.6 3383.7 3584.6 3628.5 3676.9 3692.6 1104.8 1111.1 1133.8 1158.2 1163.0 15096.9 15184.8 15191.2 15210.7 15251.0 4842.6 5050.7 5067.9 5068.6 5163.4 10719.0 10875.5 10961.2 10971.2 10982.2 5532.3 5564.8 5564.9 5573.4 5577.4 4925.2 5089.9 5145.1 5167.4 5187.2 3780.5 3842.3 3866.5 3918.6 3946.5 1133.6 1140.3 1140.4 1156.0 1156.1 711.8 732.3 733.9 748.1 752.4 5513.7 5612.6 5635.9 5705.3 5710.8 536.4 554.7 554.8 556.7 560.6 3472.3 3895.9 3957.2 3978.7 4038.8 12924.0 13560.5 13676.1 13846.3 13880.1 12923.8 13478.1 13652.0 13657.7 13675.9 7645.2 7999.0 7999.3 8006.6 8069.3 5864.2 5930.8 5934.8 5987.2 6215.9 11643.2 11883.7 12098.8 12188.1 12221.4 12283.9 12350.6 12383.6 12526.4 12786.6 7610.0 7633.3 7669.4 7686.8 7725.5 9143.0 9221.4 9397.2 9399.7 9414.7 7786.8 7921.3 7961.2 7989.8 8177.2 7758.0 7797.2 7829.7 7953.8 7959.2 6772.9 6778.6 6852.7 6862.9 6867.2 4966.8 5041.1 5087.3 5264.3 5296.6 5269.2 5300.6 5418.4 5421.6 5444.8 18:02:56 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | [#4] prototype.html Cycles:180 Average:4687.13 Median:5358.56 stddev:1415.03 (26.4%) stddev-sans-first:1381.12 18:02:56 INFO - PID 26825 | Values: 354.0 369.8 372.2 372.7 374.3 5344.6 5466.0 5487.3 5508.7 5518.5 5192.9 5316.5 5323.2 5343.2 5357.4 4032.3 4044.3 4047.6 4058.3 4059.3 3883.6 4037.3 4066.8 4068.9 4075.8 3992.3 4000.4 4006.3 4006.8 4022.7 3968.9 3991.4 3997.9 4000.5 4023.3 3489.8 3491.8 3492.7 3510.3 3519.6 5234.8 5248.2 5266.9 5271.3 5304.4 4703.9 4714.5 4718.3 4720.2 4743.4 5504.3 5656.0 5673.4 5693.3 5713.4 3876.3 3876.4 3895.6 3899.7 3918.3 5824.4 5975.2 6001.2 6021.0 6044.6 3914.9 3955.0 3963.4 3970.1 3974.3 4020.7 4032.1 4032.7 4042.5 4044.7 4468.7 4599.8 4692.9 4694.4 4700.7 5685.3 5689.0 5694.7 5700.4 5709.5 1381.7 1387.5 1391.6 1394.0 1396.6 878.3 922.2 928.1 938.8 942.1 4961.5 4965.9 4971.4 4975.8 4983.9 5886.6 5911.3 5914.3 5921.2 5942.6 4823.5 4970.0 4976.7 4979.9 4991.8 3111.9 3115.5 3139.0 3157.0 3167.7 5556.7 5582.4 5598.6 5601.4 5605.3 5808.9 6011.4 6071.4 6083.8 6085.8 5550.5 5563.3 5569.9 5572.0 5586.3 5765.7 5896.6 5903.3 5911.3 5983.1 5852.1 5855.7 5870.2 5873.3 5895.3 5425.6 5555.5 5559.5 5571.8 5606.4 3987.3 3994.9 4003.7 4005.7 4012.1 5831.2 5968.5 5970.1 5979.4 5983.6 5711.2 5758.3 5771.7 5784.6 5788.3 5721.8 5735.0 5757.3 5763.4 5780.8 5359.7 5628.7 5649.0 5667.9 5699.2 5780.1 5781.5 5786.2 5794.6 5808.2 5490.3 5576.8 5614.6 5622.3 5638.9 18:02:56 INFO - PID 26825 | 18:02:56 INFO - PID 26825 | [#5] yui.html Cycles:180 Average:15480.11 Median:23822.84 stddev:18652.11 (78.3%) stddev-sans-first:18671.28 18:02:56 INFO - PID 26825 | Values: 670.2 670.5 677.1 679.2 682.1 12262.2 12648.1 12723.1 13636.0 14158.2 15377.8 15413.9 15418.1 15558.3 15562.3 843.2 864.7 874.1 875.8 878.0 871.8 875.5 876.8 880.0 880.6 899.4 905.3 906.2 906.6 909.3 843.6 891.0 906.2 907.7 909.4 652.2 660.3 662.2 663.5 663.5 12938.2 13008.7 13077.3 13090.5 13093.3 14933.6 15920.4 16120.3 16134.1 16263.1 11464.7 11813.5 11855.5 11940.4 11991.0 2870.4 2898.0 2900.4 2905.7 2932.2 71612.6 71714.3 71891.3 72033.6 73254.3 10334.1 11543.2 11702.1 11734.9 11736.8 16358.5 21402.0 21880.6 21912.7 21979.5 6450.8 6578.7 6589.1 6604.7 6620.4 3165.3 3204.1 3208.2 3216.9 3219.5 3544.9 3572.3 3613.6 3672.6 3674.8 724.8 737.2 738.2 738.5 741.6 588.8 598.1 607.8 608.1 618.7 9485.9 9507.7 9535.4 9856.1 9930.6 611.1 612.2 615.8 623.5 634.6 4194.0 4339.7 4364.6 4370.3 4455.2 63664.0 63679.4 64599.7 66738.0 67697.7 54436.0 54714.0 55915.0 55971.0 56640.4 50971.7 52423.0 53066.7 53645.0 53801.2 8429.1 8690.0 8708.9 8739.4 8788.7 25852.4 26976.6 27312.0 27875.3 28647.0 42597.6 43306.0 44197.0 44742.6 45211.8 13645.9 13712.1 13814.5 13862.4 14030.2 15278.9 15481.0 15572.1 15960.4 16139.3 13179.5 13405.8 13615.4 13753.8 13797.4 14145.2 14219.4 14432.2 14926.3 15064.6 13396.9 13414.1 13542.9 13654.0 14010.3 9800.4 9859.0 10490.5 11196.9 11260.5 10909.1 11319.9 11403.8 11421.5 11506.3 18:02:56 INFO - PID 26825 | -------- Summary: end -------- 18:02:56 INFO - PID 26825 | 18:02:57 INFO - TEST-INFO | 26825: exit 0 18:02:57 INFO - TEST-OK | dromaeo_css | took 1118781ms 18:02:57 INFO - TEST-START | kraken 18:02:57 INFO - operating with platform_type : linux_ 18:02:57 INFO - Initialising browser for kraken test... 18:02:57 INFO - TEST-INFO | started process 27240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89SQ1T/profile http://localhost:53025/getInfo.html) 18:02:57 INFO - PID 27240 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 18:03:01 INFO - PID 27240 | __metrics Screen width/height:1600/1200 18:03:01 INFO - PID 27240 | colorDepth:24 18:03:01 INFO - PID 27240 | Browser inner width/height: 1024/695 18:03:01 INFO - PID 27240 | __metrics 18:03:02 INFO - TEST-INFO | 27240: exit 0 18:03:02 INFO - Browser initialized. 18:03:02 INFO - Running cycle 1/1 for kraken test... 18:03:02 INFO - TEST-INFO | started process 27413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89SQ1T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:14 INFO - PID 27413 | RSS: Main: 163053568 18:03:14 INFO - PID 27413 | 18:03:17 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53025/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:18 INFO - PID 27413 | RSS: Main: 166969344 18:03:18 INFO - PID 27413 | 18:03:20 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53025/tests/kraken/driver.html?testName=audio-dft) 18:03:21 INFO - PID 27413 | RSS: Main: 166920192 18:03:21 INFO - PID 27413 | 18:03:24 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53025/tests/kraken/driver.html?testName=audio-fft) 18:03:25 INFO - PID 27413 | RSS: Main: 162103296 18:03:25 INFO - PID 27413 | 18:03:27 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53025/tests/kraken/driver.html?testName=audio-oscillator) 18:03:27 INFO - PID 27413 | RSS: Main: 162476032 18:03:27 INFO - PID 27413 | 18:03:29 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53025/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:30 INFO - PID 27413 | RSS: Main: 163094528 18:03:30 INFO - PID 27413 | 18:03:33 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53025/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:34 INFO - PID 27413 | RSS: Main: 166785024 18:03:34 INFO - PID 27413 | 18:03:37 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53025/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:38 INFO - PID 27413 | RSS: Main: 164831232 18:03:38 INFO - PID 27413 | 18:03:41 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53025/tests/kraken/driver.html?testName=json-parse-financial) 18:03:41 INFO - PID 27413 | RSS: Main: 165343232 18:03:41 INFO - PID 27413 | 18:03:43 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53025/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:44 INFO - PID 27413 | RSS: Main: 165412864 18:03:44 INFO - PID 27413 | 18:03:45 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53025/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:46 INFO - PID 27413 | RSS: Main: 165548032 18:03:46 INFO - PID 27413 | 18:03:48 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53025/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:49 INFO - PID 27413 | RSS: Main: 165634048 18:03:49 INFO - PID 27413 | 18:03:52 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53025/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:03:52 INFO - PID 27413 | RSS: Main: 166064128 18:03:52 INFO - PID 27413 | 18:03:56 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53025/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:03:56 INFO - PID 27413 | RSS: Main: 166117376 18:03:56 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | Cycle 1(1): loaded http://localhost:53025/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53025/tests/kraken/driver.html?testName=ai-astar) 18:03:58 INFO - PID 27413 | RSS: Main: 166961152 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | __start_tp_report 18:03:58 INFO - PID 27413 | _x_x_mozilla_page_load 18:03:58 INFO - PID 27413 | _x_x_mozilla_page_load_details 18:03:58 INFO - PID 27413 | |i|pagename|runs| 18:03:58 INFO - PID 27413 | |0;ai-astar;103;112;113;113;112;113;112;113;113;115 18:03:58 INFO - PID 27413 | |1;audio-beat-detection;148;125;124;182;125;123;124;126;155;123 18:03:58 INFO - PID 27413 | |2;audio-dft;164;165;168;166;165;168;168;171;165;163 18:03:58 INFO - PID 27413 | |3;audio-fft;77;75;78;114;86;75;76;78;95;80 18:03:58 INFO - PID 27413 | |4;audio-oscillator;83;82;115;83;84;82;97;83;84;108 18:03:58 INFO - PID 27413 | |5;imaging-gaussian-blur;114;119;114;115;113;113;114;114;115;115 18:03:58 INFO - PID 27413 | |6;imaging-darkroom;152;149;151;150;152;152;150;151;152;151 18:03:58 INFO - PID 27413 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;94;95 18:03:58 INFO - PID 27413 | |8;json-parse-financial;55;56;55;57;57;58;59;56;57;56 18:03:58 INFO - PID 27413 | |9;json-stringify-tinderbox;57;56;57;56;57;57;57;60;58;57 18:03:58 INFO - PID 27413 | |10;stanford-crypto-aes;83;82;84;82;83;84;83;93;84;84 18:03:58 INFO - PID 27413 | |11;stanford-crypto-ccm;135;135;144;135;140;134;138;138;178;139 18:03:58 INFO - PID 27413 | |12;stanford-crypto-pbkdf2;195;202;194;198;193;202;197;198;191;187 18:03:58 INFO - PID 27413 | |13;stanford-crypto-sha256-iterative;76;77;74;77;74;73;75;73;72;72 18:03:58 INFO - PID 27413 | __end_tp_report 18:03:58 INFO - PID 27413 | __start_cc_report 18:03:58 INFO - PID 27413 | _x_x_mozilla_cycle_collect,781 18:03:58 INFO - PID 27413 | __end_cc_report 18:03:58 INFO - PID 27413 | __startTimestamp1494983038720__endTimestamp 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | ------- Summary: start ------- 18:03:58 INFO - PID 27413 | Number of tests: 14 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.25 (2.9%) stddev-sans-first:0.93 18:03:58 INFO - PID 27413 | Values: 103.0 112.0 113.0 113.0 112.0 113.0 112.0 113.0 113.0 115.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:125.50 stddev:19.96 (15.9%) stddev-sans-first:20.65 18:03:58 INFO - PID 27413 | Values: 148.0 125.0 124.0 182.0 125.0 123.0 124.0 126.0 155.0 123.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#2] audio-dft Cycles:10 Average:166.30 Median:167.00 stddev:2.41 (1.4%) stddev-sans-first:2.40 18:03:58 INFO - PID 27413 | Values: 164.0 165.0 168.0 166.0 165.0 168.0 168.0 171.0 165.0 163.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#3] audio-fft Cycles:10 Average:83.40 Median:78.00 stddev:12.40 (15.9%) stddev-sans-first:12.94 18:03:58 INFO - PID 27413 | Values: 77.0 75.0 78.0 114.0 86.0 75.0 76.0 78.0 95.0 80.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.00 stddev:12.22 (14.7%) stddev-sans-first:12.69 18:03:58 INFO - PID 27413 | Values: 83.0 82.0 115.0 83.0 84.0 82.0 97.0 83.0 84.0 108.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.71 (1.5%) stddev-sans-first:1.80 18:03:58 INFO - PID 27413 | Values: 114.0 119.0 114.0 115.0 113.0 113.0 114.0 114.0 115.0 115.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:1.05 (0.7%) stddev-sans-first:1.05 18:03:58 INFO - PID 27413 | Values: 152.0 149.0 151.0 150.0 152.0 152.0 150.0 151.0 152.0 151.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:03:58 INFO - PID 27413 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.26 (2.2%) stddev-sans-first:1.20 18:03:58 INFO - PID 27413 | Values: 55.0 56.0 55.0 57.0 57.0 58.0 59.0 56.0 57.0 56.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:1.14 (2.0%) stddev-sans-first:1.20 18:03:58 INFO - PID 27413 | Values: 57.0 56.0 57.0 56.0 57.0 57.0 57.0 60.0 58.0 57.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:3.19 (3.8%) stddev-sans-first:3.35 18:03:58 INFO - PID 27413 | Values: 83.0 82.0 84.0 82.0 83.0 84.0 83.0 93.0 84.0 84.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:138.50 stddev:13.14 (9.5%) stddev-sans-first:13.72 18:03:58 INFO - PID 27413 | Values: 135.0 135.0 144.0 135.0 140.0 134.0 138.0 138.0 178.0 139.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.70 Median:197.50 stddev:4.72 (2.4%) stddev-sans-first:4.99 18:03:58 INFO - PID 27413 | Values: 195.0 202.0 194.0 198.0 193.0 202.0 197.0 198.0 191.0 187.0 18:03:58 INFO - PID 27413 | 18:03:58 INFO - PID 27413 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.50 stddev:1.89 (2.5%) stddev-sans-first:1.90 18:03:58 INFO - PID 27413 | Values: 76.0 77.0 74.0 77.0 74.0 73.0 75.0 73.0 72.0 72.0 18:03:58 INFO - PID 27413 | -------- Summary: end -------- 18:03:58 INFO - PID 27413 | 18:03:59 INFO - TEST-INFO | 27413: exit 0 18:03:59 INFO - TEST-OK | kraken | took 62468ms 18:03:59 INFO - SUITE-END | took 1181s 18:04:00 INFO - Completed test suite (00:19:41) 18:04:00 INFO - javascript benchmark 18:04:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6644.38218067029, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2713.1724823928707, 2713.8100332976674, 2737.3430376709593, 2743.2593199836056, 2749.9312517187072, 5094.872628184297, 5105.055564720529, 5130.666506677064, 5156.071907056728, 5180.404253510843, 5171.250168725542, 5225.503577160173, 5232.816851410202, 5253.080710875591, 5258.737063146837, 4590.586847183753, 4624.14453326134, 4655.138799322136, 4696.483386827446, 4698.671093023489, 4606.239970404896, 4622.907541849161, 4641.721496710191, 4656.045510670321, 4715.3162791395225, 4577.702449340783, 4602.585767280961, 4647.9535204647855, 4649.000464900046, 4670.299455081731, 4603.401557797499, 4625.537446255347, 4647.024124933734, 4671.813127474897, 4681.672282940195, 4550.317452382136, 4597.977010114962, 4601.102784956935, 4612.331211974245, 4662.6269898408045, 5104.566111880495, 5179.663321884103, 5191.0, 5195.896082078338, 5239.842804715865, 5555.333359996826, 5555.472230138171, 5647.43525647436, 5664.150377443417, 5682.090865461548, 5661.433856614347, 5663.631863928873, 5671.262735844314, 5687.118496633028, 5736.856578585527, 5255.474452554752, 5259.079661059376, 5267.367915850123, 5276.472352764769, 5340.0, 5605.0, 5656.632318899258, 5678.205051292823, 5680.460356266148, 5788.82633520995, 5481.342238931274, 5490.368607610176, 5554.861128471821, 5557.110862262019, 5568.025595520768, 5655.519280861091, 5704.229928959538, 5719.799807006735, 5730.598858079978, 5734.942650573525, 5616.69108199053, 5632.070708333161, 5640.182173584807, 5647.49172574462, 5651.039323314964, 5607.971960140255, 5624.606277560613, 5635.267415235993, 5639.041362968305, 5641.492265696107, 4548.636109111263, 4602.240630296031, 4612.0, 4650.465196502446, 4653.115907977473, 3961.8217180226384, 3977.2642061218767, 3983.0, 4018.0557568971267, 4031.254217969685, 4795.160846851787, 4798.640101992295, 4801.135795556834, 4808.471068182497, 4828.227483602677, 5529.612927095145, 5580.2745643066955, 5663.66018038919, 5667.951428985651, 5713.428657134254, 4818.084563932842, 4833.975830120898, 4834.661573689878, 4841.588464980446, 4877.829275975324, 4916.680415772963, 4954.677945933503, 4957.355543779286, 4974.477679843637, 5019.447860735243, 5228.921566176587, 5247.842564723064, 5284.9471505284455, 5310.867228319323, 5319.867003324948, 5623.803166889139, 5634.492895639412, 5635.154726791015, 5661.122526008476, 5694.174344720075, 5234.816781412632, 5260.710660913686, 5288.7355632219005, 5289.074411977966, 5292.867678307919, 5509.5041446270025, 5529.364123125892, 5566.888662226814, 5592.524635406036, 5595.132754423071, 5675.517581005661, 5680.204771331934, 5688.0, 5690.829275121753, 5694.601377903507, 5404.675719456845, 5505.339359276913, 5509.173623956439, 5510.311211098613, 5514.448555144614, 5417.377001644862, 5450.345958485007, 5455.563554915677, 5466.098093814635, 5498.092814685532, 5304.336957880265, 5393.6763794172475, 5394.1099718546, 5402.837914862561, 5413.10683737179, 5508.228847961209, 5508.283923089973, 5508.641938274, 5518.365387980433, 5528.502434780889, 5211.270422140828, 5373.758180881791, 5378.865528361822, 5379.54273886724, 5384.057789886832], "value": 5098.268573006253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.0729819480163, 750.2235186581889, 1143.8055530559805, 1154.2209008918978, 1189.0428205294734, 32864.83567582162, 33411.832940835324, 33436.0, 33506.1623459413, 33552.32895342092, 32093.51859722106, 32462.67537324626, 32518.187045323877, 32540.837295813486, 32576.67423325766, 6475.935240647604, 6747.359000894907, 6880.655967201645, 6909.170899492068, 6916.619585922772, 6777.2545020048, 6795.626240556768, 6852.725890964381, 6857.485688573352, 6860.931390686104, 6828.6927088281145, 6836.794896153098, 6892.758753443631, 6903.551269167513, 6907.758228462005, 6774.356436138559, 6806.727730890759, 6824.078749368821, 6829.385355317995, 6868.347506986828, 6798.286179951084, 6840.521163518556, 6842.0, 6843.0419741236265, 6849.2465828758795, 30210.69789302101, 30267.09198724042, 30356.241093972607, 30379.544306835192, 30520.0, 2841.5737639354056, 2900.0429858146763, 2900.318425170083, 2911.4177164567172, 2912.3738396244908, 23581.292561223017, 23595.528089438114, 23662.17182398608, 23706.407339816644, 23758.881205594033, 3091.48990416581, 3101.7673674474504, 3126.4059828632485, 3151.889683861054, 3152.1489197916435, 144580.0, 144592.2770386152, 144641.0, 145042.0, 145322.0, 35064.0, 37682.62317376846, 37808.24383512315, 37920.620793791706, 38003.619963800564, 39051.82844514669, 39098.60901391006, 39202.0, 39224.41163382552, 39230.0, 12259.57091501811, 12262.509499619915, 12273.447694853752, 12286.631401057983, 12381.690457738629, 9854.11312981835, 9866.80266394668, 9870.703878883645, 9909.355891867006, 9947.502624868728, 11795.233309835005, 11797.941010295066, 11851.940740296242, 11939.343336116423, 12128.69678258033, 5000.199968005102, 5033.974830125826, 5227.3988491323225, 5252.816151434681, 5287.656302340336, 867.9392442529089, 891.3938521805105, 902.4089221559889, 914.5792935249726, 931.3108299858056, 20071.698924516142, 20250.493737656678, 20918.26786062511, 20933.26733564318, 21049.368518944455, 977.237754551451, 985.2905907746555, 988.3081842710131, 991.7966816802539, 999.1058003087196, 10347.482625868826, 10548.683539493828, 10841.620543280947, 10877.129829613612, 11034.889651103547, 170014.0, 170066.0, 170428.0, 170486.0, 170564.0, 37368.25263494715, 37730.245395091944, 37851.43222851659, 37881.62118378781, 37898.81050594785, 1191.7139886427194, 1204.3616883051996, 1207.9033677305795, 1214.6295379909213, 1217.11150859871, 19031.0, 19373.128209230337, 19992.300269490497, 20112.698309525662, 20562.177512899318, 27645.447091057664, 27708.445831083667, 27739.0, 27807.721922780514, 27881.581776272968, 141868.0, 143175.0, 143176.0, 143421.0, 144097.0, 27039.594406084318, 27132.457350852477, 27449.86275068612, 28280.71719282863, 28478.0, 33271.0, 33664.108780963725, 33870.83064584661, 34011.0, 34226.0, 25569.872150639127, 25733.3566660835, 25784.0, 26313.73686263113, 27052.864735676983, 25537.87231063833, 25832.354191145372, 26075.608865867405, 27146.592801108392, 27442.47416085209, 28764.712352876202, 29536.556951646173, 29581.408371832873, 30007.69992300049, 30100.54849177308, 26213.344666383495, 26257.868710656323, 26526.5410402422, 26656.733432665424, 26878.596821047307, 19401.0, 21826.126954921627, 21917.0, 21951.890240549335, 21961.121555137615], "value": 14063.443901243889, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.6784024540736, 413.3365947654017, 430.3673599808281, 435.1970614216769, 437.8445651793614, 13829.446822127127, 16617.58456038598, 17247.137643117825, 17351.479455616336, 17352.392666256685, 17645.647087058253, 17928.551786205353, 18212.180451879663, 18706.53233669159, 18756.968366739824, 5277.393099793515, 5340.49265319794, 5506.174073888908, 5526.281583394153, 5544.667319960795, 5420.0, 5495.780168793243, 5517.613767036309, 5532.1425179097105, 5534.225208470817, 5250.343707036621, 5439.5104440600335, 5451.890962180754, 5464.590155738316, 5540.113581826909, 5385.81149659762, 5419.132938729785, 5434.701091439969, 5439.265699130626, 5455.863603409926, 4775.665703400763, 4928.359313289286, 4940.901181976376, 4952.653314268003, 4974.900501989976, 20522.281720139872, 21143.788562114336, 21550.568988620296, 21593.568128637497, 21716.565668686537, 1623.2127418202163, 1666.7833181686303, 1673.4059408909784, 1673.983260167395, 1678.924448399825, 14565.417383304655, 14846.406143754344, 15003.1748253846, 15106.697866042727, 15286.388544458208, 2076.179908935977, 2100.2859027930576, 2129.084493667722, 2147.4094623978376, 2174.7825217478285, 78740.0, 78896.81654775183, 79054.604726976, 80318.59840700818, 80376.19623803746, 10924.836127458095, 11091.667249982513, 11155.609553665583, 11244.49399777012, 11574.537018519333, 15489.457868974758, 15497.0, 15592.142432166112, 15606.84393156054, 15609.921950390175, 7386.113666360071, 7403.85192296151, 7447.813804654818, 7634.083909930844, 7646.847063058819, 6673.399394054559, 6708.396244338033, 6855.691493882788, 6855.862882742417, 6890.965545172342, 7204.603746793977, 7385.3722433592675, 7387.81530461732, 7388.261173882676, 7402.1117465904435, 2181.4001149683645, 2192.9122835086737, 2205.1730601024615, 2211.7677643847487, 2321.1063740460045, 834.5743670727973, 869.4696235296464, 870.0690261420347, 870.3733312015339, 892.3842548641417, 16200.837991620168, 16236.80041578995, 16502.092384918946, 16957.915210423867, 17011.31954721822, 865.5758678247613, 873.5806812729925, 877.4121338703085, 879.2634546770078, 889.6797153024905, 8731.432456890281, 9201.171894529525, 9226.58480368385, 9318.534073296309, 10863.891361086446, 360218.0, 361605.0, 368510.0, 373991.0, 376357.0, 78311.0, 79824.20175798167, 81250.59374703089, 81615.5919220412, 82297.17702822895, 1054.8417737339307, 1067.2795862792584, 1097.3032124600936, 1102.7739313440725, 1110.8944650258213, 16972.915135424242, 17317.913410432866, 17759.73360399621, 17808.3767068152, 17884.374046908295, 38464.2307153861, 38806.41790373203, 39600.80199599099, 39838.203235935696, 40358.596414036656, 48991.51008489869, 49531.54216120567, 51021.7448912753, 51555.22667160071, 52305.21542176794, 7978.84042319162, 8059.83880322402, 8293.83412331762, 8456.746297611082, 8535.146485351663, 12632.494700211888, 12774.552890648783, 12817.42321595549, 12849.164804287691, 13165.47338106465, 10884.510197040994, 11147.498362573542, 11158.776824463303, 11175.49710263024, 11578.434395170287, 9920.156786672926, 10157.136643385395, 10275.075243228146, 10410.73973150647, 10446.52990615409, 10828.783424331627, 10851.565937362733, 10867.239293249397, 11236.831447528457, 11493.597724079616, 7891.921080789119, 8029.5583742894705, 8082.434229603871, 8136.87794683092, 8199.877001845096, 10282.434466104436, 10400.635977740743, 10401.25354543114, 10509.789804204025, 10510.0], "value": 8824.231375699217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.752449510098, 1307.5750381126131, 1321.2799024531623, 1329.5745361484328, 1335.3189873164686, 9944.602215911364, 10316.329438586496, 10323.690289291315, 10505.369677819317, 10734.355938643686, 10550.630727924525, 10608.310459820126, 10744.301620394668, 10804.72988175296, 10837.403942783143, 2336.123953517431, 2341.5668101401297, 2357.5874222011166, 2357.8349515533832, 2374.430136767172, 2168.1327469012363, 2225.254539729193, 2234.9217777377794, 2235.1394713035434, 2244.753077161511, 2091.0381224636685, 2092.257248676721, 2106.24175296893, 2115.1116531056914, 2128.659414493681, 2216.246476198084, 2235.519363336882, 2256.6615007748887, 2266.637338025916, 2293.7706229377095, 2080.791920807907, 2083.468715477559, 2115.2490865742748, 2272.7727227277305, 2276.6357382818837, 10219.233557483145, 10226.488675566266, 10235.846462303072, 10261.0, 10304.175665946706, 5610.438956104398, 5784.392638772911, 5797.333306669702, 5838.1534677471955, 5874.647521148745, 3383.712384447325, 3584.605693373727, 3628.5282913221376, 3676.871309504181, 3692.612275711065, 1104.817705078661, 1111.1166622535022, 1133.7675776465805, 1158.2008414194179, 1163.0288708928056, 15096.924515377354, 15184.848151518565, 15191.164485953268, 15210.695786084216, 15250.999999999889, 4842.6368022398465, 5050.696958182521, 5067.8986420271385, 5068.619853511002, 5163.40620828602, 10719.0, 10875.510602022929, 10961.177911656498, 10971.177161712743, 10982.231243812856, 5532.2531458253425, 5564.805231816867, 5564.86087847799, 5573.359063707644, 5577.386487486373, 4925.162722337212, 5089.949100509021, 5145.125328694131, 5167.3799144102195, 5187.170052791535, 3780.4707340972286, 3842.3275926712713, 3866.478025466582, 3918.6081391860585, 3946.506686664167, 1133.5749094089717, 1140.2987162894926, 1140.363578265192, 1156.0, 1156.0866915137115, 711.8327193109615, 732.3335764454321, 733.9449541284425, 748.1097493982144, 752.4356732450663, 5513.669179849222, 5612.607117501817, 5635.887282254414, 5705.286839145107, 5710.8001219957105, 536.3778017499682, 554.7004617506501, 554.7974989128938, 556.6771272661846, 560.5879678436346, 3472.2708231271718, 3895.8636447724193, 3957.168994511185, 3978.7214894957656, 4038.838446462167, 12924.0, 13560.457581696819, 13676.111052781538, 13846.30768461573, 13880.097793643381, 12923.806142907864, 13478.056536042579, 13652.0, 13657.658558536115, 13675.931620341835, 7645.235476452311, 7999.0, 7999.280064794197, 8006.599670016476, 8069.314108300743, 5864.237649105589, 5930.762769489172, 5934.7922822701, 5987.191729116514, 6215.875682486416, 11643.243189192675, 11883.702907427383, 12098.75802483963, 12188.085893557842, 12221.388930553614, 12283.938580307042, 12350.62948111558, 12383.62849114528, 12526.436310365872, 12786.552470663482, 7610.0, 7633.274838890296, 7669.424793140425, 7686.846263074819, 7725.459217854921, 9143.0, 9221.446713197229, 9397.248220142508, 9399.671011514563, 9414.67048653294, 7786.805329866798, 7921.32668723165, 7961.164077771982, 7989.760307190793, 8177.223163799429, 7757.961210193913, 7797.181295963842, 7829.7259595913865, 7953.761387158394, 7959.243871832166, 6772.93227067723, 6778.593284402951, 6852.6916288768125, 6862.9313706862295, 6867.244603093556, 4966.776495057658, 5041.1430056889685, 5087.287779710918, 5264.263003179634, 5296.602754793329, 5269.1832765921345, 5300.602454815981, 5418.431064738304, 5421.566274698093, 5444.754986025718], "value": 4726.968107653841, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9681428671419, 369.75780863534385, 372.20534159569314, 372.7260463559284, 374.32808109443545, 5344.625876188668, 5465.972670136649, 5487.314085739283, 5508.656603095002, 5518.503334699876, 5192.92210616841, 5316.484801831479, 5323.22813192087, 5343.1718083697, 5357.383900851403, 4032.3145065338817, 4044.332685106961, 4047.575004624516, 4058.269511487931, 4059.309917314049, 3883.6310550497656, 4037.2934736421157, 4066.8373265069363, 4068.8982775430554, 4075.7554546727292, 3992.2614316351423, 4000.4199391088273, 4006.338954072589, 4006.83972641094, 4022.658074063708, 3968.940465893014, 3991.361382178852, 3997.8600748973645, 4000.5199376074765, 4023.3160362738404, 3489.790612563229, 3491.7555771096036, 3492.703120234783, 3510.2628448025944, 3519.560054993126, 5234.7644356004075, 5248.186531087687, 5266.947330526684, 5271.262023316739, 5304.443033481506, 4703.9294410583525, 4714.457837348715, 4718.268668356411, 4720.150372932871, 4743.407074115736, 5504.311961004874, 5655.981923253813, 5673.375928647845, 5693.3452652945025, 5713.371529131834, 3876.282887665791, 3876.4379165021196, 3895.629915158084, 3899.688024958025, 3918.3338832398563, 5824.388439213864, 5975.193348897887, 6001.15983762278, 6020.969895150496, 6044.637321760664, 3914.9038269284647, 3955.0310174006977, 3963.365861462152, 3970.0868800175544, 3974.2647610192207, 4020.718549701493, 4032.0927791246736, 4032.6572241359813, 4042.535108462506, 4044.676425885922, 4468.670840223989, 4599.770011499411, 4692.882677933079, 4694.43666759991, 4700.694454860423, 5685.260916080883, 5689.0, 5694.747155625756, 5700.4299570043495, 5709.457601527848, 1381.7443772901845, 1387.5213051497217, 1391.554702495212, 1393.958181254564, 1396.615930619088, 878.2929741558107, 922.2022950148073, 928.0580211085753, 938.7559234598917, 942.0814705661925, 4961.479044700327, 4965.864678188414, 4971.4282857471135, 4975.825846095369, 4983.875403114878, 5886.646071403601, 5911.261092363455, 5914.260717410324, 5921.200637913913, 5942.61373010753, 4823.517648235148, 4969.950300497021, 4976.656302798224, 4979.875503112451, 4991.825286114969, 3111.8910838120555, 3115.5482455044344, 3139.01121146838, 3156.9684303156673, 3167.6990685884803, 5556.721953950614, 5582.358028826656, 5598.552115830724, 5601.411851755588, 5605.32736071674, 5808.941910580925, 6011.368806275365, 6071.362506936708, 6083.7870674526175, 6085.817425477243, 5550.500454959073, 5563.276774019432, 5569.944300556943, 5571.972140139354, 5586.273784408082, 5765.740541675718, 5896.587238893237, 5903.26209223847, 5911.3201981772645, 5983.072623743326, 5852.122181672783, 5855.7364918579615, 5870.178175055581, 5873.2658417697785, 5895.263092113486, 5425.620206585501, 5555.50000499957, 5559.499645031967, 5571.832845014656, 5606.393027242352, 3987.342088555356, 3994.940075898806, 4003.7197396181987, 4005.6595189409227, 4012.0972781124015, 5831.241938547962, 5968.492678122235, 5970.149253731406, 5979.402059793986, 5983.551233657406, 5711.200431939449, 5758.280214973129, 5771.7402716877, 5784.595078344475, 5788.27646544182, 5721.771129154788, 5735.0, 5757.280339957505, 5763.366029736641, 5780.768769249183, 5359.732013399393, 5628.662280263197, 5648.971755141198, 5667.914981275367, 5699.173619825185, 5780.075187969905, 5781.537477001746, 5786.1899334094105, 5794.565407594363, 5808.215890854681, 5490.286262785812, 5576.832695019156, 5614.635048721983, 5622.269105016322, 5638.85902852432], "value": 4245.696793508161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.2158474584735, 670.5038271678959, 677.1062197898773, 679.2426444514367, 682.0587589127006, 12262.202956807812, 12648.114631975754, 12723.109382343227, 13636.0, 14158.221297828615, 15377.769333460006, 15413.922930385332, 15418.074915505078, 15558.299876505556, 15562.299696513655, 843.2031730015138, 864.7276108025983, 874.1171416868976, 875.8335916175938, 877.9517126558037, 871.790770215147, 875.5272153037353, 876.837785009772, 880.0275695356635, 880.5905254056862, 899.4018977380034, 905.302916754099, 906.1934877958622, 906.6101576322179, 909.3316412436886, 843.6372359885247, 891.0465801592298, 906.2025417632441, 907.7458311672775, 909.4361495872569, 652.1912828093177, 660.2802944790154, 662.1888186970971, 663.4824836627438, 663.4891133826975, 12938.22370657754, 13008.674783130402, 13077.346132693423, 13090.541831035964, 13093.279869607168, 14933.551993440215, 15920.363185472566, 16120.274587643467, 16134.112623805804, 16263.10552919589, 11464.71338216543, 11813.468393922294, 11855.46650400734, 11940.40297985106, 11991.0, 2870.3828676834373, 2897.9710202897913, 2900.376419069889, 2905.694902035277, 2932.178989882836, 71612.6419367905, 71714.28285717129, 71891.28108718898, 72033.63983180103, 73254.26745732581, 10334.121599664113, 11543.249688770371, 11702.122340824471, 11734.88265117355, 11736.823947640793, 16358.509244722678, 21402.048272144857, 21880.562388752136, 21912.671309930363, 21979.450513736963, 6450.838729031811, 6578.736850525926, 6589.143411356493, 6604.702788374535, 6620.3710647488415, 3165.271987442901, 3204.0548038328748, 3208.246062175387, 3216.903492895217, 3219.517072439153, 3544.858205671744, 3572.3034008368118, 3613.5663720353728, 3672.59601443841, 3674.81625918703, 724.8043028382307, 737.2222305467676, 738.1732459645125, 738.5421038955882, 741.6477173342619, 588.808637192914, 598.099859711132, 607.8237311179709, 608.1394826320707, 618.7030225491699, 9485.857712134324, 9507.714768556954, 9535.427874327563, 9856.112949834549, 9930.602775889029, 611.1413464082971, 612.2499937576433, 615.7875532941129, 623.5385814497239, 634.5716641267127, 4194.0, 4339.674524410619, 4364.563543645673, 4370.278903980808, 4455.22033644111, 63664.0, 63679.36320636734, 64599.67700161469, 66738.0, 67697.66151169213, 54436.0, 54714.0, 55915.0, 55971.0, 56640.43359566434, 50971.7451412748, 52423.0, 53066.73466632642, 53645.0, 53801.1929821053, 8429.126416948011, 8690.0, 8708.909861633289, 8739.38824282294, 8788.736337909873, 25852.35369115787, 26976.595351069358, 27312.0, 27875.303117421416, 28647.0, 42597.57402425936, 43306.0, 44197.0, 44742.55257447384, 45211.7739411314, 13645.863541364459, 13712.108712933627, 13814.516491922734, 13862.376193071537, 14030.228337441538, 15278.930474866653, 15481.0, 15572.143532105843, 15960.361585536448, 16139.273732681822, 13179.538716144889, 13405.798913016508, 13615.387307570985, 13753.793693094813, 13797.448102075805, 14145.222012788983, 14219.431222751387, 14432.206228657524, 14926.253687315373, 15064.623384415478, 13396.928245740122, 13414.12808167466, 13542.932285338511, 13654.044216904722, 14010.299485025504, 9800.411975281506, 9858.950705246429, 10490.475476226311, 11196.944015280198, 11260.549578016788, 10909.127269818237, 11319.886801131883, 11403.771924561297, 11421.543138274375, 11506.30962142274], "value": 6775.999147690452, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0, 115.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 124.0, 182.0, 125.0, 123.0, 124.0, 126.0, 155.0, 123.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 168.0, 166.0, 165.0, 168.0, 168.0, 171.0, 165.0, 163.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 78.0, 114.0, 86.0, 75.0, 76.0, 78.0, 95.0, 80.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 83.0, 84.0, 82.0, 97.0, 83.0, 84.0, 108.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 151.0, 150.0, 152.0, 152.0, 150.0, 151.0, 152.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 57.0, 57.0, 58.0, 59.0, 56.0, 57.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 60.0, 58.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 82.0, 83.0, 84.0, 83.0, 93.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 144.0, 135.0, 140.0, 134.0, 138.0, 138.0, 178.0, 139.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 202.0, 194.0, 198.0, 193.0, 202.0, 197.0, 198.0, 191.0, 187.0], "value": 195.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 77.0, 74.0, 73.0, 75.0, 73.0, 72.0, 72.0], "value": 74.3, "unit": "score"}]}]} 18:04:00 INFO - Return code: 0 18:04:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:04:00 INFO - # TBPL SUCCESS # 18:04:00 INFO - Running post-action listener: _resource_record_post_action 18:04:00 INFO - [mozharness: 2017-05-17 01:04:00.548429Z] Finished run-tests step (success) 18:04:00 INFO - Running post-run listener: _resource_record_post_run 18:04:00 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 374493184; Read time: 8; Write time: 220656 18:04:00 INFO - TinderboxPrint: CPU usage
13.3% 18:04:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:04:00 INFO - TinderboxPrint: I/O write bytes / time
374,493,184 / 220,656 18:04:00 INFO - TinderboxPrint: CPU idle
8,291.5 (86.7%) 18:04:00 INFO - TinderboxPrint: CPU user
1,215.0 (12.7%) 18:04:00 INFO - TinderboxPrint: Swap in / out
0 / 0 18:04:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101376000; Read time: 0; Write time: 83160 18:04:00 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 273117184; Read time: 0; Write time: 137496 18:04:01 INFO - Running post-run listener: _upload_blobber_files 18:04:01 INFO - Blob upload gear active. 18:04:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:01 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 18:04:01 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'] 18:04:01 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 18:04:01 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:04:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:02 INFO - (blobuploader) - INFO - Done attempting. 18:04:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:05 INFO - (blobuploader) - INFO - Done attempting. 18:04:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:04:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:04:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:06 INFO - (blobuploader) - INFO - Done attempting. 18:04:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:04:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:04:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:06 INFO - (blobuploader) - INFO - Done attempting. 18:04:06 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:06 INFO - Return code: 0 18:04:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa79f2a721351649539c5225cbda443df5860616fde936e80c06d8a117dc94efc51e9fa6600c8839469a062c0711fdeae0c398d079f438abe000207ba69e4184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc6a3597bd422515c9a5cf98bea0341fedf74f5c78e63d75b42dab829318fa5aa8288eec0e8cbbc33de011db4acaaa32e8c88a0f7722c968db49f38f708c9438", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6177e09741541e412a4e959732d9eddb6cdc40478023659bb585beb651297b3db66a21d4c8de183ed8a90705109a6dcd9bbd752b48723f30cb63f84179ef3716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ca0e9d4ef09cb79317dd9dd79dfd38eb6ef5f2f40df21c8144acb12c6017fe93b82e73189e0a7b4597943308899e71f396f0543835da646fd1cc51e579ed78a"} 18:04:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:06 INFO - Contents: 18:04:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa79f2a721351649539c5225cbda443df5860616fde936e80c06d8a117dc94efc51e9fa6600c8839469a062c0711fdeae0c398d079f438abe000207ba69e4184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc6a3597bd422515c9a5cf98bea0341fedf74f5c78e63d75b42dab829318fa5aa8288eec0e8cbbc33de011db4acaaa32e8c88a0f7722c968db49f38f708c9438", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6177e09741541e412a4e959732d9eddb6cdc40478023659bb585beb651297b3db66a21d4c8de183ed8a90705109a6dcd9bbd752b48723f30cb63f84179ef3716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ca0e9d4ef09cb79317dd9dd79dfd38eb6ef5f2f40df21c8144acb12c6017fe93b82e73189e0a7b4597943308899e71f396f0543835da646fd1cc51e579ed78a"} 18:04:06 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:06 INFO - Copying logs to upload dir... 18:04:06 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.074702 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-16 18:04:06.229930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 18:04:06.233490) ========= 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=1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057 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/aa79f2a721351649539c5225cbda443df5860616fde936e80c06d8a117dc94efc51e9fa6600c8839469a062c0711fdeae0c398d079f438abe000207ba69e4184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc6a3597bd422515c9a5cf98bea0341fedf74f5c78e63d75b42dab829318fa5aa8288eec0e8cbbc33de011db4acaaa32e8c88a0f7722c968db49f38f708c9438", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6177e09741541e412a4e959732d9eddb6cdc40478023659bb585beb651297b3db66a21d4c8de183ed8a90705109a6dcd9bbd752b48723f30cb63f84179ef3716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ca0e9d4ef09cb79317dd9dd79dfd38eb6ef5f2f40df21c8144acb12c6017fe93b82e73189e0a7b4597943308899e71f396f0543835da646fd1cc51e579ed78a"} build_url:https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/O1TwBxoTRXKxEK1SCn9Txw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa79f2a721351649539c5225cbda443df5860616fde936e80c06d8a117dc94efc51e9fa6600c8839469a062c0711fdeae0c398d079f438abe000207ba69e4184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc6a3597bd422515c9a5cf98bea0341fedf74f5c78e63d75b42dab829318fa5aa8288eec0e8cbbc33de011db4acaaa32e8c88a0f7722c968db49f38f708c9438", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6177e09741541e412a4e959732d9eddb6cdc40478023659bb585beb651297b3db66a21d4c8de183ed8a90705109a6dcd9bbd752b48723f30cb63f84179ef3716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ca0e9d4ef09cb79317dd9dd79dfd38eb6ef5f2f40df21c8144acb12c6017fe93b82e73189e0a7b4597943308899e71f396f0543835da646fd1cc51e579ed78a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 18:04:06.261328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 18:04:06.261699) ========= 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=1f5564757af27664ca02d71f000001b0-1494981603.565664-851345057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 18:04:06.344376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 18:04:06.344721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 18:04:06.345067) ========= ========= Total master_lag: 0.19 =========