builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1491412539.98 results: success (0) revision: 632c2b8c17297a8d4c70fc33a518808d81fc18c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:39.984647) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:39.985102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:39.985399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:39.998077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:39.998404) ========= 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=836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 10:15:40-- 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% 42.7M=0s 2017-04-05 10:15:40 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074748 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:40.085071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:40.085386) ========= 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=836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017408 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:40.134606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:40.134953) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 632c2b8c17297a8d4c70fc33a518808d81fc18c7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 632c2b8c17297a8d4c70fc33a518808d81fc18c7 --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=836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 10:15:40,429 truncating revision to first 12 chars 2017-04-05 10:15:40,429 Setting DEBUG logging. 2017-04-05 10:15:40,429 attempt 1/10 2017-04-05 10:15:40,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/632c2b8c1729?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 10:15:41,015 unpacking tar archive at: mozilla-aurora-632c2b8c1729/testing/mozharness/ program finished with exit code 0 elapsedTime=0.878475 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:41.026683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:41.027025) ========= script_repo_revision: 632c2b8c17297a8d4c70fc33a518808d81fc18c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:41.027412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:41.027765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 10:15:41.037274) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-05 10:15:41.037596) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:41 INFO - MultiFileLogger online at 20170405 10:15:41 in /builds/slave/test 10:15:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 10:15:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:41 INFO - {'append_to_log': False, 10:15:41 INFO - 'base_work_dir': '/builds/slave/test', 10:15:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 10:15:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:41 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 10:15:41 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:41 INFO - 'config_files': ('talos/linux_config.py',), 10:15:41 INFO - 'default_actions': ('clobber', 10:15:41 INFO - 'read-buildbot-config', 10:15:41 INFO - 'download-and-extract', 10:15:41 INFO - 'populate-webroot', 10:15:41 INFO - 'create-virtualenv', 10:15:41 INFO - 'install', 10:15:41 INFO - 'run-tests'), 10:15:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:41 INFO - 'download_minidump_stackwalk': True, 10:15:41 INFO - 'download_symbols': 'ondemand', 10:15:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:41 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:41 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:41 INFO - 'gecko_profile': False, 10:15:41 INFO - 'gecko_profile_interval': 0, 10:15:41 INFO - 'installer_path': 'installer.exe', 10:15:41 INFO - 'log_level': 'info', 10:15:41 INFO - 'log_name': 'talos', 10:15:41 INFO - 'log_to_console': True, 10:15:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:41 INFO - 'opt_config_files': (), 10:15:41 INFO - 'pip_index': False, 10:15:41 INFO - 'suite': 'dromaeojs', 10:15:41 INFO - 'system_bits': '32', 10:15:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:41 INFO - 'title': 'talos-linux64-ix-028', 10:15:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:41 INFO - 'use_talos_json': True, 10:15:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:41 INFO - 'work_dir': 'build'} 10:15:41 INFO - [mozharness: 2017-04-05 17:15:41.421954Z] Running clobber step. 10:15:41 INFO - Running pre-action listener: _resource_record_pre_action 10:15:41 INFO - Running main action method: clobber 10:15:41 INFO - rmtree: /builds/slave/test/build 10:15:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:42 INFO - Running post-action listener: _resource_record_post_action 10:15:42 INFO - [mozharness: 2017-04-05 17:15:42.351388Z] Finished clobber step (success) 10:15:42 INFO - [mozharness: 2017-04-05 17:15:42.351488Z] Running read-buildbot-config step. 10:15:42 INFO - Running pre-action listener: _resource_record_pre_action 10:15:42 INFO - Running main action method: read_buildbot_config 10:15:42 INFO - Using buildbot properties: 10:15:42 INFO - { 10:15:42 INFO - "project": "", 10:15:42 INFO - "product": "firefox", 10:15:42 INFO - "who": "rjesup@wgate.com", 10:15:42 INFO - "installer_path": "public/build/target.tar.bz2", 10:15:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:15:42 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 10:15:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 10:15:42 INFO - "stage_platform": "linux64", 10:15:42 INFO - "basedir": "/builds/slave/test", 10:15:42 INFO - "buildnumber": 116, 10:15:42 INFO - "platform": "ubuntu64_hw", 10:15:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:15:42 INFO - "slavebuilddir": "test", 10:15:42 INFO - "taskId": "HNEXrui3Qv6vhq27f_6yig", 10:15:42 INFO - "branch": "mozilla-aurora", 10:15:42 INFO - "script_repo_revision": "production", 10:15:42 INFO - "revision": "632c2b8c17297a8d4c70fc33a518808d81fc18c7", 10:15:42 INFO - "slavename": "talos-linux64-ix-028", 10:15:42 INFO - "repo_path": "releases/mozilla-aurora" 10:15:42 INFO - } 10:15:42 INFO - Finding installer, test and symbols from parent task. 10:15:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNEXrui3Qv6vhq27f_6yig'}, attempt #1 10:15:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNEXrui3Qv6vhq27f_6yig'}, attempt #1 10:15:43 INFO - Task dependencies: Y6736YMNTqSa9KPhJQKk5A 10:15:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A'}, attempt #1 10:15:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.tar.bz2 10:15:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/test_packages.json 10:15:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.crashreporter-symbols.zip 10:15:43 INFO - Running post-action listener: _resource_record_post_action 10:15:43 INFO - [mozharness: 2017-04-05 17:15:43.737555Z] Finished read-buildbot-config step (success) 10:15:43 INFO - [mozharness: 2017-04-05 17:15:43.737778Z] Running download-and-extract step. 10:15:43 INFO - Running pre-action listener: _resource_record_pre_action 10:15:43 INFO - Running main action method: download_and_extract 10:15:43 INFO - mkdir: /builds/slave/test/build/tests 10:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:43 INFO - trying https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.test_packages.json 10:15:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:15:44 INFO - Downloaded 896 bytes. 10:15:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:15:44 INFO - Using the following test package requirements: 10:15:44 INFO - {u'common': [u'target.common.tests.zip'], 10:15:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:15:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:15:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:15:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:15:44 INFO - u'mozbase': [u'target.common.tests.zip'], 10:15:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:15:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:15:44 INFO - u'web-platform': [u'target.common.tests.zip', 10:15:44 INFO - u'target.web-platform.tests.zip'], 10:15:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:15:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:15:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.common.tests.zip 10:15:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:15:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.common.tests.zip into memory 10:15:45 INFO - Expected file size: 59540682 10:15:45 INFO - Obtained file size: 59540682 10:15:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:15:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.common.tests.zip 10:15:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:15:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.common.tests.zip into memory 10:15:56 INFO - Expected file size: 59540682 10:15:56 INFO - Obtained file size: 59540682 10:16:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.talos.tests.zip 10:16:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:16:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.talos.tests.zip into memory 10:16:07 INFO - Expected file size: 14404438 10:16:07 INFO - Obtained file size: 14404438 10:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:07 INFO - trying https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.tar.bz2 10:16:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:16:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:16:09 INFO - Downloaded 66794548 bytes. 10:16:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.tar.bz2 10:16:09 INFO - mkdir: /builds/slave/test/properties 10:16:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:16:09 INFO - Writing to file /builds/slave/test/properties/build_url 10:16:09 INFO - Contents: 10:16:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.tar.bz2 10:16:09 INFO - Running post-action listener: _resource_record_post_action 10:16:09 INFO - Running post-action listener: set_extra_try_arguments 10:16:09 INFO - [mozharness: 2017-04-05 17:16:09.105615Z] Finished download-and-extract step (success) 10:16:09 INFO - [mozharness: 2017-04-05 17:16:09.105713Z] Running populate-webroot step. 10:16:09 INFO - Running pre-action listener: _resource_record_pre_action 10:16:09 INFO - Running main action method: populate_webroot 10:16:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:16:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:16:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:16:09 INFO - '--tppagecycles', 10:16:09 INFO - '7'], 10:16:09 INFO - 'tests': ['tsvgm']}}, 10:16:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:16:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:16:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:16:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:16:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:16:09 INFO - 'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:16:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:16:09 INFO - 'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['damp', 'tps']}, 10:16:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:16:09 INFO - 'tests': ['damp', 'tps']}, 10:16:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['dromaeo_dom']}, 10:16:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:16:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['basic_compositor_video']}, 10:16:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:16:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['a11yr', 10:16:09 INFO - 'ts_paint', 10:16:09 INFO - 'tpaint', 10:16:09 INFO - 'sessionrestore', 10:16:09 INFO - 'sessionrestore_no_auto_restore', 10:16:09 INFO - 'tabpaint']}, 10:16:09 INFO - 'other-e10s': {'tests': ['a11yr', 10:16:09 INFO - 'ts_paint', 10:16:09 INFO - 'tpaint', 10:16:09 INFO - 'sessionrestore', 10:16:09 INFO - 'sessionrestore_no_auto_restore', 10:16:09 INFO - 'tabpaint']}, 10:16:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:16:09 INFO - 'ts_paint', 10:16:09 INFO - 'tpaint', 10:16:09 INFO - 'sessionrestore', 10:16:09 INFO - 'sessionrestore_no_auto_restore', 10:16:09 INFO - 'tabpaint']}, 10:16:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:16:09 INFO - 'ts_paint', 10:16:09 INFO - 'tpaint', 10:16:09 INFO - 'sessionrestore', 10:16:09 INFO - 'sessionrestore_no_auto_restore', 10:16:09 INFO - 'tabpaint']}, 10:16:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['a11yr', 10:16:09 INFO - 'ts_paint', 10:16:09 INFO - 'tpaint', 10:16:09 INFO - 'sessionrestore', 10:16:09 INFO - 'sessionrestore_no_auto_restore', 10:16:09 INFO - 'tabpaint']}, 10:16:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['a11yr', 10:16:09 INFO - 'ts_paint', 10:16:09 INFO - 'tpaint', 10:16:09 INFO - 'sessionrestore', 10:16:09 INFO - 'sessionrestore_no_auto_restore', 10:16:09 INFO - 'tabpaint']}, 10:16:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['tsvgx', 10:16:09 INFO - 'tsvgr_opacity', 10:16:09 INFO - 'tart', 10:16:09 INFO - 'tscrollx', 10:16:09 INFO - 'cart', 10:16:09 INFO - 'tsvg_static']}, 10:16:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:16:09 INFO - 'tsvgr_opacity', 10:16:09 INFO - 'tart', 10:16:09 INFO - 'tscrollx', 10:16:09 INFO - 'cart', 10:16:09 INFO - 'tsvg_static']}, 10:16:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:16:09 INFO - 'talos_options': ['--disable-e10s'], 10:16:09 INFO - 'tests': ['tp5o']}, 10:16:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:16:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:16:09 INFO - 'talos_options': ['--disable-e10s', 10:16:09 INFO - '--xperf_path', 10:16:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:09 INFO - 'tests': ['tp5n']}, 10:16:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:16:09 INFO - 'talos_options': ['--xperf_path', 10:16:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:09 INFO - 'tests': ['tp5n']}}, 10:16:09 INFO - 'talos.zip': {'path': '', 10:16:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:16:09 INFO - Running post-action listener: _resource_record_post_action 10:16:09 INFO - [mozharness: 2017-04-05 17:16:09.118821Z] Finished populate-webroot step (success) 10:16:09 INFO - [mozharness: 2017-04-05 17:16:09.118911Z] Running create-virtualenv step. 10:16:09 INFO - Running pre-action listener: _resource_record_pre_action 10:16:09 INFO - Running main action method: create_virtualenv 10:16:09 INFO - Creating virtualenv /builds/slave/test/build/venv 10:16:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:16:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:16:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:16:09 INFO - Using real prefix '/usr' 10:16:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:16:09 INFO - Installing distribute.............................................................................................................................................................................................done. 10:16:11 INFO - Installing pip.................done. 10:16:11 INFO - Return code: 0 10:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:16:11 INFO - Reading from file tmpfile_stdout 10:16:11 INFO - Output received: 10:16:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:16:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:16:11 INFO - Using env: {'DISPLAY': ':0', 10:16:11 INFO - 'HOME': '/home/cltbld', 10:16:11 INFO - 'LANG': 'en_US.UTF-8', 10:16:11 INFO - 'LANGUAGE': 'en_US:en', 10:16:11 INFO - 'LOGNAME': 'cltbld', 10:16:11 INFO - 'MAIL': '/var/mail/cltbld', 10:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:11 INFO - 'MOZ_NO_REMOTE': '1', 10:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:11 INFO - 'NO_EM_RESTART': '1', 10:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:11 INFO - 'PWD': '/builds/slave/test', 10:16:11 INFO - 'SHELL': '/bin/bash', 10:16:11 INFO - 'SHLVL': '1', 10:16:11 INFO - 'TERM': 'linux', 10:16:11 INFO - 'TMOUT': '86400', 10:16:11 INFO - 'USER': 'cltbld', 10:16:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:11 INFO - '_': '/tools/buildbot/bin/python'} 10:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:16:12 INFO - Cleaning up... 10:16:12 INFO - Return code: 0 10:16:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:16:12 INFO - Using env: {'DISPLAY': ':0', 10:16:12 INFO - 'HOME': '/home/cltbld', 10:16:12 INFO - 'LANG': 'en_US.UTF-8', 10:16:12 INFO - 'LANGUAGE': 'en_US:en', 10:16:12 INFO - 'LOGNAME': 'cltbld', 10:16:12 INFO - 'MAIL': '/var/mail/cltbld', 10:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:12 INFO - 'MOZ_NO_REMOTE': '1', 10:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:12 INFO - 'NO_EM_RESTART': '1', 10:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:12 INFO - 'PWD': '/builds/slave/test', 10:16:12 INFO - 'SHELL': '/bin/bash', 10:16:12 INFO - 'SHLVL': '1', 10:16:12 INFO - 'TERM': 'linux', 10:16:12 INFO - 'TMOUT': '86400', 10:16:12 INFO - 'USER': 'cltbld', 10:16:12 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:12 INFO - '_': '/tools/buildbot/bin/python'} 10:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:12 INFO - Downloading/unpacking psutil>=3.1.1 10:16: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 10:16: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 10:16:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16: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 10:16: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 10:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:16:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:14 INFO - Installing collected packages: psutil 10:16:14 INFO - Running setup.py install for psutil 10:16:14 INFO - building 'psutil._psutil_linux' extension 10:16:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:16:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:16:14 INFO - building 'psutil._psutil_posix' extension 10:16:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:16:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:16:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:15 INFO - Successfully installed psutil 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:16:15 INFO - Using env: {'DISPLAY': ':0', 10:16:15 INFO - 'HOME': '/home/cltbld', 10:16:15 INFO - 'LANG': 'en_US.UTF-8', 10:16:15 INFO - 'LANGUAGE': 'en_US:en', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MAIL': '/var/mail/cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SHLVL': '1', 10:16:15 INFO - 'TERM': 'linux', 10:16:15 INFO - 'TMOUT': '86400', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - '_': '/tools/buildbot/bin/python'} 10:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:16:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:16:17 INFO - Installing collected packages: mozsystemmonitor 10:16:17 INFO - Running setup.py install for mozsystemmonitor 10:16:17 INFO - Successfully installed mozsystemmonitor 10:16:17 INFO - Cleaning up... 10:16:17 INFO - Return code: 0 10:16:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:16:17 INFO - Using env: {'DISPLAY': ':0', 10:16:17 INFO - 'HOME': '/home/cltbld', 10:16:17 INFO - 'LANG': 'en_US.UTF-8', 10:16:17 INFO - 'LANGUAGE': 'en_US:en', 10:16:17 INFO - 'LOGNAME': 'cltbld', 10:16:17 INFO - 'MAIL': '/var/mail/cltbld', 10:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:17 INFO - 'MOZ_NO_REMOTE': '1', 10:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:17 INFO - 'NO_EM_RESTART': '1', 10:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:17 INFO - 'PWD': '/builds/slave/test', 10:16:17 INFO - 'SHELL': '/bin/bash', 10:16:17 INFO - 'SHLVL': '1', 10:16:17 INFO - 'TERM': 'linux', 10:16:17 INFO - 'TMOUT': '86400', 10:16:17 INFO - 'USER': 'cltbld', 10:16:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:17 INFO - '_': '/tools/buildbot/bin/python'} 10:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:17 INFO - Downloading/unpacking jsonschema==2.5.1 10:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:16: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 10:16: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 10:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16: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 10:16: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 10:16:20 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:20 INFO - warning: no files found matching '*.txt' 10:16:20 INFO - no previously-included directories found matching 'build' 10:16:20 INFO - no previously-included directories found matching 'dist' 10:16:20 INFO - no previously-included directories found matching '.git*' 10:16:20 INFO - Installing collected packages: jsonschema, functools32 10:16:20 INFO - Running setup.py install for functools32 10:16:20 INFO - warning: no files found matching '*.txt' 10:16:20 INFO - no previously-included directories found matching 'build' 10:16:20 INFO - no previously-included directories found matching 'dist' 10:16:20 INFO - no previously-included directories found matching '.git*' 10:16:20 INFO - Successfully installed jsonschema functools32 10:16:20 INFO - Cleaning up... 10:16:20 INFO - Return code: 0 10:16:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:20 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:16:20 INFO - Using env: {'DISPLAY': ':0', 10:16:20 INFO - 'HOME': '/home/cltbld', 10:16:20 INFO - 'LANG': 'en_US.UTF-8', 10:16:20 INFO - 'LANGUAGE': 'en_US:en', 10:16:20 INFO - 'LOGNAME': 'cltbld', 10:16:20 INFO - 'MAIL': '/var/mail/cltbld', 10:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:20 INFO - 'MOZ_NO_REMOTE': '1', 10:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:20 INFO - 'NO_EM_RESTART': '1', 10:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:20 INFO - 'PWD': '/builds/slave/test', 10:16:20 INFO - 'SHELL': '/bin/bash', 10:16:20 INFO - 'SHLVL': '1', 10:16:20 INFO - 'TERM': 'linux', 10:16:20 INFO - 'TMOUT': '86400', 10:16:20 INFO - 'USER': 'cltbld', 10:16:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:20 INFO - '_': '/tools/buildbot/bin/python'} 10:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:16:20 INFO - Cleaning up... 10:16:20 INFO - Return code: 0 10:16:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:20 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:16:20 INFO - Using env: {'DISPLAY': ':0', 10:16:20 INFO - 'HOME': '/home/cltbld', 10:16:20 INFO - 'LANG': 'en_US.UTF-8', 10:16:20 INFO - 'LANGUAGE': 'en_US:en', 10:16:20 INFO - 'LOGNAME': 'cltbld', 10:16:20 INFO - 'MAIL': '/var/mail/cltbld', 10:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:20 INFO - 'MOZ_NO_REMOTE': '1', 10:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:20 INFO - 'NO_EM_RESTART': '1', 10:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:20 INFO - 'PWD': '/builds/slave/test', 10:16:20 INFO - 'SHELL': '/bin/bash', 10:16:20 INFO - 'SHLVL': '1', 10:16:20 INFO - 'TERM': 'linux', 10:16:20 INFO - 'TMOUT': '86400', 10:16:20 INFO - 'USER': 'cltbld', 10:16:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:20 INFO - '_': '/tools/buildbot/bin/python'} 10:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:20 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:22 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:16:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:23 INFO - Downloading docopt-0.6.1.tar.gz 10:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:23 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:23 INFO - Running setup.py install for blobuploader 10:16:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:16:23 INFO - Running setup.py install for requests 10:16:24 INFO - Running setup.py install for docopt 10:16:24 INFO - Successfully installed blobuploader requests docopt 10:16:24 INFO - Cleaning up... 10:16:24 INFO - Return code: 0 10:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:16:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:16:24 INFO - Using env: {'DISPLAY': ':0', 10:16:24 INFO - 'HOME': '/home/cltbld', 10:16:24 INFO - 'LANG': 'en_US.UTF-8', 10:16:24 INFO - 'LANGUAGE': 'en_US:en', 10:16:24 INFO - 'LOGNAME': 'cltbld', 10:16:24 INFO - 'MAIL': '/var/mail/cltbld', 10:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:24 INFO - 'MOZ_NO_REMOTE': '1', 10:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:24 INFO - 'NO_EM_RESTART': '1', 10:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:24 INFO - 'PWD': '/builds/slave/test', 10:16:24 INFO - 'SHELL': '/bin/bash', 10:16:24 INFO - 'SHLVL': '1', 10:16:24 INFO - 'TERM': 'linux', 10:16:24 INFO - 'TMOUT': '86400', 10:16:24 INFO - 'USER': 'cltbld', 10:16:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:24 INFO - '_': '/tools/buildbot/bin/python'} 10:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:24 INFO - Running setup.py (path:/tmp/pip-VH5B3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:24 INFO - Running setup.py (path:/tmp/pip-HNYmJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:24 INFO - Running setup.py (path:/tmp/pip-Vmxr6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:24 INFO - Running setup.py (path:/tmp/pip-lJKaAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:25 INFO - Running setup.py (path:/tmp/pip-BdDScS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:25 INFO - Running setup.py (path:/tmp/pip-PGXrlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:25 INFO - Running setup.py (path:/tmp/pip-K_ez41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:25 INFO - Running setup.py (path:/tmp/pip-ol1wUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:25 INFO - Running setup.py (path:/tmp/pip-XO6Mvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:25 INFO - Running setup.py (path:/tmp/pip-Q9ek3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:25 INFO - Running setup.py (path:/tmp/pip-sntKCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:25 INFO - Running setup.py (path:/tmp/pip-Le4Rl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:25 INFO - Running setup.py (path:/tmp/pip-huwXSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:25 INFO - Running setup.py (path:/tmp/pip-OVbeph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:25 INFO - Running setup.py (path:/tmp/pip-H0HNk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:25 INFO - Running setup.py (path:/tmp/pip-KGhqEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:25 INFO - Running setup.py (path:/tmp/pip-mkcVel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:25 INFO - Running setup.py install for manifestparser 10:16:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Running setup.py install for mozcrash 10:16:26 INFO - Running setup.py install for mozdebug 10:16:26 INFO - Running setup.py install for mozdevice 10:16:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Running setup.py install for mozfile 10:16:26 INFO - Running setup.py install for mozhttpd 10:16:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Running setup.py install for mozinfo 10:16:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Running setup.py install for mozInstall 10:16:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:26 INFO - Running setup.py install for mozleak 10:16:26 INFO - Running setup.py install for mozlog 10:16:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:27 INFO - Running setup.py install for moznetwork 10:16:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:27 INFO - Running setup.py install for mozprocess 10:16:27 INFO - Running setup.py install for mozprofile 10:16:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:27 INFO - Running setup.py install for mozrunner 10:16:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:27 INFO - Running setup.py install for mozscreenshot 10:16:27 INFO - Running setup.py install for moztest 10:16:27 INFO - Running setup.py install for mozversion 10:16:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:27 INFO - Cleaning up... 10:16:27 INFO - Return code: 0 10:16:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:16:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:16:27 INFO - Using env: {'DISPLAY': ':0', 10:16:27 INFO - 'HOME': '/home/cltbld', 10:16:27 INFO - 'LANG': 'en_US.UTF-8', 10:16:27 INFO - 'LANGUAGE': 'en_US:en', 10:16:27 INFO - 'LOGNAME': 'cltbld', 10:16:27 INFO - 'MAIL': '/var/mail/cltbld', 10:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:27 INFO - 'MOZ_NO_REMOTE': '1', 10:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:27 INFO - 'NO_EM_RESTART': '1', 10:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:27 INFO - 'PWD': '/builds/slave/test', 10:16:27 INFO - 'SHELL': '/bin/bash', 10:16:27 INFO - 'SHLVL': '1', 10:16:27 INFO - 'TERM': 'linux', 10:16:27 INFO - 'TMOUT': '86400', 10:16:27 INFO - 'USER': 'cltbld', 10:16:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:27 INFO - '_': '/tools/buildbot/bin/python'} 10:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:28 INFO - Running setup.py (path:/tmp/pip-7HmN7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:28 INFO - Running setup.py (path:/tmp/pip-1hTRsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:28 INFO - Running setup.py (path:/tmp/pip-Q2hNkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:28 INFO - Running setup.py (path:/tmp/pip-9KurWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:28 INFO - Running setup.py (path:/tmp/pip-IP26wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:28 INFO - Running setup.py (path:/tmp/pip-3cNugt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:28 INFO - Running setup.py (path:/tmp/pip-tRLyEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:28 INFO - Running setup.py (path:/tmp/pip-bf50dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:28 INFO - Running setup.py (path:/tmp/pip-94lYzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:28 INFO - Running setup.py (path:/tmp/pip-URqfM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:28 INFO - Running setup.py (path:/tmp/pip-ZCHgSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:28 INFO - Running setup.py (path:/tmp/pip-dc1B_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:28 INFO - Running setup.py (path:/tmp/pip-q00G2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:28 INFO - Running setup.py (path:/tmp/pip-o_8sHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:29 INFO - Running setup.py (path:/tmp/pip-jPRw1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:29 INFO - Running setup.py (path:/tmp/pip-bejyB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:29 INFO - Running setup.py (path:/tmp/pip-ZuWiG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:16:29 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:29 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:31 INFO - Downloading blessings-1.6.tar.gz 10:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:31 INFO - Installing collected packages: blessings 10:16:31 INFO - Running setup.py install for blessings 10:16:31 INFO - Successfully installed blessings 10:16:31 INFO - Cleaning up... 10:16:31 INFO - Return code: 0 10:16:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:31 INFO - Reading from file tmpfile_stdout 10:16:31 INFO - Current package versions: 10:16:31 INFO - argparse == 1.2.1 10:16:31 INFO - blessings == 1.6 10:16:31 INFO - blobuploader == 1.2.4 10:16:31 INFO - docopt == 0.6.1 10:16:31 INFO - functools32 == 3.2.3-2 10:16:31 INFO - jsonschema == 2.5.1 10:16:31 INFO - manifestparser == 1.1 10:16:31 INFO - mozInstall == 1.12 10:16:31 INFO - mozcrash == 1.0 10:16:31 INFO - mozdebug == 0.1 10:16:31 INFO - mozdevice == 0.49 10:16:31 INFO - mozfile == 1.2 10:16:31 INFO - mozhttpd == 0.7 10:16:31 INFO - mozinfo == 0.9 10:16:31 INFO - mozleak == 0.1 10:16:31 INFO - mozlog == 3.4 10:16:31 INFO - moznetwork == 0.27 10:16:31 INFO - mozprocess == 0.25 10:16:31 INFO - mozprofile == 0.28 10:16:31 INFO - mozrunner == 6.13 10:16:31 INFO - mozscreenshot == 0.1 10:16:31 INFO - mozsystemmonitor == 0.3 10:16:31 INFO - moztest == 0.8 10:16:31 INFO - mozversion == 1.4 10:16:31 INFO - psutil == 3.1.1 10:16:31 INFO - requests == 1.2.3 10:16:31 INFO - wsgiref == 0.1.2 10:16:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:31 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:31 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:16:31 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:16:31 INFO - Using env: {'DISPLAY': ':0', 10:16:31 INFO - 'HOME': '/home/cltbld', 10:16:31 INFO - 'LANG': 'en_US.UTF-8', 10:16:31 INFO - 'LANGUAGE': 'en_US:en', 10:16:31 INFO - 'LOGNAME': 'cltbld', 10:16:31 INFO - 'MAIL': '/var/mail/cltbld', 10:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:31 INFO - 'MOZ_NO_REMOTE': '1', 10:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:31 INFO - 'NO_EM_RESTART': '1', 10:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:31 INFO - 'PWD': '/builds/slave/test', 10:16:31 INFO - 'SHELL': '/bin/bash', 10:16:31 INFO - 'SHLVL': '1', 10:16:31 INFO - 'TERM': 'linux', 10:16:31 INFO - 'TMOUT': '86400', 10:16:31 INFO - 'USER': 'cltbld', 10:16:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:31 INFO - '_': '/tools/buildbot/bin/python'} 10:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:16:31 INFO - Cleaning up... 10:16:31 INFO - Return code: 0 10:16:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x25fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, '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': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:16:32 INFO - Using env: {'DISPLAY': ':0', 10:16:32 INFO - 'HOME': '/home/cltbld', 10:16:32 INFO - 'LANG': 'en_US.UTF-8', 10:16:32 INFO - 'LANGUAGE': 'en_US:en', 10:16:32 INFO - 'LOGNAME': 'cltbld', 10:16:32 INFO - 'MAIL': '/var/mail/cltbld', 10:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:32 INFO - 'MOZ_NO_REMOTE': '1', 10:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:32 INFO - 'NO_EM_RESTART': '1', 10:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:32 INFO - 'PWD': '/builds/slave/test', 10:16:32 INFO - 'SHELL': '/bin/bash', 10:16:32 INFO - 'SHLVL': '1', 10:16:32 INFO - 'TERM': 'linux', 10:16:32 INFO - 'TMOUT': '86400', 10:16:32 INFO - 'USER': 'cltbld', 10:16:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:32 INFO - '_': '/tools/buildbot/bin/python'} 10:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:16:32 INFO - Cleaning up... 10:16:32 INFO - Return code: 0 10:16:32 INFO - Running post-action listener: _resource_record_post_action 10:16:32 INFO - Running post-action listener: _start_resource_monitoring 10:16:32 INFO - Starting resource monitoring. 10:16:32 INFO - [mozharness: 2017-04-05 17:16:32.262679Z] Finished create-virtualenv step (success) 10:16:32 INFO - [mozharness: 2017-04-05 17:16:32.263194Z] Running install step. 10:16:32 INFO - Running pre-action listener: _resource_record_pre_action 10:16:32 INFO - Running main action method: install 10:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:32 INFO - Reading from file tmpfile_stdout 10:16:32 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:32 INFO - Reading from file tmpfile_stdout 10:16:32 INFO - Output received: 10:16:32 INFO - Usage: mozinstall [options] installer 10:16:32 INFO - Options: 10:16:32 INFO - -h, --help show this help message and exit 10:16:32 INFO - -d DEST, --destination=DEST 10:16:32 INFO - Directory to install application into. [default: 10:16:32 INFO - "/builds/slave/test"] 10:16:32 INFO - --app=APP Application being installed. [default: firefox] 10:16:32 INFO - mkdir: /builds/slave/test/build/application 10:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:16:49 INFO - Reading from file tmpfile_stdout 10:16:49 INFO - Output received: 10:16:49 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:49 INFO - Running post-action listener: _resource_record_post_action 10:16:49 INFO - [mozharness: 2017-04-05 17:16:49.117261Z] Finished install step (success) 10:16:49 INFO - [mozharness: 2017-04-05 17:16:49.117409Z] Running run-tests step. 10:16:49 INFO - Running pre-action listener: _resource_record_pre_action 10:16:49 INFO - Running main action method: run_tests 10:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:49 INFO - Python 2.7.3 10:16:49 INFO - Return code: 0 10:16:49 INFO - grabbing minidump binary from tooltool 10:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:49 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 0x2898400>, '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 0x28993b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:16:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:16:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:16:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:49 INFO - Return code: 0 10:16:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:49 INFO - ENV: RUST_BACKTRACE is now 1 10:16:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 10:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 10:16:49 INFO - Using env: {'DISPLAY': ':0', 10:16:49 INFO - 'HOME': '/home/cltbld', 10:16:49 INFO - 'LANG': 'en_US.UTF-8', 10:16:49 INFO - 'LANGUAGE': 'en_US:en', 10:16:49 INFO - 'LOGNAME': 'cltbld', 10:16:49 INFO - 'MAIL': '/var/mail/cltbld', 10:16:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:49 INFO - 'MOZ_NO_REMOTE': '1', 10:16:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:49 INFO - 'NO_EM_RESTART': '1', 10:16:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:49 INFO - 'PWD': '/builds/slave/test', 10:16:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:49 INFO - 'RUST_BACKTRACE': '1', 10:16:49 INFO - 'SHELL': '/bin/bash', 10:16:49 INFO - 'SHLVL': '1', 10:16:49 INFO - 'TERM': 'linux', 10:16:49 INFO - 'TMOUT': '86400', 10:16:49 INFO - 'USER': 'cltbld', 10:16:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552', 10:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:49 INFO - '_': '/tools/buildbot/bin/python'} 10:16:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 10:16:49 INFO - mozversion application_buildid: 20170405162434 10:16:49 INFO - mozversion application_changeset: 632c2b8c17297a8d4c70fc33a518808d81fc18c7 10:16:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:16:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:49 INFO - mozversion application_name: Firefox 10:16:49 INFO - mozversion application_remotingname: firefox-dev 10:16:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:16:49 INFO - mozversion application_vendor: Mozilla 10:16:49 INFO - mozversion application_version: 54.0a2 10:16:49 INFO - mozversion platform_buildid: 20170405162434 10:16:49 INFO - mozversion platform_changeset: 632c2b8c17297a8d4c70fc33a518808d81fc18c7 10:16:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:16:49 INFO - mozversion platform_version: 54.0a2 10:16:49 INFO - using testdate: 1491412609 10:16:49 INFO - actual date: 1491412609 10:16:49 INFO - starting webserver on 'localhost:35662' 10:16:49 INFO - SUITE-START | Running 2 tests 10:16:49 INFO - TEST-START | dromaeo_css 10:16:49 INFO - operating with platform_type : linux_ 10:16:49 INFO - Initialising browser for dromaeo_css test... 10:16:49 INFO - TEST-INFO | started process 14081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa9mIdy/profile http://localhost:35662/getInfo.html) 10:16:53 INFO - PROCESS | 14081 | __metrics Screen width/height:1600/1200 10:16:53 INFO - PROCESS | 14081 | colorDepth:24 10:16:53 INFO - PROCESS | 14081 | Browser inner width/height: 1024/697 10:16:53 INFO - PROCESS | 14081 | __metrics 10:16:54 ERROR - PROCESS | 14081 | 1491412614591 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 10:16:54 INFO - PROCESS | 14081 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:16:54 INFO - PROCESS | 14081 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:55 INFO - TEST-INFO | 14081: exit 0 10:16:55 INFO - Browser initialized. 10:16:55 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:55 INFO - TEST-INFO | started process 14169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa9mIdy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:07 INFO - PROCESS | 14169 | RSS: Main: 139780096 10:17:07 INFO - PROCESS | 14169 | 10:20:08 INFO - PROCESS | 14169 | Cycle 1(1): loaded http://localhost:35662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35662/tests/dromaeo/cssquery-ext.html) 10:20:10 INFO - PROCESS | 14169 | RSS: Main: 281825280 10:20:10 INFO - PROCESS | 14169 | 10:21:57 INFO - PROCESS | 14169 | ************************* 10:21:57 INFO - PROCESS | 14169 | A coding exception was thrown and uncaught in a Task. 10:21:57 INFO - PROCESS | 14169 | 10:21:57 ERROR - PROCESS | 14169 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:21:57 INFO - PROCESS | 14169 | Full stack: 10:21:57 INFO - PROCESS | 14169 | ************************* 10:21:57 INFO - PROCESS | 14169 | ************************* 10:21:57 INFO - PROCESS | 14169 | A coding exception was thrown and uncaught in a Task. 10:21:57 INFO - PROCESS | 14169 | 10:21:57 ERROR - PROCESS | 14169 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:21:57 INFO - PROCESS | 14169 | Full stack: 10:21:57 INFO - PROCESS | 14169 | ************************* 10:21:57 INFO - PROCESS | 14169 | ************************* 10:21:57 INFO - PROCESS | 14169 | A coding exception was thrown and uncaught in a Task. 10:21:57 INFO - PROCESS | 14169 | 10:21:57 ERROR - PROCESS | 14169 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:21:57 INFO - PROCESS | 14169 | Full stack: 10:21:57 INFO - PROCESS | 14169 | ************************* 10:21:57 INFO - PROCESS | 14169 | ************************* 10:21:57 INFO - PROCESS | 14169 | A coding exception was thrown and uncaught in a Task. 10:21:57 INFO - PROCESS | 14169 | 10:21:57 ERROR - PROCESS | 14169 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:21:57 INFO - PROCESS | 14169 | Full stack: 10:21:57 INFO - PROCESS | 14169 | ************************* 10:23:12 INFO - PROCESS | 14169 | Cycle 1(1): loaded http://localhost:35662/tests/dromaeo/cssquery-ext.html (next: http://localhost:35662/tests/dromaeo/cssquery-jquery.html) 10:23:13 INFO - PROCESS | 14169 | RSS: Main: 218886144 10:23:13 INFO - PROCESS | 14169 | 10:26:15 INFO - PROCESS | 14169 | Cycle 1(1): loaded http://localhost:35662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35662/tests/dromaeo/cssquery-mootools.html) 10:26:15 INFO - PROCESS | 14169 | RSS: Main: 173584384 10:26:15 INFO - PROCESS | 14169 | 10:29:17 INFO - PROCESS | 14169 | Cycle 1(1): loaded http://localhost:35662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35662/tests/dromaeo/cssquery-prototype.html) 10:29:18 INFO - PROCESS | 14169 | RSS: Main: 214921216 10:29:18 INFO - PROCESS | 14169 | 10:32:21 INFO - PROCESS | 14169 | Cycle 1(1): loaded http://localhost:35662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35662/tests/dromaeo/cssquery-yui.html) 10:32:21 INFO - PROCESS | 14169 | RSS: Main: 175185920 10:32:21 INFO - PROCESS | 14169 | 10:35:23 INFO - PROCESS | 14169 | Cycle 1(1): loaded http://localhost:35662/tests/dromaeo/cssquery-yui.html (next: http://localhost:35662/tests/dromaeo/cssquery-dojo.html) 10:35:24 INFO - PROCESS | 14169 | RSS: Main: 270589952 10:35:24 INFO - PROCESS | 14169 | 10:35:24 INFO - PROCESS | 14169 | __start_tp_report 10:35:24 INFO - PROCESS | 14169 | _x_x_mozilla_page_load 10:35:24 INFO - PROCESS | 14169 | _x_x_mozilla_page_load_details 10:35:24 INFO - PROCESS | 14169 | |i|pagename|runs| 10:35:24 INFO - PROCESS | 14169 | |0;dojo.html;3383.7123844473217;3420.8460619272137;3427.383071047212;3444.1045328214655;3475.200703838117;5696.458836410539;5755.079187330028;5768.596198266123;5772.538196944245;5778.913316300248;5701.543876489881;5726.226959360485;5745.2818397700285;5751.827445176641;5752.36723960364;5002.574781143607;5067;5074.2388641703765;5089.720065396402;5113.054084994288;4965.379327584052;5153.6907785532985;5174.741262936838;5176.948230517684;5204.843854684365;5003.074431230216;5021.27191557224;5075.9746201268945;5148;5164.328637277149;5131.666441681297;5148.948510514903;5172.250023746573;5174.689518628857;5175.146100893348;5045.369328833895;5100;5135.537801597874;5142.04872098663;5177.275181474596;5520.282363292747;5534.806281780158;5637.46444087811;5708.058170401879;5708.543316534668;6148.077788331741;6164.506839452833;6176.011838105882;6184.84537886552;6191.628502289877;6204.906926396107;6214.906776398358;6221.097940798604;6221.844453888643;6234.563580549363;5581.609287349887;5617.859553511154;5675.2054712340305;5688.345840228344;5815.505682017034;6219.595726277777;6245.156903818017;6245.188125543741;6257.0614407838275;6259.530535209878;5964.671943043088;6028.035514317776;6037.184980027728;6037.516998640098;6038.184845045863;5920.615160014671;5962.433568810956;6017.879642407215;6146.5390095743;6155.84610384735;6111.552992642655;6122.173506576644;6143.385661433821;6143.723532441051;6147.754089836446;5859.1797148399255;5909.23179986599;5914.704264786744;6118.718276956224;6124.910294234916;4649.418822647169;4676.134915040729;4686.976565117221;4690.460597031317;4754.833580824655;4114.917701645951;4209;4219.324908014764;4234.407182994383;4246.256905041667;5871.031279838779;5871.677057761779;5912.881742365129;5975.342712301644;5993.490553303018;6125.1731016313115;6149.0776383542825;6154.815355539341;6156.476699480505;6157.076438534255;5943.167956486095;5955.106733989936;5960.642361458326;5961.552883533753;5963.403659634002;5109.182530795129;5142.665726727751;5219.765110570033;5265.657732247391;5275.868103297372;6490.935090649127;6496.642684652201;6499.09012738217;6502.642354670538;6502.739890404426;6199.132121503083;6211.316755156839;6217.347178546368;6218.440340369389;6224.751009959732;6120.690942951019;6238.282597501346;6255.749770009149;6312;6345.555811093179;6031.638101713911;6032.788852390146;6037.215162028908;6041.214642096499;6068.544859135494;6121.632702037892;6131.202943617302;6133.110698948538;6140.539459540463;6142.293636231891;5799.942000580109;5827;5976.043832986701;5990.820275391745;6039.063945088518;6066.787662431971;6072.635641861502;6080.513558915188;6097.603655762361;6112.724927378367;5988.847528068107;6045.848853778691;6051.788187413596;6053.182820319201;6055.5458340623745;5797.710114494343;5808.07070868659;5864.296284445893;5943.316518600416;6078.848028799315;5922.170896074639;5931.9406805931385;5941.079132734433;5946.851328716817;5959.91060134107 10:35:24 INFO - PROCESS | 14169 | |1;ext.html;717.3615482220824;782.4131901074194;803.3613277444433;834.3075247544539;844.1853611265136;30684;43772;44633;47421.288680669815;47622.76188619052;44810.32784508235;44908.3263751044;44933.77533112338;45000;45041;7738.613069346538;7881.645325960317;9201.907980920188;9344.392614480072;9346.485943273117;10813.83779243312;11040;11042.779144417107;11043.558257669683;11048.116150707965;11036.282641628308;11056.723581910477;11065.723356916102;11074;11082.944585277062;10961.397123158224;10984.560617575287;10990.065844403236;10994.175436842188;11009.504572294267;10557.841632375521;10692.893071069268;10696;10698.51856666452;10711.625093121704;41097.383539246934;41280.38079428811;41400.585994139976;41405.585944140475;41421.1715765686;4150.64719498843;4209;4245.448091748084;4324.178406102862;4352.89117772055;30077.849610752026;30585.847070764725;30592.84703576468;30640.2339941501;31841.52237716413;4351.608355248043;4432.756198409086;4441.267190913495;4509.391232183646;4526.275795872678;237781;238918;239344;241763.99999999825;242035;52158;52189.21716174261;52300.73849630728;52304.47695522996;52393;55354;55831.441685583435;55866.44133558694;55869.44130558642;55883;14059;14175.432982680784;14267.78598321026;14281.857181428053;14305.57083287503;12028.458719357475;12030.4586293617;13129.409176587076;13212.801807972888;14446.783298250535;13576.864231357758;13706.451741930212;13711.382987765575;13785.172889626654;13787.586372408843;5395.81114660985;5454.181872719124;5500.669959802424;5517.586181036439;5538.833834984876;1020.0411613083678;1024.293237666008;1027.3476342522551;1031.8452232165234;1032.2774058159318;27925;28066.85966570154;28345.858270708926;28397;28601.71398286032;1098.9505472253768;1104.2546281260277;1116.17403121691;1127.4193790198055;1140.5437824870119;14675.119492830465;15165.165915874511;15237.238138093051;15416.306266217824;15430.922845385701;298881;299260;300335;300654;301421;57748.13377799336;57784.422155778746;57809.421905781244;57935.13097303544;58042.709786450796;1502.3990403838334;1509.433962264151;1531.509916826627;1550.0777037662572;1556.6497538054073;26126.86936565305;27345;27472.45055098927;27508.44983100287;27577.586336205375;42681.359779603954;42736;42856.78571607122;42886;42949.35575966426;278099;279174;279483;280200;280222;29799.25501862384;30521.847390763793;34283.314333713686;35106.82446587751;35226.47160292649;44333.556664432945;44598.331025034;44812;46061.30908036449;46078.30882536698;33675;33940.981770545935;34019;34282.314353713286;34343.797967071034;32975.835120824246;33089.50365744564;33201;33571.49642755312;33875;38860.61139388683;39110.41334379929;39223;39295;39650.2069958605;31217.68782312148;31274.374512510076;31760.523592146597;31806.52290215695;31974.840125800154;24918.252452426455;25573.87213063923;25895.48209035771;26056.8697156513;26289.868550657124 10:35:24 INFO - PROCESS | 14169 | |2;jquery.html;463.7727513518376;469.7721605021566;471.0954966464388;475.453228786895;480.10939706843806;19257.422277331683;20935;22131.778682213175;22208.333749987487;22460.550788984212;21432.8928355358;22074.66887996681;22207.888960555174;22317.218897338596;22575;6474.676266186695;6522.641254730988;6736.797896063126;6769.932300677004;6794.592324460524;6700.028495868096;6759.425448836831;6799.320067993211;6801.6599170041545;6814.3185681431705;7196;7215.711371545131;7223.458240631948;7235.565866048028;7239.095113110861;7197.136343638745;7268.854622907539;7436.702531898744;7470.252974702541;7478.775636730907;6599.5380323377385;6892.310768923117;7271.381932535741;7311;7317.524360916524;25017.374565635822;25058.248252552272;25186.370340741443;25418.237452876445;25447.363815904566;3191.3457741163006;3240.951385729216;3276.0826968448873;3348.8995330140133;3357.8321083945707;15489.922550387177;15908.204589770581;16161.111138887356;16288.42990495327;16518.504444866674;2185.967210491844;2243.4279258789065;2276.3284830974903;2306.308107567723;2322.1175953137868;115201.42399288034;118397.40801296025;118413.40793295979;118936.40531797285;120130;15990.440334588233;16342.832577692612;17037.829621703873;18220.726689099673;18589.163487643087;30424.391512170074;30713.232169195948;30749;30749.38501229963;30800.537991930138;10215.387076775418;10364.585416583252;10486.790264194673;10506.684799456028;10529.736431628253;8842.159994800484;8916.089961124891;8951.597178127;9098.636054557875;9124.315676324302;8842.46945183291;8946.731598052069;9114.179723824887;9166;9365.344425890122;3506.5967413747235;3636.890893273206;3799.2021675448464;3856.267309211241;3978.8806335809973;971.0871780526282;978.9167920726818;994.8408254679216;997.4464172384252;1001.8647482589903;20960.26639067656;21239.256626018323;21322.680159797615;21469.78530214709;21612.135514579557;985.3989066669326;989.9901000989898;1005.9497025148713;1011.0597144655541;1015.4364327798143;11174.44127793607;11516.309021458572;11627.418629068512;11636.99609168066;11655.76688466226;291503;293654;294380;484670;641339;79241.60379198067;79886.6005669968;109473;117432.71552780145;122011.38994305149;1096.3421946831998;1132.881047490018;1138.1975707126455;1141.3095077478172;1296.4554886947317;18080.367187148386;18938.242470301586;19036.33372831944;19053.71419428682;19064.809351906304;53158.73420632872;53162;53538.73230633978;53678.73160634172;54147;60829;63055.6847215761;71175.64412177906;72012.63993679998;73108.26891731228;7588.27911348421;10798.352098874093;11747.823782643096;12263.141580089308;12369.814452783396;14405.63985900319;14433.422663093359;14492.34784434682;14555.708885822436;14699;12065.879341206475;12126.272423654256;12187.268763874195;12291.877081229073;12334.32161231105;11001.61494347694;11243.60647377338;11320.320780753182;11333.320000799979;11340.149488788209;12214.694632634255;12281.508739650671;12343.75312493763;13080.345982701017;13199.20804751718;12020.218685785396;12052.337121458404;12079.698007549881;12138.939305303771;12413.75172496527;11894.940525297665;12288.262704237774;12455.190412623151;12723.80914286305;12832.294223817406 10:35:24 INFO - PROCESS | 14169 | |3;mootools.html;1409.6546346145196;1570.3561539768693;1576.3458164861584;1603.1423188594104;1605.2776250687193;9424.81150376992;11204.943975280123;11537.653870383881;11838.467268972896;11844.11169162312;11610.419479026057;11653.067754579635;11677.299362038262;11678.941605291982;11698.766024679502;2011.3463124484529;2073.1810934680866;2093.5812837432572;2350.49464365161;2391.4141035446255;2030.5837303352778;2267.614505534063;2343.906243750248;2348.4481146930457;2363.822713296501;2287.714035745532;2292.713410823647;2293.6100862853355;2294.105298933417;2296.6555016747457;2234.597772400967;2274.374546999572;2275.8179345652306;2276.6243569810963;2279.886005699708;2209.7016902718087;2257.052038143967;2322.222055611372;2327.918522851709;2328.7904088631935;11455.484503197376;11569.016633586156;11578.247413918069;11630.883691163064;11708;5863.560232982543;5967.940320596782;6007.879842403171;6012;6021.819345419601;3554.9466757998393;3692.9446058309145;3786.848526058954;3808.980955095207;3817.2174704185577;1381.405995421968;1389.8957578181678;1448.3627204030192;1476.4906107392933;1508.5549762819994;17440.389586364417;17442.389516366995;17550.648987020188;17554.473365799047;17557.385491507735;4741.2651039089;4955.132851750929;4976.825811096594;5010.974945125324;5082;13608.387622556811;13709.314534273446;13751.793723094162;13771.793423098661;13778.586642400744;6026.578139530278;6121.602095863755;6126.479249263863;6126.571140020156;6128.693565321716;4566.474855391606;5448.991936491761;5482.945170548243;5516.779328826802;5533.6403133796175;3843.9615603844163;4149.7095203335475;4201.432806571135;4292.313229883203;4341.19687857741;1171.6133675886938;1183.798754211786;1184.9585264515702;1193.2244041373176;1199.5321824488456;1044;1053.2153545608571;1061.2359101446946;1064.6060957445795;1066.8186408310605;7068.858622827514;7140.250273721288;7197.71209151628;7215.639218039077;7238.963805180941;1094.8795632480421;1111.5053801058614;1111.7220694826294;1121.4448847820381;1147.386148410613;4811.9518804811505;4851.684640498356;4870.537298956593;4907.631927605373;4972.8756781080765;14349.497767578085;14835.258237088103;14837.10977341363;14850.702985940437;14883.10701357922;13803.930980345034;14248;15056.548303550911;15092.622684432978;15095.094294342374;10438.269321147447;10637.627683031056;10640.627578034577;10704.839427408595;10743.570257189782;7244.529105608119;7386.667599957907;7547.396208303213;7551.395888329031;7667.11828139771;13194.340282986004;13209.867901320864;13511.527096551574;13552.796708049584;13555.254461004739;13570.321483925962;13609.659758506117;13618;13670.52153174634;13856.653583660489;9908.653197138066;9996.45019523904;10031.29780915329;10078.546465409221;10120.240981926532;10854;10855.620053298097;10993.120550355792;10995.615153469591;11050.557977680803;9169;9315.813683726423;9324.627014919328;9374.437533747998;9497.335186536877;9095.363324567217;9126.589303481227;9137.177654011171;9146.542672866197;9284.814303713752;8220.383471239562;8550.273226775793;8594.65621375138;8724.956375218084;8737;6539.574927629689;6660.467162627075;6677.131972843499;6691.197056353269;6744.426723728538;6629.4696424284975;6636.734530618721;6653.567518111307;6706.228783689938;6732.42774364165 10:35:24 INFO - PROCESS | 14169 | |4;prototype.html;416.79961710274404;423.20226373286346;432.30399057517394;441.701851250406;448.15299084729844;5163.974180129098;5228.692826793302;5239.345081864767;5246.8688282792855;5281.973590132049;5044.117279476086;5131.486851314867;5162.638615296931;5175.351377279018;5199.506046925546;4331.631811296043;4336.566343365662;4345.348197770328;4352.542982986788;4370.759608221547;4359.455068116486;4359.542248063955;4381.386605875164;4385.978070109645;4414.668899832525;4247;4254.191703576326;4255.212785634668;4299.613034826881;4310.396544483775;4254.744715317075;4257.743965530176;4282.785860706952;4306.892327691833;4308;4072.8188825240645;4086.979565102185;4098.241825262336;4102.651274641659;4119.402686610425;4925.3350797642215;5083.669561478492;5095.133827249377;5102.902875881666;5134.845954621367;5093.5415812576675;5119.2321151827155;5122.3853137623355;5129.461406552333;5136.922946155811;5467.781288748485;5494.917576236359;5514.6691198527815;5549.889002219933;5551.528120109796;4422.491413487426;4525.6649288459985;4549.09018196362;4580.908381832378;4583.3125031245245;5411.675299482044;5469.343678758534;5594.636348637367;5642.830715078554;5723.51350135239;4621.653375996813;4644.256918892961;4654.743989080633;4662.813487460531;4670.579647831712;4537.977310113428;4656.534346565317;4681.414823147106;4770;4804.231322988305;4996.4254110777;5025.899482010339;5052.242163675404;5092.414372347153;5092.567131793765;5451;5466.480684334982;5470.398256191816;5487.972560137174;5523.861903452445;1576.9763453548205;1625.6504851456757;1629.8370162983606;1649.935791414531;1655.8391299354219;1241.211830487647;1272.41468924294;1280.8527019392702;1281.7180220351509;1297.4495477904004;5391.595630327663;5410.296661433988;5418.295621569171;5437.864053398696;5450.809221677222;5645.4072322405555;5645.407232240637;5650.689212093293;5680.829575112753;5748.223989761329;5286.5506431952945;5403.594730395236;5424.613170205176;5437.694953211201;5480.26016487777;2969.426204111824;2972.316367235548;2975.598294230251;2999.475091858916;3010.473167195732;5542.780588270574;5670.314295707741;5720.597349113383;5790.478856902815;5805.970970145207;5647.915281270784;5685.204071430003;5695.629784064023;5697.686627235459;5726.742296596663;5806.2451881255165;5806.983777838946;5830.271216097988;5838.314375387369;5853.473187413153;5302.250257414967;5583.664980101207;5606.85982850432;5613.578981576316;5620.241267428844;5312.574994000393;5386.892262154814;5564.888702225851;5570.721463926707;5577.358603760457;5760;5819.476247137778;5832.562557808266;5847.736851841592;5852.912206316823;4721.976390118165;4737.455192652889;4762.4285085789925;4792.634099281688;4799.568038876518;5389.568834493152;5543.972280138573;5588.469095435927;5596.832095037155;5656.585853536616;5457.317835270591;5473.616846820684;5475.288212532345;5484.917726234189;5491.450854914477;5316.521513063843;5471.261379713687;5481.369642491165;5482;5522.420145884785;5347.411784703757;5401.921549230306;5471.6169868108855;5480.72596370172;5482.423261067292;5445.373782015119;5463.590230732631;5478.589105817;5493.0998990717035;5581.916271255853;5160.380754309507;5324.840254792362;5368.7852485901685;5399.676019438846;5415.214793854948 10:35:24 INFO - PROCESS | 14169 | |5;yui.html;823.5001244709982;834.7245409015026;842.6629348260695;907.224323203661;909.9226565741911;16419.50741477756;17550.648987020253;17581.560460988483;18436.723449148274;18781.43655690328;15928.681426371466;15958.361665533394;16786.076765777878;16805.159742012882;17081;886.8891388576444;910.7859652981545;914.1041779056528;914.8536234202529;915.244922938575;891.1222445890793;898.8292224477361;912.5938957164065;913.159892898535;913.4336711239008;914.8856392950881;915.5010519267015;918.5774543709869;919.6965001549506;921.3688623293032;906.4289497616526;906.714384968736;909.0455022226636;915.9496227707474;916.4867674102524;672.4250765595394;672.5930811858804;672.6804767735335;672.7140965089866;673.639602812493;16762.580935476588;16864.241109150116;17048.48854534366;18624.348147814897;18851.52871178218;15578.454754083552;16005.439809606607;16104;16212.351505939749;16376.83623163765;13885.930570347185;14077.929610351883;14086.15483071019;14165.575032749033;14173.71652566943;4063.5326937401987;4098.282800509899;4099.036726369301;4110.46563946688;4219;85353.14646853576;86085.56957215237;86151.56924215402;87982.56008719979;88564.11435885688;12519.311437871005;12596.685082872818;12676.69314890181;12769.808452873214;12808.743825123633;21591.2443064492;24604.384890377885;24636.5072698545;24780.876095619766;24888;9130.634774609074;9182.954085229665;9235.07649235071;9288.34981551285;9415.435073895589;4520.434945631796;4666.673332866734;4687.179743544866;5025.899482010339;5092.719900405439;3729.5524537055726;3831.099691572478;3836.712246581518;3838.654521093115;3845.2117315950723;632.1781683811028;638.3201889987149;640.3532432243375;652.6834485274638;661.3915198017835;774.5352788327071;787.330768846476;790.2334735306744;794.7417089445953;811.1888111888112;11280.210385273116;11540.711482212844;11650.126240531994;11733.647990560297;11896.464659090361;830.4975489828687;836.5649862071689;846.7925358287259;855.1234984141305;863.0851297624413;5397.35231772182;5494.203340515603;5548.223248745179;5558.249636299129;5560.694161821139;63520;63617.36382636207;80722.5963870177;80831.19168808355;81923;56541.43458565444;60018.09972850411;71328;73028.26971730214;74408.62795685987;66862.66568667126;67376.32623673798;67834.66082669554;67936.320636793;68742.65628671924;10489.895101048893;10601.41692206936;10643.521041553304;10811.297265677706;10818.1886358525;46570.76714616405;47371.52628473671;47735.761321193175;48190;48374;55735.72132139313;56596.71701641465;56833;56840.43159568351;57628.42371576231;12633;12777.552785652457;12885.613431597067;12993.155444896052;13173.209607423585;14507.854921451073;14516.346764395415;14553.781693274397;14646.901482389076;14722.484713034992;12296.75406491883;12624.621261362174;12656.6835829105;12657.367131643565;13059.477620895057;13015.47938082504;14045.508407205698;14489.347979341166;14974.85025149778;15372.23138843031;14488.565343039725;14550.563483095524;14551.563453096423;15605.375784968473;15916.363345466514;11302.773944520899;11780.410979450822;12235.510579576718;12563.93718031404;12797.36013199355;12336.642969273193;12662.493500260254;12757.872421276039;12864.22814631125;13511.459541618226 10:35:24 INFO - PROCESS | 14169 | __end_tp_report 10:35:24 INFO - PROCESS | 14169 | __start_cc_report 10:35:24 INFO - PROCESS | 14169 | _x_x_mozilla_cycle_collect,1385 10:35:24 INFO - PROCESS | 14169 | __end_cc_report 10:35:24 INFO - PROCESS | 14169 | __startTimestamp1491413724234__endTimestamp 10:35:24 INFO - PROCESS | 14169 | 10:35:24 INFO - PROCESS | 14169 | ------- Summary: start ------- 10:35:24 INFO - PROCESS | 14169 | Number of tests: 6 10:35:24 INFO - PROCESS | 14169 | 10:35:24 INFO - PROCESS | 14169 | [#0] dojo.html Cycles:165 Average:5689.89 Median:5946.85 stddev:653.34 (11.0%) stddev-sans-first:629.80 10:35:24 INFO - PROCESS | 14169 | Values: 3383.7 3420.8 3427.4 3444.1 3475.2 5696.5 5755.1 5768.6 5772.5 5778.9 5701.5 5726.2 5745.3 5751.8 5752.4 5002.6 5067.0 5074.2 5089.7 5113.1 4965.4 5153.7 5174.7 5176.9 5204.8 5003.1 5021.3 5076.0 5148.0 5164.3 5131.7 5148.9 5172.3 5174.7 5175.1 5045.4 5100.0 5135.5 5142.0 5177.3 5520.3 5534.8 5637.5 5708.1 5708.5 6148.1 6164.5 6176.0 6184.8 6191.6 6204.9 6214.9 6221.1 6221.8 6234.6 5581.6 5617.9 5675.2 5688.3 5815.5 6219.6 6245.2 6245.2 6257.1 6259.5 5964.7 6028.0 6037.2 6037.5 6038.2 5920.6 5962.4 6017.9 6146.5 6155.8 6111.6 6122.2 6143.4 6143.7 6147.8 5859.2 5909.2 5914.7 6118.7 6124.9 4649.4 4676.1 4687.0 4690.5 4754.8 4114.9 4209.0 4219.3 4234.4 4246.3 5871.0 5871.7 5912.9 5975.3 5993.5 6125.2 6149.1 6154.8 6156.5 6157.1 5943.2 5955.1 5960.6 5961.6 5963.4 5109.2 5142.7 5219.8 5265.7 5275.9 6490.9 6496.6 6499.1 6502.6 6502.7 6199.1 6211.3 6217.3 6218.4 6224.8 6120.7 6238.3 6255.7 6312.0 6345.6 6031.6 6032.8 6037.2 6041.2 6068.5 6121.6 6131.2 6133.1 6140.5 6142.3 5799.9 5827.0 5976.0 5990.8 6039.1 6066.8 6072.6 6080.5 6097.6 6112.7 5988.8 6045.8 6051.8 6053.2 6055.5 5797.7 5808.1 5864.3 5943.3 6078.8 5922.2 5931.9 5941.1 5946.9 5959.9 10:35:24 INFO - PROCESS | 14169 | 10:35:24 INFO - PROCESS | 14169 | [#1] ext.html Cycles:180 Average:44801.32 Median:30662.12 stddev:71421.27 (232.9%) stddev-sans-first:71544.93 10:35:24 INFO - PROCESS | 14169 | Values: 717.4 782.4 803.4 834.3 844.2 30684.0 43772.0 44633.0 47421.3 47622.8 44810.3 44908.3 44933.8 45000.0 45041.0 7738.6 7881.6 9201.9 9344.4 9346.5 10813.8 11040.0 11042.8 11043.6 11048.1 11036.3 11056.7 11065.7 11074.0 11082.9 10961.4 10984.6 10990.1 10994.2 11009.5 10557.8 10692.9 10696.0 10698.5 10711.6 41097.4 41280.4 41400.6 41405.6 41421.2 4150.6 4209.0 4245.4 4324.2 4352.9 30077.8 30585.8 30592.8 30640.2 31841.5 4351.6 4432.8 4441.3 4509.4 4526.3 237781.0 238918.0 239344.0 241764.0 242035.0 52158.0 52189.2 52300.7 52304.5 52393.0 55354.0 55831.4 55866.4 55869.4 55883.0 14059.0 14175.4 14267.8 14281.9 14305.6 12028.5 12030.5 13129.4 13212.8 14446.8 13576.9 13706.5 13711.4 13785.2 13787.6 5395.8 5454.2 5500.7 5517.6 5538.8 1020.0 1024.3 1027.3 1031.8 1032.3 27925.0 28066.9 28345.9 28397.0 28601.7 1099.0 1104.3 1116.2 1127.4 1140.5 14675.1 15165.2 15237.2 15416.3 15430.9 298881.0 299260.0 300335.0 300654.0 301421.0 57748.1 57784.4 57809.4 57935.1 58042.7 1502.4 1509.4 1531.5 1550.1 1556.6 26126.9 27345.0 27472.5 27508.4 27577.6 42681.4 42736.0 42856.8 42886.0 42949.4 278099.0 279174.0 279483.0 280200.0 280222.0 29799.3 30521.8 34283.3 35106.8 35226.5 44333.6 44598.3 44812.0 46061.3 46078.3 33675.0 33941.0 34019.0 34282.3 34343.8 32975.8 33089.5 33201.0 33571.5 33875.0 38860.6 39110.4 39223.0 39295.0 39650.2 31217.7 31274.4 31760.5 31806.5 31974.8 24918.3 25573.9 25895.5 26056.9 26289.9 10:35:24 INFO - PROCESS | 14169 | 10:35:24 INFO - PROCESS | 14169 | [#2] jquery.html Cycles:180 Average:30266.09 Median:12351.99 stddev:72012.69 (583.0%) stddev-sans-first:72179.94 10:35:24 INFO - PROCESS | 14169 | Values: 463.8 469.8 471.1 475.5 480.1 19257.4 20935.0 22131.8 22208.3 22460.6 21432.9 22074.7 22207.9 22317.2 22575.0 6474.7 6522.6 6736.8 6769.9 6794.6 6700.0 6759.4 6799.3 6801.7 6814.3 7196.0 7215.7 7223.5 7235.6 7239.1 7197.1 7268.9 7436.7 7470.3 7478.8 6599.5 6892.3 7271.4 7311.0 7317.5 25017.4 25058.2 25186.4 25418.2 25447.4 3191.3 3241.0 3276.1 3348.9 3357.8 15489.9 15908.2 16161.1 16288.4 16518.5 2186.0 2243.4 2276.3 2306.3 2322.1 115201.4 118397.4 118413.4 118936.4 120130.0 15990.4 16342.8 17037.8 18220.7 18589.2 30424.4 30713.2 30749.0 30749.4 30800.5 10215.4 10364.6 10486.8 10506.7 10529.7 8842.2 8916.1 8951.6 9098.6 9124.3 8842.5 8946.7 9114.2 9166.0 9365.3 3506.6 3636.9 3799.2 3856.3 3978.9 971.1 978.9 994.8 997.4 1001.9 20960.3 21239.3 21322.7 21469.8 21612.1 985.4 990.0 1005.9 1011.1 1015.4 11174.4 11516.3 11627.4 11637.0 11655.8 291503.0 293654.0 294380.0 484670.0 641339.0 79241.6 79886.6 109473.0 117432.7 122011.4 1096.3 1132.9 1138.2 1141.3 1296.5 18080.4 18938.2 19036.3 19053.7 19064.8 53158.7 53162.0 53538.7 53678.7 54147.0 60829.0 63055.7 71175.6 72012.6 73108.3 7588.3 10798.4 11747.8 12263.1 12369.8 14405.6 14433.4 14492.3 14555.7 14699.0 12065.9 12126.3 12187.3 12291.9 12334.3 11001.6 11243.6 11320.3 11333.3 11340.1 12214.7 12281.5 12343.8 13080.3 13199.2 12020.2 12052.3 12079.7 12138.9 12413.8 11894.9 12288.3 12455.2 12723.8 12832.3 10:35:24 INFO - PROCESS | 14169 | 10:35:24 INFO - PROCESS | 14169 | [#3] mootools.html Cycles:180 Average:7266.01 Median:2275.10 stddev:4663.88 (205.0%) stddev-sans-first:4656.21 10:35:24 INFO - PROCESS | 14169 | Values: 1409.7 1570.4 1576.3 1603.1 1605.3 9424.8 11204.9 11537.7 11838.5 11844.1 11610.4 11653.1 11677.3 11678.9 11698.8 2011.3 2073.2 2093.6 2350.5 2391.4 2030.6 2267.6 2343.9 2348.4 2363.8 2287.7 2292.7 2293.6 2294.1 2296.7 2234.6 2274.4 2275.8 2276.6 2279.9 2209.7 2257.1 2322.2 2327.9 2328.8 11455.5 11569.0 11578.2 11630.9 11708.0 5863.6 5967.9 6007.9 6012.0 6021.8 3554.9 3692.9 3786.8 3809.0 3817.2 1381.4 1389.9 1448.4 1476.5 1508.6 17440.4 17442.4 17550.6 17554.5 17557.4 4741.3 4955.1 4976.8 5011.0 5082.0 13608.4 13709.3 13751.8 13771.8 13778.6 6026.6 6121.6 6126.5 6126.6 6128.7 4566.5 5449.0 5482.9 5516.8 5533.6 3844.0 4149.7 4201.4 4292.3 4341.2 1171.6 1183.8 1185.0 1193.2 1199.5 1044.0 1053.2 1061.2 1064.6 1066.8 7068.9 7140.3 7197.7 7215.6 7239.0 1094.9 1111.5 1111.7 1121.4 1147.4 4812.0 4851.7 4870.5 4907.6 4972.9 14349.5 14835.3 14837.1 14850.7 14883.1 13803.9 14248.0 15056.5 15092.6 15095.1 10438.3 10637.6 10640.6 10704.8 10743.6 7244.5 7386.7 7547.4 7551.4 7667.1 13194.3 13209.9 13511.5 13552.8 13555.3 13570.3 13609.7 13618.0 13670.5 13856.7 9908.7 9996.5 10031.3 10078.5 10120.2 10854.0 10855.6 10993.1 10995.6 11050.6 9169.0 9315.8 9324.6 9374.4 9497.3 9095.4 9126.6 9137.2 9146.5 9284.8 8220.4 8550.3 8594.7 8725.0 8737.0 6539.6 6660.5 6677.1 6691.2 6744.4 6629.5 6636.7 6653.6 6706.2 6732.4 10:35:24 INFO - PROCESS | 14169 | 10:35:24 INFO - PROCESS | 14169 | [#4] prototype.html Cycles:180 Average:4773.35 Median:5284.26 stddev:1266.97 (24.0%) stddev-sans-first:1227.60 10:35:24 INFO - PROCESS | 14169 | Values: 416.8 423.2 432.3 441.7 448.2 5164.0 5228.7 5239.3 5246.9 5282.0 5044.1 5131.5 5162.6 5175.4 5199.5 4331.6 4336.6 4345.3 4352.5 4370.8 4359.5 4359.5 4381.4 4386.0 4414.7 4247.0 4254.2 4255.2 4299.6 4310.4 4254.7 4257.7 4282.8 4306.9 4308.0 4072.8 4087.0 4098.2 4102.7 4119.4 4925.3 5083.7 5095.1 5102.9 5134.8 5093.5 5119.2 5122.4 5129.5 5136.9 5467.8 5494.9 5514.7 5549.9 5551.5 4422.5 4525.7 4549.1 4580.9 4583.3 5411.7 5469.3 5594.6 5642.8 5723.5 4621.7 4644.3 4654.7 4662.8 4670.6 4538.0 4656.5 4681.4 4770.0 4804.2 4996.4 5025.9 5052.2 5092.4 5092.6 5451.0 5466.5 5470.4 5488.0 5523.9 1577.0 1625.7 1629.8 1649.9 1655.8 1241.2 1272.4 1280.9 1281.7 1297.4 5391.6 5410.3 5418.3 5437.9 5450.8 5645.4 5645.4 5650.7 5680.8 5748.2 5286.6 5403.6 5424.6 5437.7 5480.3 2969.4 2972.3 2975.6 2999.5 3010.5 5542.8 5670.3 5720.6 5790.5 5806.0 5647.9 5685.2 5695.6 5697.7 5726.7 5806.2 5807.0 5830.3 5838.3 5853.5 5302.3 5583.7 5606.9 5613.6 5620.2 5312.6 5386.9 5564.9 5570.7 5577.4 5760.0 5819.5 5832.6 5847.7 5852.9 4722.0 4737.5 4762.4 4792.6 4799.6 5389.6 5544.0 5588.5 5596.8 5656.6 5457.3 5473.6 5475.3 5484.9 5491.5 5316.5 5471.3 5481.4 5482.0 5522.4 5347.4 5401.9 5471.6 5480.7 5482.4 5445.4 5463.6 5478.6 5493.1 5581.9 5160.4 5324.8 5368.8 5399.7 5415.2 10:35:24 INFO - PROCESS | 14169 | 10:35:24 INFO - PROCESS | 14169 | [#5] yui.html Cycles:180 Average:18630.58 Median:25545.60 stddev:23070.81 (90.3%) stddev-sans-first:23096.78 10:35:24 INFO - PROCESS | 14169 | Values: 823.5 834.7 842.7 907.2 909.9 16419.5 17550.6 17581.6 18436.7 18781.4 15928.7 15958.4 16786.1 16805.2 17081.0 886.9 910.8 914.1 914.9 915.2 891.1 898.8 912.6 913.2 913.4 914.9 915.5 918.6 919.7 921.4 906.4 906.7 909.0 915.9 916.5 672.4 672.6 672.7 672.7 673.6 16762.6 16864.2 17048.5 18624.3 18851.5 15578.5 16005.4 16104.0 16212.4 16376.8 13885.9 14077.9 14086.2 14165.6 14173.7 4063.5 4098.3 4099.0 4110.5 4219.0 85353.1 86085.6 86151.6 87982.6 88564.1 12519.3 12596.7 12676.7 12769.8 12808.7 21591.2 24604.4 24636.5 24780.9 24888.0 9130.6 9183.0 9235.1 9288.3 9415.4 4520.4 4666.7 4687.2 5025.9 5092.7 3729.6 3831.1 3836.7 3838.7 3845.2 632.2 638.3 640.4 652.7 661.4 774.5 787.3 790.2 794.7 811.2 11280.2 11540.7 11650.1 11733.6 11896.5 830.5 836.6 846.8 855.1 863.1 5397.4 5494.2 5548.2 5558.2 5560.7 63520.0 63617.4 80722.6 80831.2 81923.0 56541.4 60018.1 71328.0 73028.3 74408.6 66862.7 67376.3 67834.7 67936.3 68742.7 10489.9 10601.4 10643.5 10811.3 10818.2 46570.8 47371.5 47735.8 48190.0 48374.0 55735.7 56596.7 56833.0 56840.4 57628.4 12633.0 12777.6 12885.6 12993.2 13173.2 14507.9 14516.3 14553.8 14646.9 14722.5 12296.8 12624.6 12656.7 12657.4 13059.5 13015.5 14045.5 14489.3 14974.9 15372.2 14488.6 14550.6 14551.6 15605.4 15916.4 11302.8 11780.4 12235.5 12563.9 12797.4 12336.6 12662.5 12757.9 12864.2 13511.5 10:35:24 INFO - PROCESS | 14169 | -------- Summary: end -------- 10:35:24 INFO - PROCESS | 14169 | 10:35:25 INFO - TEST-INFO | 14169: exit 0 10:35:25 INFO - TEST-OK | dromaeo_css | took 1115669ms 10:35:25 INFO - TEST-START | kraken 10:35:25 INFO - operating with platform_type : linux_ 10:35:25 INFO - Initialising browser for kraken test... 10:35:25 INFO - TEST-INFO | started process 14495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRXjavt/profile http://localhost:35662/getInfo.html) 10:35:29 INFO - PROCESS | 14495 | __metrics Screen width/height:1600/1200 10:35:29 INFO - PROCESS | 14495 | colorDepth:24 10:35:29 INFO - PROCESS | 14495 | Browser inner width/height: 1024/697 10:35:29 INFO - PROCESS | 14495 | __metrics 10:35:29 ERROR - PROCESS | 14495 | 1491413729926 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 10:35:30 INFO - PROCESS | 14495 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:35:30 INFO - PROCESS | 14495 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:30 INFO - TEST-INFO | 14495: exit 0 10:35:30 INFO - Browser initialized. 10:35:30 INFO - Running cycle 1/1 for kraken test... 10:35:30 INFO - TEST-INFO | started process 14586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRXjavt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:42 INFO - PROCESS | 14586 | RSS: Main: 139681792 10:35:42 INFO - PROCESS | 14586 | 10:35:45 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35662/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:46 INFO - PROCESS | 14586 | RSS: Main: 183730176 10:35:46 INFO - PROCESS | 14586 | 10:35:48 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35662/tests/kraken/driver.html?testName=audio-dft) 10:35:49 INFO - PROCESS | 14586 | RSS: Main: 173801472 10:35:49 INFO - PROCESS | 14586 | 10:35:52 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35662/tests/kraken/driver.html?testName=audio-fft) 10:35:52 INFO - PROCESS | 14586 | RSS: Main: 265670656 10:35:52 INFO - PROCESS | 14586 | 10:35:54 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35662/tests/kraken/driver.html?testName=audio-oscillator) 10:35:55 INFO - PROCESS | 14586 | RSS: Main: 172134400 10:35:55 INFO - PROCESS | 14586 | 10:35:57 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:58 INFO - PROCESS | 14586 | RSS: Main: 174129152 10:35:58 INFO - PROCESS | 14586 | 10:36:00 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35662/tests/kraken/driver.html?testName=imaging-darkroom) 10:36:01 INFO - PROCESS | 14586 | RSS: Main: 212934656 10:36:01 INFO - PROCESS | 14586 | 10:36:04 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35662/tests/kraken/driver.html?testName=imaging-desaturate) 10:36:05 INFO - PROCESS | 14586 | RSS: Main: 211824640 10:36:05 INFO - PROCESS | 14586 | 10:36:08 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35662/tests/kraken/driver.html?testName=json-parse-financial) 10:36:08 INFO - PROCESS | 14586 | RSS: Main: 210530304 10:36:08 INFO - PROCESS | 14586 | 10:36:10 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:36:11 INFO - PROCESS | 14586 | RSS: Main: 173195264 10:36:11 INFO - PROCESS | 14586 | 10:36:12 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35662/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:36:13 INFO - PROCESS | 14586 | RSS: Main: 180404224 10:36:13 INFO - PROCESS | 14586 | 10:36:15 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:15 INFO - PROCESS | 14586 | RSS: Main: 189394944 10:36:15 INFO - PROCESS | 14586 | 10:36:18 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:19 INFO - PROCESS | 14586 | RSS: Main: 198316032 10:36:19 INFO - PROCESS | 14586 | 10:36:21 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:22 INFO - PROCESS | 14586 | RSS: Main: 195067904 10:36:22 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | Cycle 1(1): loaded http://localhost:35662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35662/tests/kraken/driver.html?testName=ai-astar) 10:36:24 INFO - PROCESS | 14586 | RSS: Main: 246947840 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | __start_tp_report 10:36:24 INFO - PROCESS | 14586 | _x_x_mozilla_page_load 10:36:24 INFO - PROCESS | 14586 | _x_x_mozilla_page_load_details 10:36:24 INFO - PROCESS | 14586 | |i|pagename|runs| 10:36:24 INFO - PROCESS | 14586 | |0;ai-astar;106;114;113;114;114;112;111;112;111;114 10:36:24 INFO - PROCESS | 14586 | |1;audio-beat-detection;137;115;114;158;119;117;116;119;137;118 10:36:24 INFO - PROCESS | 14586 | |2;audio-dft;160;160;160;161;163;160;161;160;162;160 10:36:24 INFO - PROCESS | 14586 | |3;audio-fft;75;76;74;110;76;76;76;76;99;75 10:36:24 INFO - PROCESS | 14586 | |4;audio-oscillator;82;83;102;83;82;82;110;81;82;103 10:36:24 INFO - PROCESS | 14586 | |5;imaging-gaussian-blur;113;113;113;112;113;112;113;112;113;113 10:36:24 INFO - PROCESS | 14586 | |6;imaging-darkroom;147;146;146;146;146;147;147;146;146;146 10:36:24 INFO - PROCESS | 14586 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;94;94 10:36:24 INFO - PROCESS | 14586 | |8;json-parse-financial;58;56;56;61;56;56;56;56;56;55 10:36:24 INFO - PROCESS | 14586 | |9;json-stringify-tinderbox;54;54;54;53;54;53;53;54;54;54 10:36:24 INFO - PROCESS | 14586 | |10;stanford-crypto-aes;75;76;76;75;84;81;75;76;78;75 10:36:24 INFO - PROCESS | 14586 | |11;stanford-crypto-ccm;128;125;119;121;130;121;117;132;159;122 10:36:24 INFO - PROCESS | 14586 | |12;stanford-crypto-pbkdf2;161;164;161;161;161;158;160;162;162;160 10:36:24 INFO - PROCESS | 14586 | |13;stanford-crypto-sha256-iterative;61;61;61;60;60;60;62;59;59;60 10:36:24 INFO - PROCESS | 14586 | __end_tp_report 10:36:24 INFO - PROCESS | 14586 | __start_cc_report 10:36:24 INFO - PROCESS | 14586 | _x_x_mozilla_cycle_collect,1671 10:36:24 INFO - PROCESS | 14586 | __end_cc_report 10:36:24 INFO - PROCESS | 14586 | __startTimestamp1491413784380__endTimestamp 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | ------- Summary: start ------- 10:36:24 INFO - PROCESS | 14586 | Number of tests: 14 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:2.47 (2.2%) stddev-sans-first:1.30 10:36:24 INFO - PROCESS | 14586 | Values: 106.0 114.0 113.0 114.0 114.0 112.0 111.0 112.0 111.0 114.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:119.00 stddev:14.39 (12.1%) stddev-sans-first:14.59 10:36:24 INFO - PROCESS | 14586 | Values: 137.0 115.0 114.0 158.0 119.0 117.0 116.0 119.0 137.0 118.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 10:36:24 INFO - PROCESS | 14586 | Values: 160.0 160.0 160.0 161.0 163.0 160.0 161.0 160.0 162.0 160.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.52 (16.5%) stddev-sans-first:13.07 10:36:24 INFO - PROCESS | 14586 | Values: 75.0 76.0 74.0 110.0 76.0 76.0 76.0 76.0 99.0 75.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:11.24 (13.7%) stddev-sans-first:11.64 10:36:24 INFO - PROCESS | 14586 | Values: 82.0 83.0 102.0 83.0 82.0 82.0 110.0 81.0 82.0 103.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:36:24 INFO - PROCESS | 14586 | Values: 113.0 113.0 113.0 112.0 113.0 112.0 113.0 112.0 113.0 113.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 10:36:24 INFO - PROCESS | 14586 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:36:24 INFO - PROCESS | 14586 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:1.71 (3.1%) stddev-sans-first:1.74 10:36:24 INFO - PROCESS | 14586 | Values: 58.0 56.0 56.0 61.0 56.0 56.0 56.0 56.0 56.0 55.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#9] json-stringify-tinderbox Cycles:10 Average:53.70 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 10:36:24 INFO - PROCESS | 14586 | Values: 54.0 54.0 54.0 53.0 54.0 53.0 53.0 54.0 54.0 54.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.00 stddev:3.07 (4.0%) stddev-sans-first:3.16 10:36:24 INFO - PROCESS | 14586 | Values: 75.0 76.0 76.0 75.0 84.0 81.0 75.0 76.0 78.0 75.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:126.50 stddev:12.12 (9.6%) stddev-sans-first:12.85 10:36:24 INFO - PROCESS | 14586 | Values: 128.0 125.0 119.0 121.0 130.0 121.0 117.0 132.0 159.0 122.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:1.56 (1.0%) stddev-sans-first:1.66 10:36:24 INFO - PROCESS | 14586 | Values: 161.0 164.0 161.0 161.0 161.0 158.0 160.0 162.0 162.0 160.0 10:36:24 INFO - PROCESS | 14586 | 10:36:24 INFO - PROCESS | 14586 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.50 stddev:0.95 (1.6%) stddev-sans-first:0.97 10:36:24 INFO - PROCESS | 14586 | Values: 61.0 61.0 61.0 60.0 60.0 60.0 62.0 59.0 59.0 60.0 10:36:24 INFO - PROCESS | 14586 | -------- Summary: end -------- 10:36:24 INFO - PROCESS | 14586 | 10:36:25 INFO - TEST-INFO | 14586: exit 0 10:36:25 INFO - TEST-OK | kraken | took 60378ms 10:36:25 INFO - SUITE-END | took 1176s 10:36:25 INFO - Completed test suite (00:19:36) 10:36:25 INFO - javascript benchmark 10:36:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7827.688098148043, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3383.7123844473217, 3420.8460619272137, 3427.383071047212, 3444.1045328214655, 3475.200703838117, 5696.458836410539, 5755.079187330028, 5768.596198266123, 5772.538196944245, 5778.913316300248, 5701.543876489881, 5726.226959360485, 5745.2818397700285, 5751.827445176641, 5752.36723960364, 5002.574781143607, 5067.0, 5074.2388641703765, 5089.720065396402, 5113.054084994288, 4965.379327584052, 5153.6907785532985, 5174.741262936838, 5176.948230517684, 5204.843854684365, 5003.074431230216, 5021.27191557224, 5075.9746201268945, 5148.0, 5164.328637277149, 5131.666441681297, 5148.948510514903, 5172.250023746573, 5174.689518628857, 5175.146100893348, 5045.369328833895, 5100.0, 5135.537801597874, 5142.04872098663, 5177.275181474596, 5520.282363292747, 5534.806281780158, 5637.46444087811, 5708.058170401879, 5708.543316534668, 6148.077788331741, 6164.506839452833, 6176.011838105882, 6184.84537886552, 6191.628502289877, 6204.906926396107, 6214.906776398358, 6221.097940798604, 6221.844453888643, 6234.563580549363, 5581.609287349887, 5617.859553511154, 5675.2054712340305, 5688.345840228344, 5815.505682017034, 6219.595726277777, 6245.156903818017, 6245.188125543741, 6257.0614407838275, 6259.530535209878, 5964.671943043088, 6028.035514317776, 6037.184980027728, 6037.516998640098, 6038.184845045863, 5920.615160014671, 5962.433568810956, 6017.879642407215, 6146.5390095743, 6155.84610384735, 6111.552992642655, 6122.173506576644, 6143.385661433821, 6143.723532441051, 6147.754089836446, 5859.1797148399255, 5909.23179986599, 5914.704264786744, 6118.718276956224, 6124.910294234916, 4649.418822647169, 4676.134915040729, 4686.976565117221, 4690.460597031317, 4754.833580824655, 4114.917701645951, 4209.0, 4219.324908014764, 4234.407182994383, 4246.256905041667, 5871.031279838779, 5871.677057761779, 5912.881742365129, 5975.342712301644, 5993.490553303018, 6125.1731016313115, 6149.0776383542825, 6154.815355539341, 6156.476699480505, 6157.076438534255, 5943.167956486095, 5955.106733989936, 5960.642361458326, 5961.552883533753, 5963.403659634002, 5109.182530795129, 5142.665726727751, 5219.765110570033, 5265.657732247391, 5275.868103297372, 6490.935090649127, 6496.642684652201, 6499.09012738217, 6502.642354670538, 6502.739890404426, 6199.132121503083, 6211.316755156839, 6217.347178546368, 6218.440340369389, 6224.751009959732, 6120.690942951019, 6238.282597501346, 6255.749770009149, 6312.0, 6345.555811093179, 6031.638101713911, 6032.788852390146, 6037.215162028908, 6041.214642096499, 6068.544859135494, 6121.632702037892, 6131.202943617302, 6133.110698948538, 6140.539459540463, 6142.293636231891, 5799.942000580109, 5827.0, 5976.043832986701, 5990.820275391745, 6039.063945088518, 6066.787662431971, 6072.635641861502, 6080.513558915188, 6097.603655762361, 6112.724927378367, 5988.847528068107, 6045.848853778691, 6051.788187413596, 6053.182820319201, 6055.5458340623745, 5797.710114494343, 5808.07070868659, 5864.296284445893, 5943.316518600416, 6078.848028799315, 5922.170896074639, 5931.9406805931385, 5941.079132734433, 5946.851328716817, 5959.91060134107], "value": 5646.394964397341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.3615482220824, 782.4131901074194, 803.3613277444433, 834.3075247544539, 844.1853611265136, 30684.0, 43772.0, 44633.0, 47421.288680669815, 47622.76188619052, 44810.32784508235, 44908.3263751044, 44933.77533112338, 45000.0, 45041.0, 7738.613069346538, 7881.645325960317, 9201.907980920188, 9344.392614480072, 9346.485943273117, 10813.83779243312, 11040.0, 11042.779144417107, 11043.558257669683, 11048.116150707965, 11036.282641628308, 11056.723581910477, 11065.723356916102, 11074.0, 11082.944585277062, 10961.397123158224, 10984.560617575287, 10990.065844403236, 10994.175436842188, 11009.504572294267, 10557.841632375521, 10692.893071069268, 10696.0, 10698.51856666452, 10711.625093121704, 41097.383539246934, 41280.38079428811, 41400.585994139976, 41405.585944140475, 41421.1715765686, 4150.64719498843, 4209.0, 4245.448091748084, 4324.178406102862, 4352.89117772055, 30077.849610752026, 30585.847070764725, 30592.84703576468, 30640.2339941501, 31841.52237716413, 4351.608355248043, 4432.756198409086, 4441.267190913495, 4509.391232183646, 4526.275795872678, 237781.0, 238918.0, 239344.0, 241763.99999999825, 242035.0, 52158.0, 52189.21716174261, 52300.73849630728, 52304.47695522996, 52393.0, 55354.0, 55831.441685583435, 55866.44133558694, 55869.44130558642, 55883.0, 14059.0, 14175.432982680784, 14267.78598321026, 14281.857181428053, 14305.57083287503, 12028.458719357475, 12030.4586293617, 13129.409176587076, 13212.801807972888, 14446.783298250535, 13576.864231357758, 13706.451741930212, 13711.382987765575, 13785.172889626654, 13787.586372408843, 5395.81114660985, 5454.181872719124, 5500.669959802424, 5517.586181036439, 5538.833834984876, 1020.0411613083678, 1024.293237666008, 1027.3476342522551, 1031.8452232165234, 1032.2774058159318, 27925.0, 28066.85966570154, 28345.858270708926, 28397.0, 28601.71398286032, 1098.9505472253768, 1104.2546281260277, 1116.17403121691, 1127.4193790198055, 1140.5437824870119, 14675.119492830465, 15165.165915874511, 15237.238138093051, 15416.306266217824, 15430.922845385701, 298881.0, 299260.0, 300335.0, 300654.0, 301421.0, 57748.13377799336, 57784.422155778746, 57809.421905781244, 57935.13097303544, 58042.709786450796, 1502.3990403838334, 1509.433962264151, 1531.509916826627, 1550.0777037662572, 1556.6497538054073, 26126.86936565305, 27345.0, 27472.45055098927, 27508.44983100287, 27577.586336205375, 42681.359779603954, 42736.0, 42856.78571607122, 42886.0, 42949.35575966426, 278099.0, 279174.0, 279483.0, 280200.0, 280222.0, 29799.25501862384, 30521.847390763793, 34283.314333713686, 35106.82446587751, 35226.47160292649, 44333.556664432945, 44598.331025034, 44812.0, 46061.30908036449, 46078.30882536698, 33675.0, 33940.981770545935, 34019.0, 34282.314353713286, 34343.797967071034, 32975.835120824246, 33089.50365744564, 33201.0, 33571.49642755312, 33875.0, 38860.61139388683, 39110.41334379929, 39223.0, 39295.0, 39650.2069958605, 31217.68782312148, 31274.374512510076, 31760.523592146597, 31806.52290215695, 31974.840125800154, 24918.252452426455, 25573.87213063923, 25895.48209035771, 26056.8697156513, 26289.868550657124], "value": 18970.990365134774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.7727513518376, 469.7721605021566, 471.0954966464388, 475.453228786895, 480.10939706843806, 19257.422277331683, 20935.0, 22131.778682213175, 22208.333749987487, 22460.550788984212, 21432.8928355358, 22074.66887996681, 22207.888960555174, 22317.218897338596, 22575.0, 6474.676266186695, 6522.641254730988, 6736.797896063126, 6769.932300677004, 6794.592324460524, 6700.028495868096, 6759.425448836831, 6799.320067993211, 6801.6599170041545, 6814.3185681431705, 7196.0, 7215.711371545131, 7223.458240631948, 7235.565866048028, 7239.095113110861, 7197.136343638745, 7268.854622907539, 7436.702531898744, 7470.252974702541, 7478.775636730907, 6599.5380323377385, 6892.310768923117, 7271.381932535741, 7311.0, 7317.524360916524, 25017.374565635822, 25058.248252552272, 25186.370340741443, 25418.237452876445, 25447.363815904566, 3191.3457741163006, 3240.951385729216, 3276.0826968448873, 3348.8995330140133, 3357.8321083945707, 15489.922550387177, 15908.204589770581, 16161.111138887356, 16288.42990495327, 16518.504444866674, 2185.967210491844, 2243.4279258789065, 2276.3284830974903, 2306.308107567723, 2322.1175953137868, 115201.42399288034, 118397.40801296025, 118413.40793295979, 118936.40531797285, 120130.0, 15990.440334588233, 16342.832577692612, 17037.829621703873, 18220.726689099673, 18589.163487643087, 30424.391512170074, 30713.232169195948, 30749.0, 30749.38501229963, 30800.537991930138, 10215.387076775418, 10364.585416583252, 10486.790264194673, 10506.684799456028, 10529.736431628253, 8842.159994800484, 8916.089961124891, 8951.597178127, 9098.636054557875, 9124.315676324302, 8842.46945183291, 8946.731598052069, 9114.179723824887, 9166.0, 9365.344425890122, 3506.5967413747235, 3636.890893273206, 3799.2021675448464, 3856.267309211241, 3978.8806335809973, 971.0871780526282, 978.9167920726818, 994.8408254679216, 997.4464172384252, 1001.8647482589903, 20960.26639067656, 21239.256626018323, 21322.680159797615, 21469.78530214709, 21612.135514579557, 985.3989066669326, 989.9901000989898, 1005.9497025148713, 1011.0597144655541, 1015.4364327798143, 11174.44127793607, 11516.309021458572, 11627.418629068512, 11636.99609168066, 11655.76688466226, 291503.0, 293654.0, 294380.0, 484670.0, 641339.0, 79241.60379198067, 79886.6005669968, 109473.0, 117432.71552780145, 122011.38994305149, 1096.3421946831998, 1132.881047490018, 1138.1975707126455, 1141.3095077478172, 1296.4554886947317, 18080.367187148386, 18938.242470301586, 19036.33372831944, 19053.71419428682, 19064.809351906304, 53158.73420632872, 53162.0, 53538.73230633978, 53678.73160634172, 54147.0, 60829.0, 63055.6847215761, 71175.64412177906, 72012.63993679998, 73108.26891731228, 7588.27911348421, 10798.352098874093, 11747.823782643096, 12263.141580089308, 12369.814452783396, 14405.63985900319, 14433.422663093359, 14492.34784434682, 14555.708885822436, 14699.0, 12065.879341206475, 12126.272423654256, 12187.268763874195, 12291.877081229073, 12334.32161231105, 11001.61494347694, 11243.60647377338, 11320.320780753182, 11333.320000799979, 11340.149488788209, 12214.694632634255, 12281.508739650671, 12343.75312493763, 13080.345982701017, 13199.20804751718, 12020.218685785396, 12052.337121458404, 12079.698007549881, 12138.939305303771, 12413.75172496527, 11894.940525297665, 12288.262704237774, 12455.190412623151, 12723.80914286305, 12832.294223817406], "value": 11276.822270021008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.6546346145196, 1570.3561539768693, 1576.3458164861584, 1603.1423188594104, 1605.2776250687193, 9424.81150376992, 11204.943975280123, 11537.653870383881, 11838.467268972896, 11844.11169162312, 11610.419479026057, 11653.067754579635, 11677.299362038262, 11678.941605291982, 11698.766024679502, 2011.3463124484529, 2073.1810934680866, 2093.5812837432572, 2350.49464365161, 2391.4141035446255, 2030.5837303352778, 2267.614505534063, 2343.906243750248, 2348.4481146930457, 2363.822713296501, 2287.714035745532, 2292.713410823647, 2293.6100862853355, 2294.105298933417, 2296.6555016747457, 2234.597772400967, 2274.374546999572, 2275.8179345652306, 2276.6243569810963, 2279.886005699708, 2209.7016902718087, 2257.052038143967, 2322.222055611372, 2327.918522851709, 2328.7904088631935, 11455.484503197376, 11569.016633586156, 11578.247413918069, 11630.883691163064, 11708.0, 5863.560232982543, 5967.940320596782, 6007.879842403171, 6012.0, 6021.819345419601, 3554.9466757998393, 3692.9446058309145, 3786.848526058954, 3808.980955095207, 3817.2174704185577, 1381.405995421968, 1389.8957578181678, 1448.3627204030192, 1476.4906107392933, 1508.5549762819994, 17440.389586364417, 17442.389516366995, 17550.648987020188, 17554.473365799047, 17557.385491507735, 4741.2651039089, 4955.132851750929, 4976.825811096594, 5010.974945125324, 5082.0, 13608.387622556811, 13709.314534273446, 13751.793723094162, 13771.793423098661, 13778.586642400744, 6026.578139530278, 6121.602095863755, 6126.479249263863, 6126.571140020156, 6128.693565321716, 4566.474855391606, 5448.991936491761, 5482.945170548243, 5516.779328826802, 5533.6403133796175, 3843.9615603844163, 4149.7095203335475, 4201.432806571135, 4292.313229883203, 4341.19687857741, 1171.6133675886938, 1183.798754211786, 1184.9585264515702, 1193.2244041373176, 1199.5321824488456, 1044.0, 1053.2153545608571, 1061.2359101446946, 1064.6060957445795, 1066.8186408310605, 7068.858622827514, 7140.250273721288, 7197.71209151628, 7215.639218039077, 7238.963805180941, 1094.8795632480421, 1111.5053801058614, 1111.7220694826294, 1121.4448847820381, 1147.386148410613, 4811.9518804811505, 4851.684640498356, 4870.537298956593, 4907.631927605373, 4972.8756781080765, 14349.497767578085, 14835.258237088103, 14837.10977341363, 14850.702985940437, 14883.10701357922, 13803.930980345034, 14248.0, 15056.548303550911, 15092.622684432978, 15095.094294342374, 10438.269321147447, 10637.627683031056, 10640.627578034577, 10704.839427408595, 10743.570257189782, 7244.529105608119, 7386.667599957907, 7547.396208303213, 7551.395888329031, 7667.11828139771, 13194.340282986004, 13209.867901320864, 13511.527096551574, 13552.796708049584, 13555.254461004739, 13570.321483925962, 13609.659758506117, 13618.0, 13670.52153174634, 13856.653583660489, 9908.653197138066, 9996.45019523904, 10031.29780915329, 10078.546465409221, 10120.240981926532, 10854.0, 10855.620053298097, 10993.120550355792, 10995.615153469591, 11050.557977680803, 9169.0, 9315.813683726423, 9324.627014919328, 9374.437533747998, 9497.335186536877, 9095.363324567217, 9126.589303481227, 9137.177654011171, 9146.542672866197, 9284.814303713752, 8220.383471239562, 8550.273226775793, 8594.65621375138, 8724.956375218084, 8737.0, 6539.574927629689, 6660.467162627075, 6677.131972843499, 6691.197056353269, 6744.426723728538, 6629.4696424284975, 6636.734530618721, 6653.567518111307, 6706.228783689938, 6732.42774364165], "value": 5480.835232328405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.79961710274404, 423.20226373286346, 432.30399057517394, 441.701851250406, 448.15299084729844, 5163.974180129098, 5228.692826793302, 5239.345081864767, 5246.8688282792855, 5281.973590132049, 5044.117279476086, 5131.486851314867, 5162.638615296931, 5175.351377279018, 5199.506046925546, 4331.631811296043, 4336.566343365662, 4345.348197770328, 4352.542982986788, 4370.759608221547, 4359.455068116486, 4359.542248063955, 4381.386605875164, 4385.978070109645, 4414.668899832525, 4247.0, 4254.191703576326, 4255.212785634668, 4299.613034826881, 4310.396544483775, 4254.744715317075, 4257.743965530176, 4282.785860706952, 4306.892327691833, 4308.0, 4072.8188825240645, 4086.979565102185, 4098.241825262336, 4102.651274641659, 4119.402686610425, 4925.3350797642215, 5083.669561478492, 5095.133827249377, 5102.902875881666, 5134.845954621367, 5093.5415812576675, 5119.2321151827155, 5122.3853137623355, 5129.461406552333, 5136.922946155811, 5467.781288748485, 5494.917576236359, 5514.6691198527815, 5549.889002219933, 5551.528120109796, 4422.491413487426, 4525.6649288459985, 4549.09018196362, 4580.908381832378, 4583.3125031245245, 5411.675299482044, 5469.343678758534, 5594.636348637367, 5642.830715078554, 5723.51350135239, 4621.653375996813, 4644.256918892961, 4654.743989080633, 4662.813487460531, 4670.579647831712, 4537.977310113428, 4656.534346565317, 4681.414823147106, 4770.0, 4804.231322988305, 4996.4254110777, 5025.899482010339, 5052.242163675404, 5092.414372347153, 5092.567131793765, 5451.0, 5466.480684334982, 5470.398256191816, 5487.972560137174, 5523.861903452445, 1576.9763453548205, 1625.6504851456757, 1629.8370162983606, 1649.935791414531, 1655.8391299354219, 1241.211830487647, 1272.41468924294, 1280.8527019392702, 1281.7180220351509, 1297.4495477904004, 5391.595630327663, 5410.296661433988, 5418.295621569171, 5437.864053398696, 5450.809221677222, 5645.4072322405555, 5645.407232240637, 5650.689212093293, 5680.829575112753, 5748.223989761329, 5286.5506431952945, 5403.594730395236, 5424.613170205176, 5437.694953211201, 5480.26016487777, 2969.426204111824, 2972.316367235548, 2975.598294230251, 2999.475091858916, 3010.473167195732, 5542.780588270574, 5670.314295707741, 5720.597349113383, 5790.478856902815, 5805.970970145207, 5647.915281270784, 5685.204071430003, 5695.629784064023, 5697.686627235459, 5726.742296596663, 5806.2451881255165, 5806.983777838946, 5830.271216097988, 5838.314375387369, 5853.473187413153, 5302.250257414967, 5583.664980101207, 5606.85982850432, 5613.578981576316, 5620.241267428844, 5312.574994000393, 5386.892262154814, 5564.888702225851, 5570.721463926707, 5577.358603760457, 5760.0, 5819.476247137778, 5832.562557808266, 5847.736851841592, 5852.912206316823, 4721.976390118165, 4737.455192652889, 4762.4285085789925, 4792.634099281688, 4799.568038876518, 5389.568834493152, 5543.972280138573, 5588.469095435927, 5596.832095037155, 5656.585853536616, 5457.317835270591, 5473.616846820684, 5475.288212532345, 5484.917726234189, 5491.450854914477, 5316.521513063843, 5471.261379713687, 5481.369642491165, 5482.0, 5522.420145884785, 5347.411784703757, 5401.921549230306, 5471.6169868108855, 5480.72596370172, 5482.423261067292, 5445.373782015119, 5463.590230732631, 5478.589105817, 5493.0998990717035, 5581.916271255853, 5160.380754309507, 5324.840254792362, 5368.7852485901685, 5399.676019438846, 5415.214793854948], "value": 4409.452793540617, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.5001244709982, 834.7245409015026, 842.6629348260695, 907.224323203661, 909.9226565741911, 16419.50741477756, 17550.648987020253, 17581.560460988483, 18436.723449148274, 18781.43655690328, 15928.681426371466, 15958.361665533394, 16786.076765777878, 16805.159742012882, 17081.0, 886.8891388576444, 910.7859652981545, 914.1041779056528, 914.8536234202529, 915.244922938575, 891.1222445890793, 898.8292224477361, 912.5938957164065, 913.159892898535, 913.4336711239008, 914.8856392950881, 915.5010519267015, 918.5774543709869, 919.6965001549506, 921.3688623293032, 906.4289497616526, 906.714384968736, 909.0455022226636, 915.9496227707474, 916.4867674102524, 672.4250765595394, 672.5930811858804, 672.6804767735335, 672.7140965089866, 673.639602812493, 16762.580935476588, 16864.241109150116, 17048.48854534366, 18624.348147814897, 18851.52871178218, 15578.454754083552, 16005.439809606607, 16104.0, 16212.351505939749, 16376.83623163765, 13885.930570347185, 14077.929610351883, 14086.15483071019, 14165.575032749033, 14173.71652566943, 4063.5326937401987, 4098.282800509899, 4099.036726369301, 4110.46563946688, 4219.0, 85353.14646853576, 86085.56957215237, 86151.56924215402, 87982.56008719979, 88564.11435885688, 12519.311437871005, 12596.685082872818, 12676.69314890181, 12769.808452873214, 12808.743825123633, 21591.2443064492, 24604.384890377885, 24636.5072698545, 24780.876095619766, 24888.0, 9130.634774609074, 9182.954085229665, 9235.07649235071, 9288.34981551285, 9415.435073895589, 4520.434945631796, 4666.673332866734, 4687.179743544866, 5025.899482010339, 5092.719900405439, 3729.5524537055726, 3831.099691572478, 3836.712246581518, 3838.654521093115, 3845.2117315950723, 632.1781683811028, 638.3201889987149, 640.3532432243375, 652.6834485274638, 661.3915198017835, 774.5352788327071, 787.330768846476, 790.2334735306744, 794.7417089445953, 811.1888111888112, 11280.210385273116, 11540.711482212844, 11650.126240531994, 11733.647990560297, 11896.464659090361, 830.4975489828687, 836.5649862071689, 846.7925358287259, 855.1234984141305, 863.0851297624413, 5397.35231772182, 5494.203340515603, 5548.223248745179, 5558.249636299129, 5560.694161821139, 63520.0, 63617.36382636207, 80722.5963870177, 80831.19168808355, 81923.0, 56541.43458565444, 60018.09972850411, 71328.0, 73028.26971730214, 74408.62795685987, 66862.66568667126, 67376.32623673798, 67834.66082669554, 67936.320636793, 68742.65628671924, 10489.895101048893, 10601.41692206936, 10643.521041553304, 10811.297265677706, 10818.1886358525, 46570.76714616405, 47371.52628473671, 47735.761321193175, 48190.0, 48374.0, 55735.72132139313, 56596.71701641465, 56833.0, 56840.43159568351, 57628.42371576231, 12633.0, 12777.552785652457, 12885.613431597067, 12993.155444896052, 13173.209607423585, 14507.854921451073, 14516.346764395415, 14553.781693274397, 14646.901482389076, 14722.484713034992, 12296.75406491883, 12624.621261362174, 12656.6835829105, 12657.367131643565, 13059.477620895057, 13015.47938082504, 14045.508407205698, 14489.347979341166, 14974.85025149778, 15372.23138843031, 14488.565343039725, 14550.563483095524, 14551.563453096423, 15605.375784968473, 15916.363345466514, 11302.773944520899, 11780.410979450822, 12235.510579576718, 12563.93718031404, 12797.36013199355, 12336.642969273193, 12662.493500260254, 12757.872421276039, 12864.22814631125, 13511.459541618226], "value": 7879.2225844783015, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 114.0, 114.0, 112.0, 111.0, 112.0, 111.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 115.0, 114.0, 158.0, 119.0, 117.0, 116.0, 119.0, 137.0, 118.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 163.0, 160.0, 161.0, 160.0, 162.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 110.0, 76.0, 76.0, 76.0, 76.0, 99.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 102.0, 83.0, 82.0, 82.0, 110.0, 81.0, 82.0, 103.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 61.0, 56.0, 56.0, 56.0, 56.0, 56.0, 55.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 75.0, 84.0, 81.0, 75.0, 76.0, 78.0, 75.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 119.0, 121.0, 130.0, 121.0, 117.0, 132.0, 159.0, 122.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 161.0, 161.0, 158.0, 160.0, 162.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 62.0, 59.0, 59.0, 60.0], "value": 60.3, "unit": "score"}]}]} 10:36:25 INFO - Return code: 0 10:36:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:36:25 ERROR - # TBPL SUCCESS # 10:36:25 INFO - Running post-action listener: _resource_record_post_action 10:36:25 INFO - [mozharness: 2017-04-05 17:36:25.718324Z] Finished run-tests step (success) 10:36:25 INFO - Running post-run listener: _resource_record_post_run 10:36:25 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366485504; Read time: 36; Write time: 297076 10:36:25 INFO - TinderboxPrint: CPU usage
13.1% 10:36:25 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 10:36:25 INFO - TinderboxPrint: I/O write bytes / time
366,485,504 / 297,076 10:36:25 INFO - TinderboxPrint: CPU idle
8,271.7 (86.9%) 10:36:25 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 10:36:25 INFO - TinderboxPrint: Swap in / out
0 / 0 10:36:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110481408; Read time: 0; Write time: 110092 10:36:25 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 256004096; Read time: 36; Write time: 186984 10:36:26 INFO - Running post-run listener: _upload_blobber_files 10:36:26 INFO - Blob upload gear active. 10:36:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:36:26 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:36:26 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:36:26 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:36:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:36:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:27 INFO - (blobuploader) - INFO - Done attempting. 10:36:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:36:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:28 INFO - (blobuploader) - INFO - Done attempting. 10:36:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:36:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:31 INFO - (blobuploader) - INFO - Done attempting. 10:36:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:36:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:36:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:32 INFO - (blobuploader) - INFO - Done attempting. 10:36:32 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:32 INFO - Return code: 0 10:36:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/09cbd55eb6568b8627d3e900e79ccc8141d2f2be55f7819e1d5f70486fa8f55cfb06141f2b42db3455d4dde9f53060c705d3b56f70ed0eaae8bed59cf3e6c47f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aafac57ade5dfbef11b3721283a8fc4146c659db4be5359fd51489834f9ecb8c2ed1f9fd1cdd4193af3233d39622421a16dc27dc48ad238b752b27a933deda6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3573e068b6ab4d46a7f2bad2d83a5aadbe3918b681b6ba23231df629a8faa5bd60a7f2314ce4e19d8440c2b4cb014da0eadd5e9cef9449048d8b637fa53fefb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/721f5e86046c07a8a6a9a5ba85ed69c81aa994b1a4b63039656664941cfec2da2d917d4343936fb9667346c5b1e1bc3d2fe366833a83840bc186f38ea904795d"} 10:36:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:32 INFO - Contents: 10:36:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/09cbd55eb6568b8627d3e900e79ccc8141d2f2be55f7819e1d5f70486fa8f55cfb06141f2b42db3455d4dde9f53060c705d3b56f70ed0eaae8bed59cf3e6c47f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aafac57ade5dfbef11b3721283a8fc4146c659db4be5359fd51489834f9ecb8c2ed1f9fd1cdd4193af3233d39622421a16dc27dc48ad238b752b27a933deda6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3573e068b6ab4d46a7f2bad2d83a5aadbe3918b681b6ba23231df629a8faa5bd60a7f2314ce4e19d8440c2b4cb014da0eadd5e9cef9449048d8b637fa53fefb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/721f5e86046c07a8a6a9a5ba85ed69c81aa994b1a4b63039656664941cfec2da2d917d4343936fb9667346c5b1e1bc3d2fe366833a83840bc186f38ea904795d"} 10:36:32 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:32 INFO - Copying logs to upload dir... 10:36:32 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.167861 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-05 10:36:32.214168) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 10:36:32.218161) ========= 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=836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/09cbd55eb6568b8627d3e900e79ccc8141d2f2be55f7819e1d5f70486fa8f55cfb06141f2b42db3455d4dde9f53060c705d3b56f70ed0eaae8bed59cf3e6c47f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aafac57ade5dfbef11b3721283a8fc4146c659db4be5359fd51489834f9ecb8c2ed1f9fd1cdd4193af3233d39622421a16dc27dc48ad238b752b27a933deda6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3573e068b6ab4d46a7f2bad2d83a5aadbe3918b681b6ba23231df629a8faa5bd60a7f2314ce4e19d8440c2b4cb014da0eadd5e9cef9449048d8b637fa53fefb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/721f5e86046c07a8a6a9a5ba85ed69c81aa994b1a4b63039656664941cfec2da2d917d4343936fb9667346c5b1e1bc3d2fe366833a83840bc186f38ea904795d"} build_url:https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/Y6736YMNTqSa9KPhJQKk5A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/09cbd55eb6568b8627d3e900e79ccc8141d2f2be55f7819e1d5f70486fa8f55cfb06141f2b42db3455d4dde9f53060c705d3b56f70ed0eaae8bed59cf3e6c47f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aafac57ade5dfbef11b3721283a8fc4146c659db4be5359fd51489834f9ecb8c2ed1f9fd1cdd4193af3233d39622421a16dc27dc48ad238b752b27a933deda6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3573e068b6ab4d46a7f2bad2d83a5aadbe3918b681b6ba23231df629a8faa5bd60a7f2314ce4e19d8440c2b4cb014da0eadd5e9cef9449048d8b637fa53fefb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/721f5e86046c07a8a6a9a5ba85ed69c81aa994b1a4b63039656664941cfec2da2d917d4343936fb9667346c5b1e1bc3d2fe366833a83840bc186f38ea904795d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 10:36:32.243697) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:36:32.244147) ========= 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=836cfdc75598d54cb747368e000001a9-1491412539.519069-946472552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:36:32.328490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 10:36:32.328945) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 10:36:32.329320) ========= ========= Total master_lag: 0.16 =========