builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1494718287.98 results: success (0) revision: 73b3fc64525b6816842c737e104ef2ac5482d217 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:27.983186) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:27.983742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:27.984068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:28.034946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:28.035331) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-13 16:31:28-- 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% 70.1M=0s 2017-05-13 16:31:28 (70.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.188404 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:28.253531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:28.253839) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016936 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:28.303669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:28.304022) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 73b3fc64525b6816842c737e104ef2ac5482d217 --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 73b3fc64525b6816842c737e104ef2ac5482d217 --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=82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-13 16:31:28,453 truncating revision to first 12 chars 2017-05-13 16:31:28,453 Setting DEBUG logging. 2017-05-13 16:31:28,453 attempt 1/10 2017-05-13 16:31:28,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/73b3fc64525b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-13 16:31:28,965 unpacking tar archive at: mozilla-central-73b3fc64525b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.903873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:29.222009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:29.222338) ========= script_repo_revision: 73b3fc64525b6816842c737e104ef2ac5482d217 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:29.222753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:29.223034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-13 16:31:29.232479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-13 16:31:29.232912) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:31:29 INFO - MultiFileLogger online at 20170513 16:31:29 in /builds/slave/test 16:31:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:31:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:29 INFO - {'append_to_log': False, 16:31:29 INFO - 'base_work_dir': '/builds/slave/test', 16:31:29 INFO - 'blob_upload_branch': 'Firefox', 16:31:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:29 INFO - 'branch': 'Firefox', 16:31:29 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:29 INFO - 'config_files': ('talos/linux_config.py',), 16:31:29 INFO - 'default_actions': ('clobber', 16:31:29 INFO - 'read-buildbot-config', 16:31:29 INFO - 'download-and-extract', 16:31:29 INFO - 'populate-webroot', 16:31:29 INFO - 'create-virtualenv', 16:31:29 INFO - 'install', 16:31:29 INFO - 'run-tests'), 16:31:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:29 INFO - 'download_minidump_stackwalk': True, 16:31:29 INFO - 'download_symbols': 'ondemand', 16:31:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:29 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:29 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:29 INFO - 'gecko_profile': False, 16:31:29 INFO - 'gecko_profile_interval': 0, 16:31:29 INFO - 'installer_path': 'installer.exe', 16:31:29 INFO - 'log_level': 'info', 16:31:29 INFO - 'log_name': 'talos', 16:31:29 INFO - 'log_to_console': True, 16:31:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:31:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:31:29 INFO - 'opt_config_files': (), 16:31:29 INFO - 'pip_index': False, 16:31:29 INFO - 'suite': 'dromaeojs', 16:31:29 INFO - 'system_bits': '32', 16:31:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:29 INFO - 'title': 'talos-linux64-ix-066', 16:31:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:29 INFO - 'use_talos_json': True, 16:31:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:29 INFO - 'work_dir': 'build'} 16:31:29 INFO - [mozharness: 2017-05-13 23:31:29.552875Z] Running clobber step. 16:31:29 INFO - Running pre-action listener: _resource_record_pre_action 16:31:29 INFO - Running main action method: clobber 16:31:29 INFO - rmtree: /builds/slave/test/build 16:31:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:30 INFO - Running post-action listener: _resource_record_post_action 16:31:30 INFO - [mozharness: 2017-05-13 23:31:30.513175Z] Finished clobber step (success) 16:31:30 INFO - [mozharness: 2017-05-13 23:31:30.513285Z] Running read-buildbot-config step. 16:31:30 INFO - Running pre-action listener: _resource_record_pre_action 16:31:30 INFO - Running main action method: read_buildbot_config 16:31:30 INFO - Using buildbot properties: 16:31:30 INFO - { 16:31:30 INFO - "project": "", 16:31:30 INFO - "product": "firefox", 16:31:30 INFO - "who": "archaeopteryx@coole-files.de", 16:31:30 INFO - "installer_path": "public/build/target.tar.bz2", 16:31:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:31:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:31:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:31:30 INFO - "stage_platform": "linux64-pgo", 16:31:30 INFO - "basedir": "/builds/slave/test", 16:31:30 INFO - "buildnumber": 183, 16:31:30 INFO - "platform": "ubuntu64_hw", 16:31:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:31:30 INFO - "slavebuilddir": "test", 16:31:30 INFO - "taskId": "DELzAXsFQfi2kfwp0BO8dA", 16:31:30 INFO - "branch": "mozilla-central", 16:31:30 INFO - "script_repo_revision": "production", 16:31:30 INFO - "revision": "73b3fc64525b6816842c737e104ef2ac5482d217", 16:31:30 INFO - "slavename": "talos-linux64-ix-066", 16:31:30 INFO - "repo_path": "mozilla-central" 16:31:30 INFO - } 16:31:30 INFO - Finding installer, test and symbols from parent task. 16:31:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DELzAXsFQfi2kfwp0BO8dA'}, attempt #1 16:31:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DELzAXsFQfi2kfwp0BO8dA'}, attempt #1 16:31:31 INFO - Task dependencies: D9qPfgBfSveAM8hWI7HP1Q 16:31:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q'}, attempt #1 16:31:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.tar.bz2 16:31:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/test_packages.json 16:31:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.crashreporter-symbols.zip 16:31:31 INFO - Running post-action listener: _resource_record_post_action 16:31:31 INFO - [mozharness: 2017-05-13 23:31:31.872493Z] Finished read-buildbot-config step (success) 16:31:31 INFO - [mozharness: 2017-05-13 23:31:31.872709Z] Running download-and-extract step. 16:31:31 INFO - Running pre-action listener: _resource_record_pre_action 16:31:31 INFO - Running main action method: download_and_extract 16:31:31 INFO - mkdir: /builds/slave/test/build/tests 16:31:31 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')]} 16:31:31 INFO - trying https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.test_packages.json 16:31:31 INFO - Downloading https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:31:32 INFO - Downloaded 986 bytes. 16:31:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:31:32 INFO - Using the following test package requirements: 16:31:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:31:32 INFO - u'common': [u'target.common.tests.zip'], 16:31:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:31:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:31:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:31:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:31:32 INFO - u'mozbase': [u'target.common.tests.zip'], 16:31:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:31:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:31:32 INFO - u'web-platform': [u'target.common.tests.zip', 16:31:32 INFO - u'target.web-platform.tests.zip'], 16:31:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:31:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:31:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.common.tests.zip 16:31:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:31:32 INFO - Fetch https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.common.tests.zip into memory 16:31:34 INFO - Content-Length response header: 64598559 16:31:34 INFO - Bytes received: 64598559 16:31:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:31:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.common.tests.zip 16:31:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:31:46 INFO - Fetch https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.common.tests.zip into memory 16:31:47 INFO - Content-Length response header: 64598559 16:31:47 INFO - Bytes received: 64598559 16:31:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.talos.tests.zip 16:31:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:31:59 INFO - Fetch https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.talos.tests.zip into memory 16:32:00 INFO - Content-Length response header: 14409411 16:32:00 INFO - Bytes received: 14409411 16:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:00 INFO - trying https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.tar.bz2 16:32:00 INFO - Downloading https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:32:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:32:02 INFO - Downloaded 68724135 bytes. 16:32:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.tar.bz2 16:32:02 INFO - mkdir: /builds/slave/test/properties 16:32:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:02 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:02 INFO - Contents: 16:32:02 INFO - build_url:https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.tar.bz2 16:32:02 INFO - Running post-action listener: _resource_record_post_action 16:32:02 INFO - Running post-action listener: set_extra_try_arguments 16:32:02 INFO - [mozharness: 2017-05-13 23:32:02.974031Z] Finished download-and-extract step (success) 16:32:02 INFO - [mozharness: 2017-05-13 23:32:02.974160Z] Running populate-webroot step. 16:32:02 INFO - Running pre-action listener: _resource_record_pre_action 16:32:02 INFO - Running main action method: populate_webroot 16:32:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:32:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:32:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:32:02 INFO - '--tppagecycles', 16:32:02 INFO - '7'], 16:32:02 INFO - 'tests': ['tsvgm']}}, 16:32:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:32:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:32:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['damp', 'tps']}, 16:32:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'tests': ['damp', 'tps']}, 16:32:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['dromaeo_dom']}, 16:32:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:32:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:32:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:32:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:32:02 INFO - 'bloom_basic_ref']}, 16:32:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['tsvgx', 16:32:02 INFO - 'tsvgr_opacity', 16:32:02 INFO - 'tart', 16:32:02 INFO - 'tscrollx', 16:32:02 INFO - 'cart', 16:32:02 INFO - 'tsvg_static']}, 16:32:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:02 INFO - 'tsvgr_opacity', 16:32:02 INFO - 'tart', 16:32:02 INFO - 'tscrollx', 16:32:02 INFO - 'cart', 16:32:02 INFO - 'tsvg_static']}, 16:32:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['tp5o']}, 16:32:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:32:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--disable-e10s', 16:32:02 INFO - '--xperf_path', 16:32:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:02 INFO - 'tests': ['tp5n']}, 16:32:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--xperf_path', 16:32:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:02 INFO - 'tests': ['tp5n']}}, 16:32:02 INFO - 'talos.zip': {'path': '', 16:32:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:32:02 INFO - Running post-action listener: _resource_record_post_action 16:32:02 INFO - [mozharness: 2017-05-13 23:32:02.992743Z] Finished populate-webroot step (success) 16:32:02 INFO - [mozharness: 2017-05-13 23:32:02.992861Z] Running create-virtualenv step. 16:32:02 INFO - Running pre-action listener: _resource_record_pre_action 16:32:02 INFO - Running main action method: create_virtualenv 16:32:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32:02 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 16:32:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:03 INFO - Using real prefix '/usr' 16:32:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:05 INFO - Installing pip.................done. 16:32:05 INFO - Return code: 0 16:32:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:32:06 INFO - Reading from file tmpfile_stdout 16:32:06 INFO - Output received: 16:32:06 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) 16:32:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:06 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 16:32:06 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 16:32:06 INFO - Using env: {'DISPLAY': ':0', 16:32:06 INFO - 'HOME': '/home/cltbld', 16:32:06 INFO - 'LANG': 'en_US.UTF-8', 16:32:06 INFO - 'LANGUAGE': 'en_US:en', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MAIL': '/var/mail/cltbld', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SHLVL': '1', 16:32:06 INFO - 'TERM': 'linux', 16:32:06 INFO - 'TMOUT': '86400', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - '_': '/tools/buildbot/bin/python'} 16:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:06 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 16:32:06 INFO - Cleaning up... 16:32:06 INFO - Return code: 0 16:32:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:06 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 16:32:06 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 16:32:06 INFO - Using env: {'DISPLAY': ':0', 16:32:06 INFO - 'HOME': '/home/cltbld', 16:32:06 INFO - 'LANG': 'en_US.UTF-8', 16:32:06 INFO - 'LANGUAGE': 'en_US:en', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MAIL': '/var/mail/cltbld', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SHLVL': '1', 16:32:06 INFO - 'TERM': 'linux', 16:32:06 INFO - 'TMOUT': '86400', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - '_': '/tools/buildbot/bin/python'} 16:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:06 INFO - Downloading/unpacking psutil>=3.1.1 16:32:06 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 16:32:06 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 16:32:06 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 16:32:06 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 16:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:07 INFO - Installing collected packages: psutil 16:32:07 INFO - Running setup.py install for psutil 16:32:07 INFO - building 'psutil._psutil_linux' extension 16:32:07 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 16:32:08 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 16:32:09 INFO - building 'psutil._psutil_posix' extension 16:32:09 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 16:32:09 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 16:32:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:09 INFO - Successfully installed psutil 16:32:09 INFO - Cleaning up... 16:32:09 INFO - Return code: 0 16:32:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32:09 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')]} 16:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:09 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')]} 16:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:09 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:09 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 16:32:09 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 16:32:09 INFO - Using env: {'DISPLAY': ':0', 16:32:09 INFO - 'HOME': '/home/cltbld', 16:32:09 INFO - 'LANG': 'en_US.UTF-8', 16:32:09 INFO - 'LANGUAGE': 'en_US:en', 16:32:09 INFO - 'LOGNAME': 'cltbld', 16:32:09 INFO - 'MAIL': '/var/mail/cltbld', 16:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:09 INFO - 'MOZ_NO_REMOTE': '1', 16:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:09 INFO - 'NO_EM_RESTART': '1', 16:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:09 INFO - 'PWD': '/builds/slave/test', 16:32:09 INFO - 'SHELL': '/bin/bash', 16:32:09 INFO - 'SHLVL': '1', 16:32:09 INFO - 'TERM': 'linux', 16:32:09 INFO - 'TMOUT': '86400', 16:32:09 INFO - 'USER': 'cltbld', 16:32:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:09 INFO - '_': '/tools/buildbot/bin/python'} 16:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:32:10 INFO - Installing collected packages: mozsystemmonitor 16:32:10 INFO - Running setup.py install for mozsystemmonitor 16:32:10 INFO - Successfully installed mozsystemmonitor 16:32:10 INFO - Cleaning up... 16:32:10 INFO - Return code: 0 16:32:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:32:10 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')]} 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:10 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')]} 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:10 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:10 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 16:32:10 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 16:32:10 INFO - Using env: {'DISPLAY': ':0', 16:32:10 INFO - 'HOME': '/home/cltbld', 16:32:10 INFO - 'LANG': 'en_US.UTF-8', 16:32:10 INFO - 'LANGUAGE': 'en_US:en', 16:32:10 INFO - 'LOGNAME': 'cltbld', 16:32:10 INFO - 'MAIL': '/var/mail/cltbld', 16:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:10 INFO - 'MOZ_NO_REMOTE': '1', 16:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:10 INFO - 'NO_EM_RESTART': '1', 16:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:10 INFO - 'PWD': '/builds/slave/test', 16:32:10 INFO - 'SHELL': '/bin/bash', 16:32:10 INFO - 'SHLVL': '1', 16:32:10 INFO - 'TERM': 'linux', 16:32:10 INFO - 'TMOUT': '86400', 16:32:10 INFO - 'USER': 'cltbld', 16:32:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:10 INFO - '_': '/tools/buildbot/bin/python'} 16:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:11 INFO - Downloading/unpacking jsonschema==2.5.1 16:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:32:12 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 16:32:12 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 16:32:12 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 16:32:12 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 16:32:12 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:12 INFO - warning: no files found matching '*.txt' 16:32:12 INFO - no previously-included directories found matching 'build' 16:32:12 INFO - no previously-included directories found matching 'dist' 16:32:12 INFO - no previously-included directories found matching '.git*' 16:32:12 INFO - Installing collected packages: jsonschema, functools32 16:32:12 INFO - Running setup.py install for functools32 16:32:12 INFO - warning: no files found matching '*.txt' 16:32:12 INFO - no previously-included directories found matching 'build' 16:32:12 INFO - no previously-included directories found matching 'dist' 16:32:12 INFO - no previously-included directories found matching '.git*' 16:32:12 INFO - Successfully installed jsonschema functools32 16:32:12 INFO - Cleaning up... 16:32:12 INFO - Return code: 0 16:32:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:32:12 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')]} 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:12 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')]} 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:12 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:12 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 16:32:12 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 16:32:12 INFO - Using env: {'DISPLAY': ':0', 16:32:12 INFO - 'HOME': '/home/cltbld', 16:32:12 INFO - 'LANG': 'en_US.UTF-8', 16:32:12 INFO - 'LANGUAGE': 'en_US:en', 16:32:12 INFO - 'LOGNAME': 'cltbld', 16:32:12 INFO - 'MAIL': '/var/mail/cltbld', 16:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:12 INFO - 'MOZ_NO_REMOTE': '1', 16:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:12 INFO - 'NO_EM_RESTART': '1', 16:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:12 INFO - 'PWD': '/builds/slave/test', 16:32:12 INFO - 'SHELL': '/bin/bash', 16:32:12 INFO - 'SHLVL': '1', 16:32:12 INFO - 'TERM': 'linux', 16:32:12 INFO - 'TMOUT': '86400', 16:32:12 INFO - 'USER': 'cltbld', 16:32:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:12 INFO - '_': '/tools/buildbot/bin/python'} 16:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:32:12 INFO - Cleaning up... 16:32:12 INFO - Return code: 0 16:32:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:12 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')]} 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:12 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')]} 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:12 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:12 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 16:32:12 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 16:32:12 INFO - Using env: {'DISPLAY': ':0', 16:32:12 INFO - 'HOME': '/home/cltbld', 16:32:12 INFO - 'LANG': 'en_US.UTF-8', 16:32:12 INFO - 'LANGUAGE': 'en_US:en', 16:32:12 INFO - 'LOGNAME': 'cltbld', 16:32:12 INFO - 'MAIL': '/var/mail/cltbld', 16:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:12 INFO - 'MOZ_NO_REMOTE': '1', 16:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:12 INFO - 'NO_EM_RESTART': '1', 16:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:12 INFO - 'PWD': '/builds/slave/test', 16:32:12 INFO - 'SHELL': '/bin/bash', 16:32:12 INFO - 'SHLVL': '1', 16:32:12 INFO - 'TERM': 'linux', 16:32:12 INFO - 'TMOUT': '86400', 16:32:12 INFO - 'USER': 'cltbld', 16:32:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:12 INFO - '_': '/tools/buildbot/bin/python'} 16:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:12 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:12 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 16:32:12 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 16:32:12 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 16:32:12 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 16:32:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32:14 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 16:32:14 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 16:32:14 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 16:32:14 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 16:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32:14 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 16:32:14 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 16:32:14 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 16:32:14 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 16:32:14 INFO - Downloading docopt-0.6.1.tar.gz 16:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:14 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:14 INFO - Running setup.py install for blobuploader 16:32:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:14 INFO - Running setup.py install for requests 16:32:15 INFO - Running setup.py install for docopt 16:32:15 INFO - Successfully installed blobuploader requests docopt 16:32:15 INFO - Cleaning up... 16:32:15 INFO - Return code: 0 16:32:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:15 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:15 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 16:32:15 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 16:32:15 INFO - Using env: {'DISPLAY': ':0', 16:32:15 INFO - 'HOME': '/home/cltbld', 16:32:15 INFO - 'LANG': 'en_US.UTF-8', 16:32:15 INFO - 'LANGUAGE': 'en_US:en', 16:32:15 INFO - 'LOGNAME': 'cltbld', 16:32:15 INFO - 'MAIL': '/var/mail/cltbld', 16:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:15 INFO - 'MOZ_NO_REMOTE': '1', 16:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:15 INFO - 'NO_EM_RESTART': '1', 16:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:15 INFO - 'PWD': '/builds/slave/test', 16:32:15 INFO - 'SHELL': '/bin/bash', 16:32:15 INFO - 'SHLVL': '1', 16:32:15 INFO - 'TERM': 'linux', 16:32:15 INFO - 'TMOUT': '86400', 16:32:15 INFO - 'USER': 'cltbld', 16:32:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:15 INFO - '_': '/tools/buildbot/bin/python'} 16:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:15 INFO - Running setup.py (path:/tmp/pip-o2Z5pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:15 INFO - Running setup.py (path:/tmp/pip-b7iRxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:15 INFO - Running setup.py (path:/tmp/pip-yuFqz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:15 INFO - Running setup.py (path:/tmp/pip-mBANDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:15 INFO - Running setup.py (path:/tmp/pip-phU6j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:15 INFO - Running setup.py (path:/tmp/pip-FGrKvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:15 INFO - Running setup.py (path:/tmp/pip-3g5nbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:15 INFO - Running setup.py (path:/tmp/pip-arw4p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:16 INFO - Running setup.py (path:/tmp/pip-SZzo7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:16 INFO - Running setup.py (path:/tmp/pip-rMC6eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:16 INFO - Running setup.py (path:/tmp/pip-RwFRE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:16 INFO - Running setup.py (path:/tmp/pip-aLhCJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:16 INFO - Running setup.py (path:/tmp/pip-WLzSCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:16 INFO - Running setup.py (path:/tmp/pip-6UragC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:16 INFO - Running setup.py (path:/tmp/pip-GB_44i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:16 INFO - Running setup.py (path:/tmp/pip-mLITwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:16 INFO - Running setup.py (path:/tmp/pip-xYAD0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:16 INFO - Running setup.py install for manifestparser 16:32:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Running setup.py install for mozcrash 16:32:16 INFO - Running setup.py install for mozdebug 16:32:17 INFO - Running setup.py install for mozdevice 16:32:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozfile 16:32:17 INFO - Running setup.py install for mozhttpd 16:32:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozinfo 16:32:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozInstall 16:32:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozleak 16:32:17 INFO - Running setup.py install for mozlog 16:32:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for moznetwork 16:32:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozprocess 16:32:17 INFO - Running setup.py install for mozprofile 16:32:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for mozrunner 16:32:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for mozscreenshot 16:32:18 INFO - Running setup.py install for moztest 16:32:18 INFO - Running setup.py install for mozversion 16:32:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:18 INFO - Cleaning up... 16:32:18 INFO - Return code: 0 16:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:18 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:18 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 16:32:18 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 16:32:18 INFO - Using env: {'DISPLAY': ':0', 16:32:18 INFO - 'HOME': '/home/cltbld', 16:32:18 INFO - 'LANG': 'en_US.UTF-8', 16:32:18 INFO - 'LANGUAGE': 'en_US:en', 16:32:18 INFO - 'LOGNAME': 'cltbld', 16:32:18 INFO - 'MAIL': '/var/mail/cltbld', 16:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:18 INFO - 'MOZ_NO_REMOTE': '1', 16:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:18 INFO - 'NO_EM_RESTART': '1', 16:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:18 INFO - 'PWD': '/builds/slave/test', 16:32:18 INFO - 'SHELL': '/bin/bash', 16:32:18 INFO - 'SHLVL': '1', 16:32:18 INFO - 'TERM': 'linux', 16:32:18 INFO - 'TMOUT': '86400', 16:32:18 INFO - 'USER': 'cltbld', 16:32:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:18 INFO - '_': '/tools/buildbot/bin/python'} 16:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:18 INFO - Running setup.py (path:/tmp/pip-QKi34t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:18 INFO - Running setup.py (path:/tmp/pip-qpKOUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:18 INFO - Running setup.py (path:/tmp/pip-oxy6Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:18 INFO - Running setup.py (path:/tmp/pip-pwDzei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:18 INFO - Running setup.py (path:/tmp/pip-PJcTtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:19 INFO - Running setup.py (path:/tmp/pip-xnCAxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:19 INFO - Running setup.py (path:/tmp/pip-NsrGZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:19 INFO - Running setup.py (path:/tmp/pip-MJ2b5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:19 INFO - Running setup.py (path:/tmp/pip-HE8zEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:19 INFO - Running setup.py (path:/tmp/pip-QaPbK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:19 INFO - Running setup.py (path:/tmp/pip-rCXwQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:19 INFO - Running setup.py (path:/tmp/pip-Y33m5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:19 INFO - Running setup.py (path:/tmp/pip-W3xqyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:19 INFO - Running setup.py (path:/tmp/pip-ucRUfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:19 INFO - Running setup.py (path:/tmp/pip-ajTgQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:19 INFO - Running setup.py (path:/tmp/pip-EUmcWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:19 INFO - Running setup.py (path:/tmp/pip-75K81O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:19 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 16:32:19 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 16:32:19 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 16:32:19 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 16:32:21 INFO - Downloading blessings-1.6.tar.gz 16:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:21 INFO - Installing collected packages: blessings 16:32:21 INFO - Running setup.py install for blessings 16:32:21 INFO - Successfully installed blessings 16:32:21 INFO - Cleaning up... 16:32:21 INFO - Return code: 0 16:32:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:21 INFO - Reading from file tmpfile_stdout 16:32:21 INFO - Current package versions: 16:32:21 INFO - argparse == 1.2.1 16:32:21 INFO - blessings == 1.6 16:32:21 INFO - blobuploader == 1.2.4 16:32:21 INFO - docopt == 0.6.1 16:32:21 INFO - functools32 == 3.2.3-2 16:32:21 INFO - jsonschema == 2.5.1 16:32:21 INFO - manifestparser == 1.1 16:32:21 INFO - mozInstall == 1.12 16:32:21 INFO - mozcrash == 1.0 16:32:21 INFO - mozdebug == 0.1 16:32:21 INFO - mozdevice == 0.50 16:32:21 INFO - mozfile == 1.2 16:32:21 INFO - mozhttpd == 0.7 16:32:21 INFO - mozinfo == 0.9 16:32:21 INFO - mozleak == 0.1 16:32:21 INFO - mozlog == 3.4 16:32:21 INFO - moznetwork == 0.27 16:32:21 INFO - mozprocess == 0.25 16:32:21 INFO - mozprofile == 0.28 16:32:21 INFO - mozrunner == 6.13 16:32:21 INFO - mozscreenshot == 0.1 16:32:21 INFO - mozsystemmonitor == 0.3 16:32:21 INFO - moztest == 0.8 16:32:21 INFO - mozversion == 1.4 16:32:21 INFO - psutil == 3.1.1 16:32:21 INFO - requests == 1.2.3 16:32:21 INFO - wsgiref == 0.1.2 16:32:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:21 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 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:21 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 16:32:21 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 16:32:21 INFO - Using env: {'DISPLAY': ':0', 16:32:21 INFO - 'HOME': '/home/cltbld', 16:32:21 INFO - 'LANG': 'en_US.UTF-8', 16:32:21 INFO - 'LANGUAGE': 'en_US:en', 16:32:21 INFO - 'LOGNAME': 'cltbld', 16:32:21 INFO - 'MAIL': '/var/mail/cltbld', 16:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:21 INFO - 'MOZ_NO_REMOTE': '1', 16:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:21 INFO - 'NO_EM_RESTART': '1', 16:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:21 INFO - 'PWD': '/builds/slave/test', 16:32:21 INFO - 'SHELL': '/bin/bash', 16:32:21 INFO - 'SHLVL': '1', 16:32:21 INFO - 'TERM': 'linux', 16:32:21 INFO - 'TMOUT': '86400', 16:32:21 INFO - 'USER': 'cltbld', 16:32:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:21 INFO - '_': '/tools/buildbot/bin/python'} 16:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 INFO - Cleaning up... 16:32:21 INFO - Return code: 0 16:32:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', '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 16:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:32:21 INFO - Using env: {'DISPLAY': ':0', 16:32:21 INFO - 'HOME': '/home/cltbld', 16:32:21 INFO - 'LANG': 'en_US.UTF-8', 16:32:21 INFO - 'LANGUAGE': 'en_US:en', 16:32:21 INFO - 'LOGNAME': 'cltbld', 16:32:21 INFO - 'MAIL': '/var/mail/cltbld', 16:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:21 INFO - 'MOZ_NO_REMOTE': '1', 16:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:21 INFO - 'NO_EM_RESTART': '1', 16:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:21 INFO - 'PWD': '/builds/slave/test', 16:32:21 INFO - 'SHELL': '/bin/bash', 16:32:21 INFO - 'SHLVL': '1', 16:32:21 INFO - 'TERM': 'linux', 16:32:21 INFO - 'TMOUT': '86400', 16:32:21 INFO - 'USER': 'cltbld', 16:32:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:21 INFO - '_': '/tools/buildbot/bin/python'} 16:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:21 INFO - Cleaning up... 16:32:21 INFO - Return code: 0 16:32:21 INFO - Running post-action listener: _resource_record_post_action 16:32:21 INFO - Running post-action listener: _start_resource_monitoring 16:32:21 INFO - Starting resource monitoring. 16:32:21 INFO - [mozharness: 2017-05-13 23:32:21.980943Z] Finished create-virtualenv step (success) 16:32:21 INFO - [mozharness: 2017-05-13 23:32:21.981473Z] Running install step. 16:32:21 INFO - Running pre-action listener: _resource_record_pre_action 16:32:21 INFO - Running main action method: install 16:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:22 INFO - Reading from file tmpfile_stdout 16:32:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:22 INFO - Reading from file tmpfile_stdout 16:32:22 INFO - Output received: 16:32:22 INFO - Usage: mozinstall [options] installer 16:32:22 INFO - Options: 16:32:22 INFO - -h, --help show this help message and exit 16:32:22 INFO - -d DEST, --destination=DEST 16:32:22 INFO - Directory to install application into. [default: 16:32:22 INFO - "/builds/slave/test"] 16:32:22 INFO - --app=APP Application being installed. [default: firefox] 16:32:22 INFO - mkdir: /builds/slave/test/build/application 16:32:22 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'] 16:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:32:39 INFO - Reading from file tmpfile_stdout 16:32:39 INFO - Output received: 16:32:39 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:39 INFO - Running post-action listener: _resource_record_post_action 16:32:39 INFO - [mozharness: 2017-05-13 23:32:39.367888Z] Finished install step (success) 16:32:39 INFO - [mozharness: 2017-05-13 23:32:39.368134Z] Running run-tests step. 16:32:39 INFO - Running pre-action listener: _resource_record_pre_action 16:32:39 INFO - Running main action method: run_tests 16:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:39 INFO - Python 2.7.3 16:32:39 INFO - Return code: 0 16:32:39 INFO - grabbing minidump binary from tooltool 16:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:39 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 0x1215a30>, '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 0x12167f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:39 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 16:32:39 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 16:32:39 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 16:32:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:39 INFO - Return code: 0 16:32:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:39 INFO - ENV: RUST_BACKTRACE is now 1 16:32:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:32:39 INFO - Using env: {'DISPLAY': ':0', 16:32:39 INFO - 'HOME': '/home/cltbld', 16:32:39 INFO - 'LANG': 'en_US.UTF-8', 16:32:39 INFO - 'LANGUAGE': 'en_US:en', 16:32:39 INFO - 'LOGNAME': 'cltbld', 16:32:39 INFO - 'MAIL': '/var/mail/cltbld', 16:32:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:39 INFO - 'MOZ_NO_REMOTE': '1', 16:32:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:39 INFO - 'NO_EM_RESTART': '1', 16:32:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:39 INFO - 'PWD': '/builds/slave/test', 16:32:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:39 INFO - 'RUST_BACKTRACE': '1', 16:32:39 INFO - 'SHELL': '/bin/bash', 16:32:39 INFO - 'SHLVL': '1', 16:32:39 INFO - 'TERM': 'linux', 16:32:39 INFO - 'TMOUT': '86400', 16:32:39 INFO - 'USER': 'cltbld', 16:32:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011', 16:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:39 INFO - '_': '/tools/buildbot/bin/python'} 16:32:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:32:39 INFO - mozversion application_buildid: 20170513223750 16:32:39 INFO - mozversion application_changeset: 73b3fc64525b6816842c737e104ef2ac5482d217 16:32:39 INFO - mozversion application_display_name: Nightly 16:32:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:39 INFO - mozversion application_name: Firefox 16:32:39 INFO - mozversion application_remotingname: firefox 16:32:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:32:39 INFO - mozversion application_vendor: Mozilla 16:32:39 INFO - mozversion application_version: 55.0a1 16:32:39 INFO - mozversion platform_buildid: 20170513223750 16:32:39 INFO - mozversion platform_changeset: 73b3fc64525b6816842c737e104ef2ac5482d217 16:32:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:32:39 INFO - mozversion platform_version: 55.0a1 16:32:39 INFO - using testdate: 1494718359 16:32:39 INFO - actual date: 1494718359 16:32:39 INFO - starting webserver on 'localhost:47014' 16:32:39 INFO - SUITE-START | Running 2 tests 16:32:39 INFO - TEST-START | dromaeo_css 16:32:39 INFO - operating with platform_type : linux_ 16:32:39 INFO - Initialising browser for dromaeo_css test... 16:32:39 INFO - TEST-INFO | started process 3310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx0zEUo/profile http://localhost:47014/getInfo.html) 16:32:44 INFO - PID 3310 | __metrics Screen width/height:1600/1200 16:32:44 INFO - PID 3310 | colorDepth:24 16:32:44 INFO - PID 3310 | Browser inner width/height: 1024/695 16:32:44 INFO - PID 3310 | __metrics 16:32:45 INFO - PID 3310 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:32:45 INFO - PID 3310 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:46 INFO - TEST-INFO | 3310: exit 0 16:32:46 INFO - Browser initialized. 16:32:46 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:46 INFO - TEST-INFO | started process 3406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx0zEUo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:57 INFO - PID 3406 | RSS: Main: 144953344 16:32:57 INFO - PID 3406 | 16:35:59 INFO - PID 3406 | Cycle 1(1): loaded http://localhost:47014/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47014/tests/dromaeo/cssquery-ext.html) 16:36:01 INFO - PID 3406 | RSS: Main: 304652288 16:36:01 INFO - PID 3406 | 16:39:03 INFO - PID 3406 | Cycle 1(1): loaded http://localhost:47014/tests/dromaeo/cssquery-ext.html (next: http://localhost:47014/tests/dromaeo/cssquery-jquery.html) 16:39:03 INFO - PID 3406 | RSS: Main: 220114944 16:39:03 INFO - PID 3406 | 16:42:05 INFO - PID 3406 | Cycle 1(1): loaded http://localhost:47014/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47014/tests/dromaeo/cssquery-mootools.html) 16:42:05 INFO - PID 3406 | RSS: Main: 210604032 16:42:05 INFO - PID 3406 | 16:45:07 INFO - PID 3406 | Cycle 1(1): loaded http://localhost:47014/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47014/tests/dromaeo/cssquery-prototype.html) 16:45:08 INFO - PID 3406 | RSS: Main: 175984640 16:45:08 INFO - PID 3406 | 16:48:11 INFO - PID 3406 | Cycle 1(1): loaded http://localhost:47014/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47014/tests/dromaeo/cssquery-yui.html) 16:48:11 INFO - PID 3406 | RSS: Main: 178782208 16:48:11 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | Cycle 1(1): loaded http://localhost:47014/tests/dromaeo/cssquery-yui.html (next: http://localhost:47014/tests/dromaeo/cssquery-dojo.html) 16:51:13 INFO - PID 3406 | RSS: Main: 272457728 16:51:13 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | __start_tp_report 16:51:13 INFO - PID 3406 | _x_x_mozilla_page_load 16:51:13 INFO - PID 3406 | _x_x_mozilla_page_load_details 16:51:13 INFO - PID 3406 | |i|pagename|runs| 16:51:13 INFO - PID 3406 | |0;dojo.html;3279.9180020499484;3298.6536413676563;3322.9003129906096;3332.0503656457886;3342.766006379553;5659.60382773206;5723.170140329655;5762.683052432119;5763.9711801441035;5765.509931655814;5695.0318445864195;5745.396733343002;5745.942540574593;5758;5761.855953601162;5086;5108.872278193037;5114.718690472041;5180;5207.843764687065;5204.635675502716;5216.374035115772;5217.765200565965;5223.399309079447;5224.164133738603;40.55106348592222;5146.794128234867;5234.267202591621;5256.868578285555;5292.973535132338;4542.432195975503;5078.619103567247;5181.818636347747;5186.040582492251;5212.817551385721;5136.332276804029;5153.098207813618;5161.4322424533275;5166.07010738067;5200.6619569727845;5633.492985631272;5654.915176272318;5756.194132821366;5768.682722450264;5793.710314484259;6114.996965385497;6136.2636483622255;6185.8144255672405;6199.845003874939;6201;6258.061290806416;6266.028765541303;6286.402791734778;6298.559100862942;6299.401556852092;5829.5336373090895;5832;5835.3198251887425;5837.09525023622;5870.11948207768;6195.566310358322;6220.7511699532415;6263.78076767311;6388.265349484869;6408.58344207625;6098.408161645036;6101.974255744823;6105.322780187474;6108.918862504643;6142.170806941006;6139.009643731611;6186.536009799283;6192.783252586228;6193.318734939243;6204.81385558434;6029.8191054268445;6110.224634763485;6112.908306375408;6114.527975159776;6187.504999600022;6201.720922558496;6223.502119830403;6224.657643829632;6229.283632382243;6235.127082208494;4724.385829842098;4727.881802954885;4729.337892695025;4752.667313288106;4766.428028636586;4140.3168477201525;4152.335626299838;4172.666186705056;4184.058586818002;4188.099558594917;5775.826725198251;5777.942220577825;5816.970915145482;5818.0981947798155;5824.592278540546;6091.238595175603;6175.475084617858;6183.474404675563;6185.969070154711;6193.783217587453;5697.658140511582;5704.686242256716;5741.942580574141;5756.3380211276235;5761.078227483583;5238.554722848525;5251.606129540223;5281.947180528223;5294.073537131064;5300.787968481218;6459.386358295955;6468.579542329733;6470.579412338183;6474.514411419163;6478.4169424752;6096.390360963868;6211.6792666229985;6251.374862513712;6259.467945224706;6274.1843560336865;6288.591241569284;6406.199225096863;6456.967715161394;6458.063580780855;6489.221293444817;6130.570860039755;6177.938220617916;6181.567290289637;6186.19579454668;6188.226471691039;6295.96852015737;6303.896818056914;6305.117283580211;6307.432331090224;6307.873842523032;5897.616654917417;5968.104784282393;6063.605865618721;6099.237595300588;6108.6945652716295;6083.422074903054;6093.268807743099;6093.725782339894;6099.085137229451;6133.723982420713;5975.701214939322;6062.545309101747;6072.14989901423;6075.817725468066;6080.179175811209;5989;6028.246469191351;6065.332813390435;6068.393160684073;6075.453209211192;5863.501602363847;5899.056151015817;5907;5930.911036334544;6004.759809607567 16:51:13 INFO - PID 3406 | |1;ext.html;733.22278384912;801.7434420985285;828.5360198288959;1114.3369695031454;1137.3232926408784;28804.56793148102;35645.643543564554;36747.26505469889;36795.26409471816;36906.26187476249;37485.06287342818;37876.81061594688;37898.62101378985;37945;37995.430068548994;5511.22842802008;5706.457886500776;7131.928680713191;7283.053203083618;7285.817854553626;6641.302663220365;7241.4568907331895;7244.203137654854;7251.6374181290985;7255.383292420124;7296.2338954409815;7397;7409.851802963937;7416.480846340758;7421.294976977206;7311.670974806147;7366.447516436288;7376.889346659805;7386.224446433154;7386.667599958015;7201.135863696338;7245.384142347907;7255.52839065459;7257.056582644275;7267.49127561071;34179.316413671586;34269.11519866406;34358.6564134358;34550.654493455;34569;3430.811305378203;3442.225499262671;3463.9954413220134;3465.549478567795;3467.098554375855;27223.319417014536;27248.45503089947;27319.86340068287;27326.726732732615;27330.726692733217;3148.6064241969752;3154.4322022036026;3161.272907231327;3171.0328349853285;3174.4603417419094;181115;181257;181372;181808;182050;43251.78374108109;43677.56322436799;43728.344074838904;43741.34387984183;43758.998560230844;45140.77429612831;45459.31811022837;45467.09065818665;45559;45561;15087.773683394758;15182.164980926154;15199.316030778642;15207.771883421758;15227.467038653594;10922.126229901747;11180.329180249211;12617.936910315573;12626.179298345578;12626.936865315614;11894.702632434259;11992.820107698391;12164.33096179701;12196;12256.325902075294;5097.770600322994;5197.7141257231215;5246.658967167122;5260.13207820713;5292.655977361459;1046.2362475392854;1081.8809930907594;1086.3861918016296;1091.7980173667897;1094.1574987259764;24846.503069938863;24961.25426203116;24965.12622058219;25025.62461563078;25035.12377066794;1163.4938801621322;1169.1640477058943;1170.78925793358;1172.5192671004847;1201.7776711308436;12352.62942111738;13209.801852972214;13222.206667599974;13268.867311326956;13277.269750163641;216262;216464;216521;217414;218899;49850.25224621633;49854.252186217236;49869;49915.75042124766;49931.500684993414;1486.0934829753842;1504.308018311589;1525.877929765616;1533.2103966457285;1535.6314484523857;23138.652920205874;24370.512589747752;24477.265682029567;24661.13686020981;24692.876535617925;36592.45111323385;36598.634013659524;36616.267674645824;36627.633723662424;36656.63343366532;187708;190338.04830975758;190787;191552;192105;29061.41877162487;32089.197770055936;32451.18872028218;33329.83335083309;33521.16197094994;35561.82219088888;35868.461973069905;35871.82064089663;35886.64113358833;38266.6173338263;29908;32164.839175803972;32418;32552.348953020333;33183.668163318056;31278;31283.84358078195;32359.352812944082;32361.19097022499;32750.181245469055;37388.43917341297;37487.25025499529;37635.435468468546;37639.81180094082;37768.244635106596;29120.56319155172;30199.698003020567;30212.395752084394;30430.54354184733;31323.530147047357;24665.383365416008;24747.381315467257;24992.625110623718;25357.239282821545;25763.613545796452 16:51:13 INFO - PID 3406 | |2;jquery.html;430.86643140626387;437.78329726785245;441.1728009981284;448.65453600727443;451.78991768827507;17896.284148634055;19100.80899191008;19688.606227875433;19758.308459203894;19771.802281977176;19890.303839365624;20035.298764543244;20176;20531.692024619642;20942;5454.509094181523;5663.122216056518;5664.122061080539;5667.603267771257;5674.063779476382;5468.453154684519;5564.165375193713;5665.5467562594895;5691.178822776692;5693.459121383462;5660.405657405975;5669.234653321811;5670.8015219467325;5676.205331253607;5680.857978550549;5460.34475862899;5579.944200557983;5585.525230355424;5663.490285874271;5670.262865827437;5058.4688607696025;5069.77186026626;5075.898482030376;5076.416212135615;5085.821996230115;24972.750272497226;26045.869770651025;26251;26303.21090367292;26447.47105057907;2123.203798575534;2152.461884528868;2158.082814803702;2160.643493823533;2162.351294611626;16050.197490125563;16379;16654;16798.664026719518;17298.913505432392;2139.069504765432;2195.571863486605;2210.9447263818533;2216.523447458788;2231.832612554065;106382.46808765907;107190;108721.99999999921;109499.45250273698;110049;12322.630321090382;12548.81176782349;12658.367081645882;12671.17637353569;12679.112462127563;17206.741898871525;17277.65444691099;17286;17304.134793260288;17359.392421265195;8898;9242.953785231031;9292.256619470427;9378.765530861783;9380.249580033718;8511.787205319917;8523.147685231428;8607;8806.86789698155;8823.602937867812;7697.961510192413;7889.723859664884;8008;8032.196780321921;8209;2168.1544197762887;2179.3679832848297;2181.640029395132;2211.635080211747;2349;1019.6380284998867;1042.827933390982;1048.7902419516126;1056.3503445381036;1056.5298442193305;19409.32067377635;19688.70466942997;21114.261000864895;21188.364349069554;21402;1021.4177918586483;1042.5569133118395;1052.3580615824342;1066.8186408310605;1079.6760971708457;11234.606788762354;11607.361595112181;11612.167984565072;11645.184837061493;11706.88293117075;455391;459404;461449;505083;508067;92166.53916730374;93733;94131.52934235285;94761;95065.5246723762;1159.576754484624;1176.0944073063692;1208.1844754790482;1226.938653067361;1227.5151315230612;17767;17868.55328616743;18211;18443.417921490734;18450.538736531693;45204;47016.05967880555;47127.76436117797;47717.52282477131;47726.284105737745;59636.70181649064;60944.39055609565;61374;62105.68947155235;62840.685796570724;8893.777655558662;8991.550422478718;9382;9500.619975200914;9593.568289427132;14425.711485770436;14472;14491;15001.324940377492;15205;12138.211016283913;12389.442475088463;12703.809442858179;12972.870271297166;13274.402651880495;11061.723456913642;11105.611303604335;11212.66362009141;11244.493997770283;11370.260933039326;12710.428030738824;12904.354782261038;13037.348132593523;13347.332633368487;13357.265350405432;9005.549722513717;9109.954450227706;9244.445333280024;9405.294602904673;9416.576254068721;11953.521859125538;12537.87462125367;12966.092373533762;12984;13105 16:51:13 INFO - PID 3406 | |3;mootools.html;1182.9112816538761;1317.8220940173076;1352.9797053044206;1372.7734923737578;1377.7244551089782;9575.281853860954;10637.734056648578;11152.944235278832;11170.888291117097;11182.832257516124;10991.285566438177;11246.606368777095;11250.943745281262;11252.324860508375;11262.605808796694;1986.860919735619;2064.6696528555435;2330.6154484510034;2370.383700237933;2374.2165085521738;2292.908283668651;2370.2178281167176;2375.489269806991;2379.678743369649;2382.7498112698177;2361.291612516247;2381.7499162587937;2389.4026493376655;2393.56915755164;2397.4725560376687;2330.067972810872;2343.496148328109;2345.167465549731;2349.130821596012;2351.2123438648073;2243.618584840565;2254.458929856839;2299.7930186283147;2329.9068037278657;2331.5919714049974;10932.398718070503;11031.503582338733;11034.668959931216;11035;11041.503132358983;6121.846953826145;6345.365463453618;6346.460550853183;6347.365263473662;6359.936400635981;3596.1189508570305;3666.6150054244454;3853.1523064925673;3868.032991752062;3876.7286289959716;1283.1915892987358;1337.3580681273043;1359.0622470495327;1364.8908087353086;1365.1808914651228;16215.83784162167;16532.669346613002;16547.420840270654;16560.254788534425;16566.1716914155;5278.366596008426;5317.1492561190025;5351.170568561879;5438.238646589481;5561.138023606348;13797.448102076005;13803.03378763477;13807.792883106762;13814.309284535733;13822.93088534551;6221.595596286227;6300.180976473029;6310.400511951358;6460.25707043696;6461.547691661539;4360.803763830635;5824.88350232993;5826.796062137805;5873.823785286449;5922.466977972003;4353.455818022747;4407.625351845065;4413.911721765547;4489.595936365743;4527.796249168795;1268.0743057568027;1317.0846261848114;1318.5780550223835;1332.5202926946292;1348.0967751606447;839.202757380491;848.728406909783;863.0635760200128;873.4802792338548;890.5547226386807;6659.167604049494;6910.412614927687;6913.2049814270995;6956.582605043714;6962.512624116364;648.0441349010172;649.1658219188321;650.2067477677226;655.8391646785259;661.4047357378398;4013.5585085640555;4027.657649099801;4032.5160980681917;4048.8785336439364;4104.363823607346;14249.145051296955;14744.778828317583;14766.704665906622;14789.778153327708;14791.70416591662;12880.227186368847;13314.46742130304;14510.709785804225;14518;14548;8044.758657240292;8250.752477425687;8368.623411946355;8712.128787121237;8932.687355942511;6544.5418820684;6550.508711846726;6615.272320044887;6632.071509988702;6837.247902730795;12574.559890403792;12736.872631273569;13164.210147391188;13168;13169.473221071434;13300.667483312995;13327.733445330845;13399.12905661129;13406.932965335502;13448.93275533616;8380.916190838014;8726.781830454289;9104.726858194264;9244.306676999386;9431.622735090794;10213.387196768217;10325.483725813829;10423.114035307084;10428.322159059637;10463.476826158814;8824.735257942271;8897.510636915033;8901.109889011048;9137.817243655223;9242.676506322516;8972.237359824489;9013.369064165445;9086.591103400231;9090.454572725657;9271.629134834531;7863.567503787347;7959.243871832166;8013.15861834499;8044.31623312025;8044.959775201087;5824.155497452761;5848.122781582797;5879.794207202727;5902.911456328073;6162.506999440124;5941.58408911372;5943.435373639497;5970.9701451492465;6014;6207.441330280297 16:51:13 INFO - PID 3406 | |4;prototype.html;383.6662103969547;398.1499498570553;406.1937054945932;409.0244766232535;411.5308548254989;5811.418858114186;5838.737256823442;5844.3279022912375;5855.79504717335;5870.324912635043;5570.805021824237;5736.397678243787;5741.081426971686;5748;5780.277465316835;4477.10457908418;4477.999999999992;4479.372887795695;4489.326601009859;4500.437445319335;4471.441069866267;4479.641628669715;4494.68537202396;4509.962708577029;4511.390962220091;4176.728512646669;4330.090680956987;4343.674224433164;4349.282368409209;4469.88825279369;4284.635805956482;4301.118270754488;4321.243782338078;4350.58669426404;4354.129174165164;3799.1072098056934;3804.258169656918;3806.219724956405;3818.0645741793437;3823.1589050408866;5395.730213489349;5591.720413979285;5619.409961953977;5631.774729010835;5678.829635110953;5065.366829146356;5079.187330027178;5089.066154861166;5105.055564720501;5109.56568691658;6019.69901504923;6021.458068773832;6071.210742603477;6088.939110608926;6105.206323177958;4040.3535434330365;4083.836646534135;4115.8765237042935;4133.21468920904;4137.2552940470705;6006.519478441714;6211.19254496917;6310.274318453345;6361.777337793155;6392.872142557169;4222.1766755483;4327.545607711145;4347;4359.084592235603;4365.148795984753;4148.149629325981;4211.957880421218;4237.618614324726;4414.757188354672;4425.402570652985;4963.45402005779;4996.750162491933;4998.2502624606595;5000.774965126505;5000.974800165957;6069;6078.939210607838;6100.267967843887;6102.908456373158;6137.5703700741415;1489.8957073004785;1507.4347119830063;1507.6683129711446;1520.7186670465999;1522.3834347089446;961.8172547216006;982.7150126463389;985.6747273399761;991.6083147156833;992.7418871093568;5773.162891380726;5799.739011744397;5805;5826.82519524415;5865.765369385262;6234.594751341239;6274.152989346471;6278.560500764903;6281.586643005287;6313.273973493016;5696.572757043238;5775.104858746901;5811.709414529341;5844.327902291206;5867.559933005042;3258.3809076275907;3287.3918325109453;3301.603807543062;3304.8182349970984;3317.9004629861142;6296.307406185316;6393.488520918316;6445.939058393183;6474.643894585843;6478.870422591522;6346.58747181441;6361.650109244036;6376.202974628171;6415.486761059104;6422.775202867971;6368.490520758328;6468.450181734511;6473.967630161819;6487.935120648827;6515.706793194412;6234.75060997555;6248.781292654735;6255.155554000152;6262.123302737529;6266.592671476339;5883;6034.969825150846;6065.6663883486835;6167.823570860921;6216.53375996793;6278.968605157128;6447.451966582893;6454.290028097;6478.773242936474;6482.384173503509;4276.422682937764;4355.259605866947;4359.782010899379;4365.847195348148;4373.606375426227;6188.783392581238;6194.274519211533;6198.969005154945;6221.688915554295;6232;6114;6114.615300032901;6119.632822030692;6119.84700382494;6120.1125836752535;5912.408759124053;6024.33732289439;6047.485963693135;6107.480864126599;6120.724567394389;6065.5754097212775;6078.3921607838865;6078.696065196811;6084.296397008845;6095.634261944298;5935.881282374415;6062.575619706755;6063.878722425438;6130.2030736004035;6132.448079672851;5919.7568510613255;5953.434423729739;5956.434138756811;5957.463828255478;5971.910421343597 16:51:13 INFO - PID 3406 | |5;yui.html;862.6894318045504;870.843248215321;873.6811063961655;882.1839798186679;899.020068125743;16494;16659.333626654934;17188.914055429705;17199.656006879854;17200.053997030158;16315.83684163158;16384.75422868658;16488.258028388722;16519.752203716955;16529.91735041326;977.2621670638658;1006.4967516241879;1022.7545389106598;1023.3092662452851;1023.800358930009;1020.3316827478013;1024.4416792847878;1026.1277913773308;1027.773889744259;1031.3863251365426;1080.8486811846349;1081.1296905990675;1082.123479981214;1083.9187060970419;1085.679724481276;1059.369675043352;1068.40169505077;1073.683263437288;1076.8923107689247;1078.4553800330782;782.1474592693991;783.7844592736986;783.9804004899867;785.5561607691693;785.7407055671615;14932;14956.177410242432;15732.528024159179;16155.273012714339;16567.25447354872;17165.656686866318;17359.698022648226;17718.734218986727;17747.911260443616;17882.105894705343;15034.548963531002;15191.924040379727;15383.461578844686;15411.691766164615;15565.610859728484;3490.249596336774;3507.6843084122297;3509.7192224621967;3510.0873772818995;3513.7364697647777;81852.59073704593;85148;85531;86199;87643;15149.166795826335;15171.848281517265;15206.923965380101;15296.617584560476;15308.693826123637;27247.455050898872;27562.310942226202;27681.307967300978;28032.43935121327;28052.158435246976;7670.4247181461615;7727.034120734908;7730.033745781778;7735.845283094307;7750.379969602418;4230.15396920611;4233.322668373107;4263.317869140923;4270.338097594878;4308.116836048603;4246.532881383046;4358.084802191575;4361.5856493633055;4363.280058790264;4369.69412141147;922.9769255768659;984.3650845204803;1014.4065721552827;1027.6660085472251;1033.3593172233263;711.6797441151502;720.4920531025614;732.6702983657375;736.7568702328219;754.0762565856782;10671.83992240117;11743.17797754149;12001.039916806634;12395.814062789066;12488.313142777053;678.2539206872401;685.6674512861258;690.3752104345475;695.7808290388512;710.1832892173938;5299.973500132474;5563.13771365439;5610.4670056344585;5653.265075540236;5660.29246344207;81890.59054704689;82856;85721.57139214264;87350.56324718335;87893;73292;74250;74832.99999999891;75562.24437755662;78090.60954695304;66420.33579664142;68672.65663671649;68691.65654171797;69075.3092469079;69134.65432672905;10475.790484190426;10938.507767150339;10963.451827408757;11099.167562432689;11128.276662017266;36109.63890361063;36339.27321453609;36354;36515.63484365229;37520;43091.35362969495;43340.34989475223;43439.34840977324;43542.56457435385;45553.772231139956;14792.11247325164;15023.248837558296;15137.394504220149;15246.237688115772;15376.692466150838;15448;17168.65662686714;17706.82293177052;17995.2801887923;18325.450236492925;15884.841151588336;15974.201289935689;16051.839481605035;16399.262033208295;16641.251143698322;16558.337666493204;16726;16937.32250709958;17111.486655400357;17250.65498690044;16307;16602.16989150562;16762.832371676126;17856.375026873997;17952.640947181244;11796.823047654121;12323.938380308042;12574.1198116131;13416.463341466231;14299.499517516837;13606.727865442834;14144.575662730134;14302.928485357506;14435.92782036083;14605.342759576057 16:51:13 INFO - PID 3406 | __end_tp_report 16:51:13 INFO - PID 3406 | __start_cc_report 16:51:13 INFO - PID 3406 | _x_x_mozilla_cycle_collect,1604 16:51:13 INFO - PID 3406 | __end_cc_report 16:51:13 INFO - PID 3406 | __startTimestamp1494719473631__endTimestamp 16:51:13 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | ------- Summary: start ------- 16:51:13 INFO - PID 3406 | Number of tests: 6 16:51:13 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | [#0] dojo.html Cycles:165 Average:5699.92 Median:5989.00 stddev:812.29 (13.6%) stddev-sans-first:792.28 16:51:13 INFO - PID 3406 | Values: 3279.9 3298.7 3322.9 3332.1 3342.8 5659.6 5723.2 5762.7 5764.0 5765.5 5695.0 5745.4 5745.9 5758.0 5761.9 5086.0 5108.9 5114.7 5180.0 5207.8 5204.6 5216.4 5217.8 5223.4 5224.2 40.6 5146.8 5234.3 5256.9 5293.0 4542.4 5078.6 5181.8 5186.0 5212.8 5136.3 5153.1 5161.4 5166.1 5200.7 5633.5 5654.9 5756.2 5768.7 5793.7 6115.0 6136.3 6185.8 6199.8 6201.0 6258.1 6266.0 6286.4 6298.6 6299.4 5829.5 5832.0 5835.3 5837.1 5870.1 6195.6 6220.8 6263.8 6388.3 6408.6 6098.4 6102.0 6105.3 6108.9 6142.2 6139.0 6186.5 6192.8 6193.3 6204.8 6029.8 6110.2 6112.9 6114.5 6187.5 6201.7 6223.5 6224.7 6229.3 6235.1 4724.4 4727.9 4729.3 4752.7 4766.4 4140.3 4152.3 4172.7 4184.1 4188.1 5775.8 5777.9 5817.0 5818.1 5824.6 6091.2 6175.5 6183.5 6186.0 6193.8 5697.7 5704.7 5741.9 5756.3 5761.1 5238.6 5251.6 5281.9 5294.1 5300.8 6459.4 6468.6 6470.6 6474.5 6478.4 6096.4 6211.7 6251.4 6259.5 6274.2 6288.6 6406.2 6457.0 6458.1 6489.2 6130.6 6177.9 6181.6 6186.2 6188.2 6296.0 6303.9 6305.1 6307.4 6307.9 5897.6 5968.1 6063.6 6099.2 6108.7 6083.4 6093.3 6093.7 6099.1 6133.7 5975.7 6062.5 6072.1 6075.8 6080.2 5989.0 6028.2 6065.3 6068.4 6075.5 5863.5 5899.1 5907.0 5930.9 6004.8 16:51:13 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | [#1] ext.html Cycles:180 Average:35510.96 Median:32389.60 stddev:50954.97 (157.3%) stddev-sans-first:51031.00 16:51:13 INFO - PID 3406 | Values: 733.2 801.7 828.5 1114.3 1137.3 28804.6 35645.6 36747.3 36795.3 36906.3 37485.1 37876.8 37898.6 37945.0 37995.4 5511.2 5706.5 7131.9 7283.1 7285.8 6641.3 7241.5 7244.2 7251.6 7255.4 7296.2 7397.0 7409.9 7416.5 7421.3 7311.7 7366.4 7376.9 7386.2 7386.7 7201.1 7245.4 7255.5 7257.1 7267.5 34179.3 34269.1 34358.7 34550.7 34569.0 3430.8 3442.2 3464.0 3465.5 3467.1 27223.3 27248.5 27319.9 27326.7 27330.7 3148.6 3154.4 3161.3 3171.0 3174.5 181115.0 181257.0 181372.0 181808.0 182050.0 43251.8 43677.6 43728.3 43741.3 43759.0 45140.8 45459.3 45467.1 45559.0 45561.0 15087.8 15182.2 15199.3 15207.8 15227.5 10922.1 11180.3 12617.9 12626.2 12626.9 11894.7 11992.8 12164.3 12196.0 12256.3 5097.8 5197.7 5246.7 5260.1 5292.7 1046.2 1081.9 1086.4 1091.8 1094.2 24846.5 24961.3 24965.1 25025.6 25035.1 1163.5 1169.2 1170.8 1172.5 1201.8 12352.6 13209.8 13222.2 13268.9 13277.3 216262.0 216464.0 216521.0 217414.0 218899.0 49850.3 49854.3 49869.0 49915.8 49931.5 1486.1 1504.3 1525.9 1533.2 1535.6 23138.7 24370.5 24477.3 24661.1 24692.9 36592.5 36598.6 36616.3 36627.6 36656.6 187708.0 190338.0 190787.0 191552.0 192105.0 29061.4 32089.2 32451.2 33329.8 33521.2 35561.8 35868.5 35871.8 35886.6 38266.6 29908.0 32164.8 32418.0 32552.3 33183.7 31278.0 31283.8 32359.4 32361.2 32750.2 37388.4 37487.3 37635.4 37639.8 37768.2 29120.6 30199.7 30212.4 30430.5 31323.5 24665.4 24747.4 24992.6 25357.2 25763.6 16:51:13 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | [#2] jquery.html Cycles:180 Average:30487.14 Median:2165.25 stddev:79540.52 (3673.5%) stddev-sans-first:79731.64 16:51:13 INFO - PID 3406 | Values: 430.9 437.8 441.2 448.7 451.8 17896.3 19100.8 19688.6 19758.3 19771.8 19890.3 20035.3 20176.0 20531.7 20942.0 5454.5 5663.1 5664.1 5667.6 5674.1 5468.5 5564.2 5665.5 5691.2 5693.5 5660.4 5669.2 5670.8 5676.2 5680.9 5460.3 5579.9 5585.5 5663.5 5670.3 5058.5 5069.8 5075.9 5076.4 5085.8 24972.8 26045.9 26251.0 26303.2 26447.5 2123.2 2152.5 2158.1 2160.6 2162.4 16050.2 16379.0 16654.0 16798.7 17298.9 2139.1 2195.6 2210.9 2216.5 2231.8 106382.5 107190.0 108722.0 109499.5 110049.0 12322.6 12548.8 12658.4 12671.2 12679.1 17206.7 17277.7 17286.0 17304.1 17359.4 8898.0 9243.0 9292.3 9378.8 9380.2 8511.8 8523.1 8607.0 8806.9 8823.6 7698.0 7889.7 8008.0 8032.2 8209.0 2168.2 2179.4 2181.6 2211.6 2349.0 1019.6 1042.8 1048.8 1056.4 1056.5 19409.3 19688.7 21114.3 21188.4 21402.0 1021.4 1042.6 1052.4 1066.8 1079.7 11234.6 11607.4 11612.2 11645.2 11706.9 455391.0 459404.0 461449.0 505083.0 508067.0 92166.5 93733.0 94131.5 94761.0 95065.5 1159.6 1176.1 1208.2 1226.9 1227.5 17767.0 17868.6 18211.0 18443.4 18450.5 45204.0 47016.1 47127.8 47717.5 47726.3 59636.7 60944.4 61374.0 62105.7 62840.7 8893.8 8991.6 9382.0 9500.6 9593.6 14425.7 14472.0 14491.0 15001.3 15205.0 12138.2 12389.4 12703.8 12972.9 13274.4 11061.7 11105.6 11212.7 11244.5 11370.3 12710.4 12904.4 13037.3 13347.3 13357.3 9005.5 9110.0 9244.4 9405.3 9416.6 11953.5 12537.9 12966.1 12984.0 13105.0 16:51:13 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | [#3] mootools.html Cycles:180 Average:6958.80 Median:3759.88 stddev:4464.40 (118.7%) stddev-sans-first:4455.82 16:51:13 INFO - PID 3406 | Values: 1182.9 1317.8 1353.0 1372.8 1377.7 9575.3 10637.7 11152.9 11170.9 11182.8 10991.3 11246.6 11250.9 11252.3 11262.6 1986.9 2064.7 2330.6 2370.4 2374.2 2292.9 2370.2 2375.5 2379.7 2382.7 2361.3 2381.7 2389.4 2393.6 2397.5 2330.1 2343.5 2345.2 2349.1 2351.2 2243.6 2254.5 2299.8 2329.9 2331.6 10932.4 11031.5 11034.7 11035.0 11041.5 6121.8 6345.4 6346.5 6347.4 6359.9 3596.1 3666.6 3853.2 3868.0 3876.7 1283.2 1337.4 1359.1 1364.9 1365.2 16215.8 16532.7 16547.4 16560.3 16566.2 5278.4 5317.1 5351.2 5438.2 5561.1 13797.4 13803.0 13807.8 13814.3 13822.9 6221.6 6300.2 6310.4 6460.3 6461.5 4360.8 5824.9 5826.8 5873.8 5922.5 4353.5 4407.6 4413.9 4489.6 4527.8 1268.1 1317.1 1318.6 1332.5 1348.1 839.2 848.7 863.1 873.5 890.6 6659.2 6910.4 6913.2 6956.6 6962.5 648.0 649.2 650.2 655.8 661.4 4013.6 4027.7 4032.5 4048.9 4104.4 14249.1 14744.8 14766.7 14789.8 14791.7 12880.2 13314.5 14510.7 14518.0 14548.0 8044.8 8250.8 8368.6 8712.1 8932.7 6544.5 6550.5 6615.3 6632.1 6837.2 12574.6 12736.9 13164.2 13168.0 13169.5 13300.7 13327.7 13399.1 13406.9 13448.9 8380.9 8726.8 9104.7 9244.3 9431.6 10213.4 10325.5 10423.1 10428.3 10463.5 8824.7 8897.5 8901.1 9137.8 9242.7 8972.2 9013.4 9086.6 9090.5 9271.6 7863.6 7959.2 8013.2 8044.3 8045.0 5824.2 5848.1 5879.8 5902.9 6162.5 5941.6 5943.4 5971.0 6014.0 6207.4 16:51:13 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | [#4] prototype.html Cycles:180 Average:5075.23 Median:5850.06 stddev:1527.81 (26.1%) stddev-sans-first:1490.96 16:51:13 INFO - PID 3406 | Values: 383.7 398.1 406.2 409.0 411.5 5811.4 5838.7 5844.3 5855.8 5870.3 5570.8 5736.4 5741.1 5748.0 5780.3 4477.1 4478.0 4479.4 4489.3 4500.4 4471.4 4479.6 4494.7 4510.0 4511.4 4176.7 4330.1 4343.7 4349.3 4469.9 4284.6 4301.1 4321.2 4350.6 4354.1 3799.1 3804.3 3806.2 3818.1 3823.2 5395.7 5591.7 5619.4 5631.8 5678.8 5065.4 5079.2 5089.1 5105.1 5109.6 6019.7 6021.5 6071.2 6088.9 6105.2 4040.4 4083.8 4115.9 4133.2 4137.3 6006.5 6211.2 6310.3 6361.8 6392.9 4222.2 4327.5 4347.0 4359.1 4365.1 4148.1 4212.0 4237.6 4414.8 4425.4 4963.5 4996.8 4998.3 5000.8 5001.0 6069.0 6078.9 6100.3 6102.9 6137.6 1489.9 1507.4 1507.7 1520.7 1522.4 961.8 982.7 985.7 991.6 992.7 5773.2 5799.7 5805.0 5826.8 5865.8 6234.6 6274.2 6278.6 6281.6 6313.3 5696.6 5775.1 5811.7 5844.3 5867.6 3258.4 3287.4 3301.6 3304.8 3317.9 6296.3 6393.5 6445.9 6474.6 6478.9 6346.6 6361.7 6376.2 6415.5 6422.8 6368.5 6468.5 6474.0 6487.9 6515.7 6234.8 6248.8 6255.2 6262.1 6266.6 5883.0 6035.0 6065.7 6167.8 6216.5 6279.0 6447.5 6454.3 6478.8 6482.4 4276.4 4355.3 4359.8 4365.8 4373.6 6188.8 6194.3 6199.0 6221.7 6232.0 6114.0 6114.6 6119.6 6119.8 6120.1 5912.4 6024.3 6047.5 6107.5 6120.7 6065.6 6078.4 6078.7 6084.3 6095.6 5935.9 6062.6 6063.9 6130.2 6132.4 5919.8 5953.4 5956.4 5957.5 5971.9 16:51:13 INFO - PID 3406 | 16:51:13 INFO - PID 3406 | [#5] yui.html Cycles:180 Average:19040.86 Median:17733.32 stddev:23379.31 (131.8%) stddev-sans-first:23405.04 16:51:13 INFO - PID 3406 | Values: 862.7 870.8 873.7 882.2 899.0 16494.0 16659.3 17188.9 17199.7 17200.1 16315.8 16384.8 16488.3 16519.8 16529.9 977.3 1006.5 1022.8 1023.3 1023.8 1020.3 1024.4 1026.1 1027.8 1031.4 1080.8 1081.1 1082.1 1083.9 1085.7 1059.4 1068.4 1073.7 1076.9 1078.5 782.1 783.8 784.0 785.6 785.7 14932.0 14956.2 15732.5 16155.3 16567.3 17165.7 17359.7 17718.7 17747.9 17882.1 15034.5 15191.9 15383.5 15411.7 15565.6 3490.2 3507.7 3509.7 3510.1 3513.7 81852.6 85148.0 85531.0 86199.0 87643.0 15149.2 15171.8 15206.9 15296.6 15308.7 27247.5 27562.3 27681.3 28032.4 28052.2 7670.4 7727.0 7730.0 7735.8 7750.4 4230.2 4233.3 4263.3 4270.3 4308.1 4246.5 4358.1 4361.6 4363.3 4369.7 923.0 984.4 1014.4 1027.7 1033.4 711.7 720.5 732.7 736.8 754.1 10671.8 11743.2 12001.0 12395.8 12488.3 678.3 685.7 690.4 695.8 710.2 5300.0 5563.1 5610.5 5653.3 5660.3 81890.6 82856.0 85721.6 87350.6 87893.0 73292.0 74250.0 74833.0 75562.2 78090.6 66420.3 68672.7 68691.7 69075.3 69134.7 10475.8 10938.5 10963.5 11099.2 11128.3 36109.6 36339.3 36354.0 36515.6 37520.0 43091.4 43340.3 43439.3 43542.6 45553.8 14792.1 15023.2 15137.4 15246.2 15376.7 15448.0 17168.7 17706.8 17995.3 18325.5 15884.8 15974.2 16051.8 16399.3 16641.3 16558.3 16726.0 16937.3 17111.5 17250.7 16307.0 16602.2 16762.8 17856.4 17952.6 11796.8 12323.9 12574.1 13416.5 14299.5 13606.7 14144.6 14302.9 14435.9 14605.3 16:51:13 INFO - PID 3406 | -------- Summary: end -------- 16:51:13 INFO - PID 3406 | 16:51:14 INFO - TEST-INFO | 3406: exit 0 16:51:14 INFO - TEST-OK | dromaeo_css | took 1114596ms 16:51:14 INFO - TEST-START | kraken 16:51:14 INFO - operating with platform_type : linux_ 16:51:14 INFO - Initialising browser for kraken test... 16:51:14 INFO - TEST-INFO | started process 3733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyS7BWR/profile http://localhost:47014/getInfo.html) 16:51:18 INFO - PID 3733 | __metrics Screen width/height:1600/1200 16:51:18 INFO - PID 3733 | colorDepth:24 16:51:18 INFO - PID 3733 | Browser inner width/height: 1024/695 16:51:18 INFO - PID 3733 | __metrics 16:51:19 INFO - PID 3733 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:51:19 INFO - PID 3733 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:51:20 INFO - TEST-INFO | 3733: exit 0 16:51:20 INFO - Browser initialized. 16:51:20 INFO - Running cycle 1/1 for kraken test... 16:51:20 INFO - TEST-INFO | started process 3831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyS7BWR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:31 INFO - PID 3831 | RSS: Main: 149090304 16:51:31 INFO - PID 3831 | 16:51:34 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47014/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:35 INFO - PID 3831 | RSS: Main: 217571328 16:51:35 INFO - PID 3831 | 16:51:37 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47014/tests/kraken/driver.html?testName=audio-dft) 16:51:38 INFO - PID 3831 | RSS: Main: 178909184 16:51:38 INFO - PID 3831 | 16:51:41 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47014/tests/kraken/driver.html?testName=audio-fft) 16:51:41 INFO - PID 3831 | RSS: Main: 261042176 16:51:41 INFO - PID 3831 | 16:51:44 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47014/tests/kraken/driver.html?testName=audio-oscillator) 16:51:44 INFO - PID 3831 | RSS: Main: 171892736 16:51:44 INFO - PID 3831 | 16:51:46 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47014/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:47 INFO - PID 3831 | RSS: Main: 175464448 16:51:47 INFO - PID 3831 | 16:51:50 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47014/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:50 INFO - PID 3831 | RSS: Main: 235835392 16:51:50 INFO - PID 3831 | 16:51:54 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47014/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:54 INFO - PID 3831 | RSS: Main: 250433536 16:51:54 INFO - PID 3831 | 16:51:57 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47014/tests/kraken/driver.html?testName=json-parse-financial) 16:51:58 INFO - PID 3831 | RSS: Main: 261296128 16:51:58 INFO - PID 3831 | 16:51:59 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47014/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:00 INFO - PID 3831 | RSS: Main: 198946816 16:52:00 INFO - PID 3831 | 16:52:01 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47014/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:02 INFO - PID 3831 | RSS: Main: 203591680 16:52:02 INFO - PID 3831 | 16:52:04 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47014/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:05 INFO - PID 3831 | RSS: Main: 213471232 16:52:05 INFO - PID 3831 | 16:52:07 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:08 INFO - PID 3831 | RSS: Main: 222613504 16:52:08 INFO - PID 3831 | 16:52:11 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:11 INFO - PID 3831 | RSS: Main: 217305088 16:52:11 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | Cycle 1(1): loaded http://localhost:47014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47014/tests/kraken/driver.html?testName=ai-astar) 16:52:13 INFO - PID 3831 | RSS: Main: 268460032 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | __start_tp_report 16:52:13 INFO - PID 3831 | _x_x_mozilla_page_load 16:52:13 INFO - PID 3831 | _x_x_mozilla_page_load_details 16:52:13 INFO - PID 3831 | |i|pagename|runs| 16:52:13 INFO - PID 3831 | |0;ai-astar;103;109;109;109;109;108;108;109;110;109 16:52:13 INFO - PID 3831 | |1;audio-beat-detection;147;116;125;166;119;119;118;116;137;119 16:52:13 INFO - PID 3831 | |2;audio-dft;161;160;161;163;161;161;163;162;162;162 16:52:13 INFO - PID 3831 | |3;audio-fft;73;74;74;109;75;74;74;74;95;74 16:52:13 INFO - PID 3831 | |4;audio-oscillator;82;83;101;82;83;81;96;82;82;108 16:52:13 INFO - PID 3831 | |5;imaging-gaussian-blur;113;113;112;113;112;112;113;113;113;113 16:52:13 INFO - PID 3831 | |6;imaging-darkroom;146;147;151;147;147;147;147;146;146;147 16:52:13 INFO - PID 3831 | |7;imaging-desaturate;93;94;94;94;94;94;93;93;94;94 16:52:13 INFO - PID 3831 | |8;json-parse-financial;48;49;47;48;48;54;50;48;49;49 16:52:13 INFO - PID 3831 | |9;json-stringify-tinderbox;55;55;55;55;54;55;57;55;55;57 16:52:13 INFO - PID 3831 | |10;stanford-crypto-aes;81;78;79;78;79;86;78;79;78;78 16:52:13 INFO - PID 3831 | |11;stanford-crypto-ccm;127;127;126;124;125;125;123;123;182;126 16:52:13 INFO - PID 3831 | |12;stanford-crypto-pbkdf2;172;184;181;189;180;182;182;180;182;173 16:52:13 INFO - PID 3831 | |13;stanford-crypto-sha256-iterative;68;68;65;65;66;65;65;65;67;63 16:52:13 INFO - PID 3831 | __end_tp_report 16:52:13 INFO - PID 3831 | __start_cc_report 16:52:13 INFO - PID 3831 | _x_x_mozilla_cycle_collect,1701 16:52:13 INFO - PID 3831 | __end_cc_report 16:52:13 INFO - PID 3831 | __startTimestamp1494719533765__endTimestamp 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | ------- Summary: start ------- 16:52:13 INFO - PID 3831 | Number of tests: 14 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:1.95 (1.8%) stddev-sans-first:0.60 16:52:13 INFO - PID 3831 | Values: 103.0 109.0 109.0 109.0 109.0 108.0 108.0 109.0 110.0 109.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:122.00 stddev:16.75 (13.7%) stddev-sans-first:16.33 16:52:13 INFO - PID 3831 | Values: 147.0 116.0 125.0 166.0 119.0 119.0 118.0 116.0 137.0 119.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 16:52:13 INFO - PID 3831 | Values: 161.0 160.0 161.0 163.0 161.0 161.0 163.0 162.0 162.0 162.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#3] audio-fft Cycles:10 Average:79.60 Median:74.00 stddev:12.27 (16.6%) stddev-sans-first:12.78 16:52:13 INFO - PID 3831 | Values: 73.0 74.0 74.0 109.0 75.0 74.0 74.0 74.0 95.0 74.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.00 stddev:9.87 (12.0%) stddev-sans-first:10.22 16:52:13 INFO - PID 3831 | Values: 82.0 83.0 101.0 82.0 83.0 81.0 96.0 82.0 82.0 108.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:52:13 INFO - PID 3831 | Values: 113.0 113.0 112.0 113.0 112.0 112.0 113.0 113.0 113.0 113.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.45 (1.0%) stddev-sans-first:1.48 16:52:13 INFO - PID 3831 | Values: 146.0 147.0 151.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 16:52:13 INFO - PID 3831 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#8] json-parse-financial Cycles:10 Average:49.00 Median:49.00 stddev:1.94 (4.0%) stddev-sans-first:2.03 16:52:13 INFO - PID 3831 | Values: 48.0 49.0 47.0 48.0 48.0 54.0 50.0 48.0 49.0 49.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 16:52:13 INFO - PID 3831 | Values: 55.0 55.0 55.0 55.0 54.0 55.0 57.0 55.0 55.0 57.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.50 (3.2%) stddev-sans-first:2.59 16:52:13 INFO - PID 3831 | Values: 81.0 78.0 79.0 78.0 79.0 86.0 78.0 79.0 78.0 78.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:126.00 stddev:18.05 (14.3%) stddev-sans-first:19.09 16:52:13 INFO - PID 3831 | Values: 127.0 127.0 126.0 124.0 125.0 125.0 123.0 123.0 182.0 126.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:182.00 stddev:4.95 (2.7%) stddev-sans-first:4.19 16:52:13 INFO - PID 3831 | Values: 172.0 184.0 181.0 189.0 180.0 182.0 182.0 180.0 182.0 173.0 16:52:13 INFO - PID 3831 | 16:52:13 INFO - PID 3831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:1.57 (2.4%) stddev-sans-first:1.42 16:52:13 INFO - PID 3831 | Values: 68.0 68.0 65.0 65.0 66.0 65.0 65.0 65.0 67.0 63.0 16:52:13 INFO - PID 3831 | -------- Summary: end -------- 16:52:13 INFO - PID 3831 | 16:52:14 INFO - TEST-INFO | 3831: exit 0 16:52:14 INFO - TEST-OK | kraken | took 60427ms 16:52:14 INFO - SUITE-END | took 1175s 16:52:14 INFO - Completed test suite (00:19:35) 16:52:14 INFO - javascript benchmark 16:52:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7533.042281567442, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.9180020499484, 3298.6536413676563, 3322.9003129906096, 3332.0503656457886, 3342.766006379553, 5659.60382773206, 5723.170140329655, 5762.683052432119, 5763.9711801441035, 5765.509931655814, 5695.0318445864195, 5745.396733343002, 5745.942540574593, 5758.0, 5761.855953601162, 5086.0, 5108.872278193037, 5114.718690472041, 5180.0, 5207.843764687065, 5204.635675502716, 5216.374035115772, 5217.765200565965, 5223.399309079447, 5224.164133738603, 40.55106348592222, 5146.794128234867, 5234.267202591621, 5256.868578285555, 5292.973535132338, 4542.432195975503, 5078.619103567247, 5181.818636347747, 5186.040582492251, 5212.817551385721, 5136.332276804029, 5153.098207813618, 5161.4322424533275, 5166.07010738067, 5200.6619569727845, 5633.492985631272, 5654.915176272318, 5756.194132821366, 5768.682722450264, 5793.710314484259, 6114.996965385497, 6136.2636483622255, 6185.8144255672405, 6199.845003874939, 6201.0, 6258.061290806416, 6266.028765541303, 6286.402791734778, 6298.559100862942, 6299.401556852092, 5829.5336373090895, 5832.0, 5835.3198251887425, 5837.09525023622, 5870.11948207768, 6195.566310358322, 6220.7511699532415, 6263.78076767311, 6388.265349484869, 6408.58344207625, 6098.408161645036, 6101.974255744823, 6105.322780187474, 6108.918862504643, 6142.170806941006, 6139.009643731611, 6186.536009799283, 6192.783252586228, 6193.318734939243, 6204.81385558434, 6029.8191054268445, 6110.224634763485, 6112.908306375408, 6114.527975159776, 6187.504999600022, 6201.720922558496, 6223.502119830403, 6224.657643829632, 6229.283632382243, 6235.127082208494, 4724.385829842098, 4727.881802954885, 4729.337892695025, 4752.667313288106, 4766.428028636586, 4140.3168477201525, 4152.335626299838, 4172.666186705056, 4184.058586818002, 4188.099558594917, 5775.826725198251, 5777.942220577825, 5816.970915145482, 5818.0981947798155, 5824.592278540546, 6091.238595175603, 6175.475084617858, 6183.474404675563, 6185.969070154711, 6193.783217587453, 5697.658140511582, 5704.686242256716, 5741.942580574141, 5756.3380211276235, 5761.078227483583, 5238.554722848525, 5251.606129540223, 5281.947180528223, 5294.073537131064, 5300.787968481218, 6459.386358295955, 6468.579542329733, 6470.579412338183, 6474.514411419163, 6478.4169424752, 6096.390360963868, 6211.6792666229985, 6251.374862513712, 6259.467945224706, 6274.1843560336865, 6288.591241569284, 6406.199225096863, 6456.967715161394, 6458.063580780855, 6489.221293444817, 6130.570860039755, 6177.938220617916, 6181.567290289637, 6186.19579454668, 6188.226471691039, 6295.96852015737, 6303.896818056914, 6305.117283580211, 6307.432331090224, 6307.873842523032, 5897.616654917417, 5968.104784282393, 6063.605865618721, 6099.237595300588, 6108.6945652716295, 6083.422074903054, 6093.268807743099, 6093.725782339894, 6099.085137229451, 6133.723982420713, 5975.701214939322, 6062.545309101747, 6072.14989901423, 6075.817725468066, 6080.179175811209, 5989.0, 6028.246469191351, 6065.332813390435, 6068.393160684073, 6075.453209211192, 5863.501602363847, 5899.056151015817, 5907.0, 5930.911036334544, 6004.759809607567], "value": 5645.605563702196, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.22278384912, 801.7434420985285, 828.5360198288959, 1114.3369695031454, 1137.3232926408784, 28804.56793148102, 35645.643543564554, 36747.26505469889, 36795.26409471816, 36906.26187476249, 37485.06287342818, 37876.81061594688, 37898.62101378985, 37945.0, 37995.430068548994, 5511.22842802008, 5706.457886500776, 7131.928680713191, 7283.053203083618, 7285.817854553626, 6641.302663220365, 7241.4568907331895, 7244.203137654854, 7251.6374181290985, 7255.383292420124, 7296.2338954409815, 7397.0, 7409.851802963937, 7416.480846340758, 7421.294976977206, 7311.670974806147, 7366.447516436288, 7376.889346659805, 7386.224446433154, 7386.667599958015, 7201.135863696338, 7245.384142347907, 7255.52839065459, 7257.056582644275, 7267.49127561071, 34179.316413671586, 34269.11519866406, 34358.6564134358, 34550.654493455, 34569.0, 3430.811305378203, 3442.225499262671, 3463.9954413220134, 3465.549478567795, 3467.098554375855, 27223.319417014536, 27248.45503089947, 27319.86340068287, 27326.726732732615, 27330.726692733217, 3148.6064241969752, 3154.4322022036026, 3161.272907231327, 3171.0328349853285, 3174.4603417419094, 181115.0, 181257.0, 181372.0, 181808.0, 182050.0, 43251.78374108109, 43677.56322436799, 43728.344074838904, 43741.34387984183, 43758.998560230844, 45140.77429612831, 45459.31811022837, 45467.09065818665, 45559.0, 45561.0, 15087.773683394758, 15182.164980926154, 15199.316030778642, 15207.771883421758, 15227.467038653594, 10922.126229901747, 11180.329180249211, 12617.936910315573, 12626.179298345578, 12626.936865315614, 11894.702632434259, 11992.820107698391, 12164.33096179701, 12196.0, 12256.325902075294, 5097.770600322994, 5197.7141257231215, 5246.658967167122, 5260.13207820713, 5292.655977361459, 1046.2362475392854, 1081.8809930907594, 1086.3861918016296, 1091.7980173667897, 1094.1574987259764, 24846.503069938863, 24961.25426203116, 24965.12622058219, 25025.62461563078, 25035.12377066794, 1163.4938801621322, 1169.1640477058943, 1170.78925793358, 1172.5192671004847, 1201.7776711308436, 12352.62942111738, 13209.801852972214, 13222.206667599974, 13268.867311326956, 13277.269750163641, 216262.0, 216464.0, 216521.0, 217414.0, 218899.0, 49850.25224621633, 49854.252186217236, 49869.0, 49915.75042124766, 49931.500684993414, 1486.0934829753842, 1504.308018311589, 1525.877929765616, 1533.2103966457285, 1535.6314484523857, 23138.652920205874, 24370.512589747752, 24477.265682029567, 24661.13686020981, 24692.876535617925, 36592.45111323385, 36598.634013659524, 36616.267674645824, 36627.633723662424, 36656.63343366532, 187708.0, 190338.04830975758, 190787.0, 191552.0, 192105.0, 29061.41877162487, 32089.197770055936, 32451.18872028218, 33329.83335083309, 33521.16197094994, 35561.82219088888, 35868.461973069905, 35871.82064089663, 35886.64113358833, 38266.6173338263, 29908.0, 32164.839175803972, 32418.0, 32552.348953020333, 33183.668163318056, 31278.0, 31283.84358078195, 32359.352812944082, 32361.19097022499, 32750.181245469055, 37388.43917341297, 37487.25025499529, 37635.435468468546, 37639.81180094082, 37768.244635106596, 29120.56319155172, 30199.698003020567, 30212.395752084394, 30430.54354184733, 31323.530147047357, 24665.383365416008, 24747.381315467257, 24992.625110623718, 25357.239282821545, 25763.613545796452], "value": 16236.220923564877, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.86643140626387, 437.78329726785245, 441.1728009981284, 448.65453600727443, 451.78991768827507, 17896.284148634055, 19100.80899191008, 19688.606227875433, 19758.308459203894, 19771.802281977176, 19890.303839365624, 20035.298764543244, 20176.0, 20531.692024619642, 20942.0, 5454.509094181523, 5663.122216056518, 5664.122061080539, 5667.603267771257, 5674.063779476382, 5468.453154684519, 5564.165375193713, 5665.5467562594895, 5691.178822776692, 5693.459121383462, 5660.405657405975, 5669.234653321811, 5670.8015219467325, 5676.205331253607, 5680.857978550549, 5460.34475862899, 5579.944200557983, 5585.525230355424, 5663.490285874271, 5670.262865827437, 5058.4688607696025, 5069.77186026626, 5075.898482030376, 5076.416212135615, 5085.821996230115, 24972.750272497226, 26045.869770651025, 26251.0, 26303.21090367292, 26447.47105057907, 2123.203798575534, 2152.461884528868, 2158.082814803702, 2160.643493823533, 2162.351294611626, 16050.197490125563, 16379.0, 16654.0, 16798.664026719518, 17298.913505432392, 2139.069504765432, 2195.571863486605, 2210.9447263818533, 2216.523447458788, 2231.832612554065, 106382.46808765907, 107190.0, 108721.99999999921, 109499.45250273698, 110049.0, 12322.630321090382, 12548.81176782349, 12658.367081645882, 12671.17637353569, 12679.112462127563, 17206.741898871525, 17277.65444691099, 17286.0, 17304.134793260288, 17359.392421265195, 8898.0, 9242.953785231031, 9292.256619470427, 9378.765530861783, 9380.249580033718, 8511.787205319917, 8523.147685231428, 8607.0, 8806.86789698155, 8823.602937867812, 7697.961510192413, 7889.723859664884, 8008.0, 8032.196780321921, 8209.0, 2168.1544197762887, 2179.3679832848297, 2181.640029395132, 2211.635080211747, 2349.0, 1019.6380284998867, 1042.827933390982, 1048.7902419516126, 1056.3503445381036, 1056.5298442193305, 19409.32067377635, 19688.70466942997, 21114.261000864895, 21188.364349069554, 21402.0, 1021.4177918586483, 1042.5569133118395, 1052.3580615824342, 1066.8186408310605, 1079.6760971708457, 11234.606788762354, 11607.361595112181, 11612.167984565072, 11645.184837061493, 11706.88293117075, 455391.0, 459404.0, 461449.0, 505083.0, 508067.0, 92166.53916730374, 93733.0, 94131.52934235285, 94761.0, 95065.5246723762, 1159.576754484624, 1176.0944073063692, 1208.1844754790482, 1226.938653067361, 1227.5151315230612, 17767.0, 17868.55328616743, 18211.0, 18443.417921490734, 18450.538736531693, 45204.0, 47016.05967880555, 47127.76436117797, 47717.52282477131, 47726.284105737745, 59636.70181649064, 60944.39055609565, 61374.0, 62105.68947155235, 62840.685796570724, 8893.777655558662, 8991.550422478718, 9382.0, 9500.619975200914, 9593.568289427132, 14425.711485770436, 14472.0, 14491.0, 15001.324940377492, 15205.0, 12138.211016283913, 12389.442475088463, 12703.809442858179, 12972.870271297166, 13274.402651880495, 11061.723456913642, 11105.611303604335, 11212.66362009141, 11244.493997770283, 11370.260933039326, 12710.428030738824, 12904.354782261038, 13037.348132593523, 13347.332633368487, 13357.265350405432, 9005.549722513717, 9109.954450227706, 9244.445333280024, 9405.294602904673, 9416.576254068721, 11953.521859125538, 12537.87462125367, 12966.092373533762, 12984.0, 13105.0], "value": 10077.270435554676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1182.9112816538761, 1317.8220940173076, 1352.9797053044206, 1372.7734923737578, 1377.7244551089782, 9575.281853860954, 10637.734056648578, 11152.944235278832, 11170.888291117097, 11182.832257516124, 10991.285566438177, 11246.606368777095, 11250.943745281262, 11252.324860508375, 11262.605808796694, 1986.860919735619, 2064.6696528555435, 2330.6154484510034, 2370.383700237933, 2374.2165085521738, 2292.908283668651, 2370.2178281167176, 2375.489269806991, 2379.678743369649, 2382.7498112698177, 2361.291612516247, 2381.7499162587937, 2389.4026493376655, 2393.56915755164, 2397.4725560376687, 2330.067972810872, 2343.496148328109, 2345.167465549731, 2349.130821596012, 2351.2123438648073, 2243.618584840565, 2254.458929856839, 2299.7930186283147, 2329.9068037278657, 2331.5919714049974, 10932.398718070503, 11031.503582338733, 11034.668959931216, 11035.0, 11041.503132358983, 6121.846953826145, 6345.365463453618, 6346.460550853183, 6347.365263473662, 6359.936400635981, 3596.1189508570305, 3666.6150054244454, 3853.1523064925673, 3868.032991752062, 3876.7286289959716, 1283.1915892987358, 1337.3580681273043, 1359.0622470495327, 1364.8908087353086, 1365.1808914651228, 16215.83784162167, 16532.669346613002, 16547.420840270654, 16560.254788534425, 16566.1716914155, 5278.366596008426, 5317.1492561190025, 5351.170568561879, 5438.238646589481, 5561.138023606348, 13797.448102076005, 13803.03378763477, 13807.792883106762, 13814.309284535733, 13822.93088534551, 6221.595596286227, 6300.180976473029, 6310.400511951358, 6460.25707043696, 6461.547691661539, 4360.803763830635, 5824.88350232993, 5826.796062137805, 5873.823785286449, 5922.466977972003, 4353.455818022747, 4407.625351845065, 4413.911721765547, 4489.595936365743, 4527.796249168795, 1268.0743057568027, 1317.0846261848114, 1318.5780550223835, 1332.5202926946292, 1348.0967751606447, 839.202757380491, 848.728406909783, 863.0635760200128, 873.4802792338548, 890.5547226386807, 6659.167604049494, 6910.412614927687, 6913.2049814270995, 6956.582605043714, 6962.512624116364, 648.0441349010172, 649.1658219188321, 650.2067477677226, 655.8391646785259, 661.4047357378398, 4013.5585085640555, 4027.657649099801, 4032.5160980681917, 4048.8785336439364, 4104.363823607346, 14249.145051296955, 14744.778828317583, 14766.704665906622, 14789.778153327708, 14791.70416591662, 12880.227186368847, 13314.46742130304, 14510.709785804225, 14518.0, 14548.0, 8044.758657240292, 8250.752477425687, 8368.623411946355, 8712.128787121237, 8932.687355942511, 6544.5418820684, 6550.508711846726, 6615.272320044887, 6632.071509988702, 6837.247902730795, 12574.559890403792, 12736.872631273569, 13164.210147391188, 13168.0, 13169.473221071434, 13300.667483312995, 13327.733445330845, 13399.12905661129, 13406.932965335502, 13448.93275533616, 8380.916190838014, 8726.781830454289, 9104.726858194264, 9244.306676999386, 9431.622735090794, 10213.387196768217, 10325.483725813829, 10423.114035307084, 10428.322159059637, 10463.476826158814, 8824.735257942271, 8897.510636915033, 8901.109889011048, 9137.817243655223, 9242.676506322516, 8972.237359824489, 9013.369064165445, 9086.591103400231, 9090.454572725657, 9271.629134834531, 7863.567503787347, 7959.243871832166, 8013.15861834499, 8044.31623312025, 8044.959775201087, 5824.155497452761, 5848.122781582797, 5879.794207202727, 5902.911456328073, 6162.506999440124, 5941.58408911372, 5943.435373639497, 5970.9701451492465, 6014.0, 6207.441330280297], "value": 5211.610354348346, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6662103969547, 398.1499498570553, 406.1937054945932, 409.0244766232535, 411.5308548254989, 5811.418858114186, 5838.737256823442, 5844.3279022912375, 5855.79504717335, 5870.324912635043, 5570.805021824237, 5736.397678243787, 5741.081426971686, 5748.0, 5780.277465316835, 4477.10457908418, 4477.999999999992, 4479.372887795695, 4489.326601009859, 4500.437445319335, 4471.441069866267, 4479.641628669715, 4494.68537202396, 4509.962708577029, 4511.390962220091, 4176.728512646669, 4330.090680956987, 4343.674224433164, 4349.282368409209, 4469.88825279369, 4284.635805956482, 4301.118270754488, 4321.243782338078, 4350.58669426404, 4354.129174165164, 3799.1072098056934, 3804.258169656918, 3806.219724956405, 3818.0645741793437, 3823.1589050408866, 5395.730213489349, 5591.720413979285, 5619.409961953977, 5631.774729010835, 5678.829635110953, 5065.366829146356, 5079.187330027178, 5089.066154861166, 5105.055564720501, 5109.56568691658, 6019.69901504923, 6021.458068773832, 6071.210742603477, 6088.939110608926, 6105.206323177958, 4040.3535434330365, 4083.836646534135, 4115.8765237042935, 4133.21468920904, 4137.2552940470705, 6006.519478441714, 6211.19254496917, 6310.274318453345, 6361.777337793155, 6392.872142557169, 4222.1766755483, 4327.545607711145, 4347.0, 4359.084592235603, 4365.148795984753, 4148.149629325981, 4211.957880421218, 4237.618614324726, 4414.757188354672, 4425.402570652985, 4963.45402005779, 4996.750162491933, 4998.2502624606595, 5000.774965126505, 5000.974800165957, 6069.0, 6078.939210607838, 6100.267967843887, 6102.908456373158, 6137.5703700741415, 1489.8957073004785, 1507.4347119830063, 1507.6683129711446, 1520.7186670465999, 1522.3834347089446, 961.8172547216006, 982.7150126463389, 985.6747273399761, 991.6083147156833, 992.7418871093568, 5773.162891380726, 5799.739011744397, 5805.0, 5826.82519524415, 5865.765369385262, 6234.594751341239, 6274.152989346471, 6278.560500764903, 6281.586643005287, 6313.273973493016, 5696.572757043238, 5775.104858746901, 5811.709414529341, 5844.327902291206, 5867.559933005042, 3258.3809076275907, 3287.3918325109453, 3301.603807543062, 3304.8182349970984, 3317.9004629861142, 6296.307406185316, 6393.488520918316, 6445.939058393183, 6474.643894585843, 6478.870422591522, 6346.58747181441, 6361.650109244036, 6376.202974628171, 6415.486761059104, 6422.775202867971, 6368.490520758328, 6468.450181734511, 6473.967630161819, 6487.935120648827, 6515.706793194412, 6234.75060997555, 6248.781292654735, 6255.155554000152, 6262.123302737529, 6266.592671476339, 5883.0, 6034.969825150846, 6065.6663883486835, 6167.823570860921, 6216.53375996793, 6278.968605157128, 6447.451966582893, 6454.290028097, 6478.773242936474, 6482.384173503509, 4276.422682937764, 4355.259605866947, 4359.782010899379, 4365.847195348148, 4373.606375426227, 6188.783392581238, 6194.274519211533, 6198.969005154945, 6221.688915554295, 6232.0, 6114.0, 6114.615300032901, 6119.632822030692, 6119.84700382494, 6120.1125836752535, 5912.408759124053, 6024.33732289439, 6047.485963693135, 6107.480864126599, 6120.724567394389, 6065.5754097212775, 6078.3921607838865, 6078.696065196811, 6084.296397008845, 6095.634261944298, 5935.881282374415, 6062.575619706755, 6063.878722425438, 6130.2030736004035, 6132.448079672851, 5919.7568510613255, 5953.434423729739, 5956.434138756811, 5957.463828255478, 5971.910421343597], "value": 4597.044170146721, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.6894318045504, 870.843248215321, 873.6811063961655, 882.1839798186679, 899.020068125743, 16494.0, 16659.333626654934, 17188.914055429705, 17199.656006879854, 17200.053997030158, 16315.83684163158, 16384.75422868658, 16488.258028388722, 16519.752203716955, 16529.91735041326, 977.2621670638658, 1006.4967516241879, 1022.7545389106598, 1023.3092662452851, 1023.800358930009, 1020.3316827478013, 1024.4416792847878, 1026.1277913773308, 1027.773889744259, 1031.3863251365426, 1080.8486811846349, 1081.1296905990675, 1082.123479981214, 1083.9187060970419, 1085.679724481276, 1059.369675043352, 1068.40169505077, 1073.683263437288, 1076.8923107689247, 1078.4553800330782, 782.1474592693991, 783.7844592736986, 783.9804004899867, 785.5561607691693, 785.7407055671615, 14932.0, 14956.177410242432, 15732.528024159179, 16155.273012714339, 16567.25447354872, 17165.656686866318, 17359.698022648226, 17718.734218986727, 17747.911260443616, 17882.105894705343, 15034.548963531002, 15191.924040379727, 15383.461578844686, 15411.691766164615, 15565.610859728484, 3490.249596336774, 3507.6843084122297, 3509.7192224621967, 3510.0873772818995, 3513.7364697647777, 81852.59073704593, 85148.0, 85531.0, 86199.0, 87643.0, 15149.166795826335, 15171.848281517265, 15206.923965380101, 15296.617584560476, 15308.693826123637, 27247.455050898872, 27562.310942226202, 27681.307967300978, 28032.43935121327, 28052.158435246976, 7670.4247181461615, 7727.034120734908, 7730.033745781778, 7735.845283094307, 7750.379969602418, 4230.15396920611, 4233.322668373107, 4263.317869140923, 4270.338097594878, 4308.116836048603, 4246.532881383046, 4358.084802191575, 4361.5856493633055, 4363.280058790264, 4369.69412141147, 922.9769255768659, 984.3650845204803, 1014.4065721552827, 1027.6660085472251, 1033.3593172233263, 711.6797441151502, 720.4920531025614, 732.6702983657375, 736.7568702328219, 754.0762565856782, 10671.83992240117, 11743.17797754149, 12001.039916806634, 12395.814062789066, 12488.313142777053, 678.2539206872401, 685.6674512861258, 690.3752104345475, 695.7808290388512, 710.1832892173938, 5299.973500132474, 5563.13771365439, 5610.4670056344585, 5653.265075540236, 5660.29246344207, 81890.59054704689, 82856.0, 85721.57139214264, 87350.56324718335, 87893.0, 73292.0, 74250.0, 74832.99999999891, 75562.24437755662, 78090.60954695304, 66420.33579664142, 68672.65663671649, 68691.65654171797, 69075.3092469079, 69134.65432672905, 10475.790484190426, 10938.507767150339, 10963.451827408757, 11099.167562432689, 11128.276662017266, 36109.63890361063, 36339.27321453609, 36354.0, 36515.63484365229, 37520.0, 43091.35362969495, 43340.34989475223, 43439.34840977324, 43542.56457435385, 45553.772231139956, 14792.11247325164, 15023.248837558296, 15137.394504220149, 15246.237688115772, 15376.692466150838, 15448.0, 17168.65662686714, 17706.82293177052, 17995.2801887923, 18325.450236492925, 15884.841151588336, 15974.201289935689, 16051.839481605035, 16399.262033208295, 16641.251143698322, 16558.337666493204, 16726.0, 16937.32250709958, 17111.486655400357, 17250.65498690044, 16307.0, 16602.16989150562, 16762.832371676126, 17856.375026873997, 17952.640947181244, 11796.823047654121, 12323.938380308042, 12574.1198116131, 13416.463341466231, 14299.499517516837, 13606.727865442834, 14144.575662730134, 14302.928485357506, 14435.92782036083, 14605.342759576057], "value": 8256.61742992437, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 109.0, 109.0, 109.0, 108.0, 108.0, 109.0, 110.0, 109.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 125.0, 166.0, 119.0, 119.0, 118.0, 116.0, 137.0, 119.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 163.0, 161.0, 161.0, 163.0, 162.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 109.0, 75.0, 74.0, 74.0, 74.0, 95.0, 74.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 101.0, 82.0, 83.0, 81.0, 96.0, 82.0, 82.0, 108.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 113.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 151.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 47.0, 48.0, 48.0, 54.0, 50.0, 48.0, 49.0, 49.0], "value": 49.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 57.0, 55.0, 55.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 79.0, 78.0, 79.0, 86.0, 78.0, 79.0, 78.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 126.0, 124.0, 125.0, 125.0, 123.0, 123.0, 182.0, 126.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 184.0, 181.0, 189.0, 180.0, 182.0, 182.0, 180.0, 182.0, 173.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 67.0, 63.0], "value": 65.7, "unit": "score"}]}]} 16:52:14 INFO - Return code: 0 16:52:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:15 INFO - # TBPL SUCCESS # 16:52:15 INFO - Running post-action listener: _resource_record_post_action 16:52:15 INFO - [mozharness: 2017-05-13 23:52:15.058561Z] Finished run-tests step (success) 16:52:15 INFO - Running post-run listener: _resource_record_post_run 16:52:15 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7827456; Write bytes: 388067328; Read time: 1816; Write time: 311296 16:52:15 INFO - TinderboxPrint: CPU usage
12.9% 16:52:15 INFO - TinderboxPrint: I/O read bytes / time
7,827,456 / 1,816 16:52:15 INFO - TinderboxPrint: I/O write bytes / time
388,067,328 / 311,296 16:52:15 INFO - TinderboxPrint: CPU idle
8,291.6 (87.1%) 16:52:15 INFO - TinderboxPrint: CPU user
1,184.7 (12.4%) 16:52:15 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 119816192; Read time: 0; Write time: 122284 16:52:15 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5615616; Write bytes: 264392704; Read time: 1564; Write time: 188780 16:52:15 INFO - Running post-run listener: _upload_blobber_files 16:52:15 INFO - Blob upload gear active. 16:52:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:15 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 16:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:52:16 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:52:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:17 INFO - (blobuploader) - INFO - Done attempting. 16:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:20 INFO - (blobuploader) - INFO - Done attempting. 16:52:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:52:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:52:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:21 INFO - (blobuploader) - INFO - Done attempting. 16:52:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:52:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:52:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:22 INFO - (blobuploader) - INFO - Done attempting. 16:52:22 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:22 INFO - Return code: 0 16:52:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f481ba026c8567db430a263218fa5663d594daf3b0b0b91cf095dba1e172261120a7707f04a58a819049fbc4203ab2b79adda57fe3dec379c5d5821f12433a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db444e8a0060cf4ba462e839a290da65643e2c0aba4985e2ebd02fef02e209148d26b3cc24124328f38e8b817cd554aec4f06a7b6d3ff2ffeb64e46ecfdf1b8c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb2e6f0c93c12cc7e71761d25622f316af139919cd22b180c0746c7c14e12b6208a3369dd795a07da55ce8a6a5ba39e7904736e051ceb5c24637d0146564c84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927d7f72f2fe784fa1a417dad01d7b25e922d8b7bfe2d4bbc58e02783a1bef9fe440ebd88640b439e5b579b13a0597bfac955e49f9fc4764ea6ba3f29e9ce98a"} 16:52:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:22 INFO - Contents: 16:52:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f481ba026c8567db430a263218fa5663d594daf3b0b0b91cf095dba1e172261120a7707f04a58a819049fbc4203ab2b79adda57fe3dec379c5d5821f12433a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db444e8a0060cf4ba462e839a290da65643e2c0aba4985e2ebd02fef02e209148d26b3cc24124328f38e8b817cd554aec4f06a7b6d3ff2ffeb64e46ecfdf1b8c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb2e6f0c93c12cc7e71761d25622f316af139919cd22b180c0746c7c14e12b6208a3369dd795a07da55ce8a6a5ba39e7904736e051ceb5c24637d0146564c84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927d7f72f2fe784fa1a417dad01d7b25e922d8b7bfe2d4bbc58e02783a1bef9fe440ebd88640b439e5b579b13a0597bfac955e49f9fc4764ea6ba3f29e9ce98a"} 16:52:22 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:22 INFO - Copying logs to upload dir... 16:52:22 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.863720 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-13 16:52:22.237565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-13 16:52:22.241393) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011 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/sha512/06f481ba026c8567db430a263218fa5663d594daf3b0b0b91cf095dba1e172261120a7707f04a58a819049fbc4203ab2b79adda57fe3dec379c5d5821f12433a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db444e8a0060cf4ba462e839a290da65643e2c0aba4985e2ebd02fef02e209148d26b3cc24124328f38e8b817cd554aec4f06a7b6d3ff2ffeb64e46ecfdf1b8c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb2e6f0c93c12cc7e71761d25622f316af139919cd22b180c0746c7c14e12b6208a3369dd795a07da55ce8a6a5ba39e7904736e051ceb5c24637d0146564c84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927d7f72f2fe784fa1a417dad01d7b25e922d8b7bfe2d4bbc58e02783a1bef9fe440ebd88640b439e5b579b13a0597bfac955e49f9fc4764ea6ba3f29e9ce98a"} build_url:https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/D9qPfgBfSveAM8hWI7HP1Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f481ba026c8567db430a263218fa5663d594daf3b0b0b91cf095dba1e172261120a7707f04a58a819049fbc4203ab2b79adda57fe3dec379c5d5821f12433a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db444e8a0060cf4ba462e839a290da65643e2c0aba4985e2ebd02fef02e209148d26b3cc24124328f38e8b817cd554aec4f06a7b6d3ff2ffeb64e46ecfdf1b8c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb2e6f0c93c12cc7e71761d25622f316af139919cd22b180c0746c7c14e12b6208a3369dd795a07da55ce8a6a5ba39e7904736e051ceb5c24637d0146564c84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927d7f72f2fe784fa1a417dad01d7b25e922d8b7bfe2d4bbc58e02783a1bef9fe440ebd88640b439e5b579b13a0597bfac955e49f9fc4764ea6ba3f29e9ce98a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-13 16:52:22.266877) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:52:22.267363) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1494718153.495302-691869011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:52:22.350738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-13 16:52:22.351059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-13 16:52:22.351350) ========= ========= Total master_lag: 0.31 =========