builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-077 starttime: 1486680004.32 results: success (0) buildid: 20170209125019 builduid: 3f0e84669b35410c96750a1fd480bae7 revision: b6e8246f967b9d786e2b15a53616a90cdc791c93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:04.320726) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:04.321196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:04.321476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:04.338036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:04.338390) ========= 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=20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 14:40:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-02-09 14:40:05 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.258215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:04.609876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:04.610201) ========= 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=20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:04.659776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 14:40:04.660131) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b6e8246f967b9d786e2b15a53616a90cdc791c93 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b6e8246f967b9d786e2b15a53616a90cdc791c93 --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=20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 14:40:05,155 truncating revision to first 12 chars 2017-02-09 14:40:05,155 Setting DEBUG logging. 2017-02-09 14:40:05,155 attempt 1/10 2017-02-09 14:40:05,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b6e8246f967b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 14:40:05,843 unpacking tar archive at: mozilla-beta-b6e8246f967b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.996311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 14:40:05.669327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:05.669678) ========= script_repo_revision: b6e8246f967b9d786e2b15a53616a90cdc791c93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:05.670069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:05.670333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 14:40:05.680273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-09 14:40:05.680546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:40:06 INFO - MultiFileLogger online at 20170209 14:40:06 in /builds/slave/test 14:40:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:40:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:40:06 INFO - {'append_to_log': False, 14:40:06 INFO - 'base_work_dir': '/builds/slave/test', 14:40:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:40:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:40:06 INFO - 'branch': 'Mozilla-Beta', 14:40:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:40:06 INFO - 'config_files': ('talos/linux_config.py',), 14:40:06 INFO - 'default_actions': ('clobber', 14:40:06 INFO - 'read-buildbot-config', 14:40:06 INFO - 'download-and-extract', 14:40:06 INFO - 'populate-webroot', 14:40:06 INFO - 'create-virtualenv', 14:40:06 INFO - 'install', 14:40:06 INFO - 'run-tests'), 14:40:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:40:06 INFO - 'download_minidump_stackwalk': True, 14:40:06 INFO - 'download_symbols': 'ondemand', 14:40:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:40:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:40:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:40:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:40:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:40:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:40:06 INFO - 'installer_path': 'installer.exe', 14:40:06 INFO - 'log_level': 'info', 14:40:06 INFO - 'log_name': 'talos', 14:40:06 INFO - 'log_to_console': True, 14:40:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:40:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:40:06 INFO - 'opt_config_files': (), 14:40:06 INFO - 'pip_index': False, 14:40:06 INFO - 'sps_profile': False, 14:40:06 INFO - 'sps_profile_interval': 0, 14:40:06 INFO - 'suite': 'dromaeojs', 14:40:06 INFO - 'system_bits': '32', 14:40:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:40:06 INFO - 'title': 'talos-linux64-ix-077', 14:40:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:40:06 INFO - 'use_talos_json': True, 14:40:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:40:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:40:06 INFO - 'work_dir': 'build'} 14:40:06 INFO - [mozharness: 2017-02-09 22:40:06.276979Z] Running clobber step. 14:40:06 INFO - Running pre-action listener: _resource_record_pre_action 14:40:06 INFO - Running main action method: clobber 14:40:06 INFO - rmtree: /builds/slave/test/build 14:40:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:40:06 INFO - Running post-action listener: _resource_record_post_action 14:40:06 INFO - [mozharness: 2017-02-09 22:40:06.788729Z] Finished clobber step (success) 14:40:06 INFO - [mozharness: 2017-02-09 22:40:06.788829Z] Running read-buildbot-config step. 14:40:06 INFO - Running pre-action listener: _resource_record_pre_action 14:40:06 INFO - Running main action method: read_buildbot_config 14:40:06 INFO - Using buildbot properties: 14:40:06 INFO - { 14:40:06 INFO - "project": "", 14:40:06 INFO - "product": "firefox", 14:40:06 INFO - "script_repo_revision": "production", 14:40:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:40:06 INFO - "repository": "", 14:40:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:40:06 INFO - "buildid": "20170209125019", 14:40:06 INFO - "pgo_build": "True", 14:40:06 INFO - "basedir": "/builds/slave/test", 14:40:06 INFO - "buildnumber": 14, 14:40:06 INFO - "slavename": "talos-linux64-ix-077", 14:40:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:40:06 INFO - "platform": "ubuntu64_hw", 14:40:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:40:06 INFO - "branch": "mozilla-beta", 14:40:06 INFO - "repo_path": "releases/mozilla-beta", 14:40:06 INFO - "revision": "b6e8246f967b9d786e2b15a53616a90cdc791c93", 14:40:06 INFO - "stage_platform": "linux64-pgo", 14:40:06 INFO - "builduid": "3f0e84669b35410c96750a1fd480bae7", 14:40:06 INFO - "slavebuilddir": "test" 14:40:06 INFO - } 14:40:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 14:40:06 INFO - Running post-action listener: _resource_record_post_action 14:40:06 INFO - [mozharness: 2017-02-09 22:40:06.791290Z] Finished read-buildbot-config step (success) 14:40:06 INFO - [mozharness: 2017-02-09 22:40:06.791377Z] Running download-and-extract step. 14:40:06 INFO - Running pre-action listener: _resource_record_pre_action 14:40:06 INFO - Running main action method: download_and_extract 14:40:06 INFO - mkdir: /builds/slave/test/build/tests 14:40:06 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')]} 14:40:06 INFO - trying https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:40:06 INFO - Downloading https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:40:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:40:07 INFO - Downloaded 1327 bytes. 14:40:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:40:07 INFO - Using the following test package requirements: 14:40:07 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:40:07 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:40:07 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:40:07 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:40:07 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 14:40:07 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:40:07 INFO - u'jsshell-linux-x86_64.zip'], 14:40:07 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:40:07 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:40:07 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:40:07 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:40:07 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 14:40:07 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:40:07 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 14:40:07 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:40:07 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:40:07 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:40:07 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:40:07 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:40:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:40:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:40:07 INFO - Fetch https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:40:07 INFO - Http code: 200 14:40:07 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 14:40:07 INFO - x-amz-cf-id: yvzDLkPXpYPkdd0sbjaQJ9LpkyxwcrC5h1DJxcnUUiC24_ZNPSK_Rg== 14:40:07 INFO - x-amz-version-id: DKvREcKKavkvFjNlnb0XuPA32aEWg3xw 14:40:08 INFO - Expected file size: 21958962 14:40:08 INFO - Obtained file size: 21958962 14:40:12 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:40:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:40:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:40:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:40:12 INFO - Http code: 200 14:40:12 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 14:40:12 INFO - x-amz-cf-id: OMqjJv6H_QoMVS9JD4D5FpFgiAgyujNqmv2djYnuJwc89N1D9fQY9g== 14:40:12 INFO - x-amz-version-id: DKvREcKKavkvFjNlnb0XuPA32aEWg3xw 14:40:13 INFO - Expected file size: 21958962 14:40:13 INFO - Obtained file size: 21958962 14:40:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 14:40:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:40:17 INFO - Fetch https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 14:40:17 INFO - Http code: 200 14:40:17 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 14:40:17 INFO - x-amz-cf-id: cwvkzlTnpGN0MvVyj6JjQ7vydzjkM2fFODqjD6TzXYm6Gu_rknorpg== 14:40:17 INFO - x-amz-version-id: EpagACBm1xyZGbgCv9vjgrN6cHoUfSxq 14:40:18 INFO - Expected file size: 14403005 14:40:18 INFO - Obtained file size: 14403005 14:40:18 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')]} 14:40:18 INFO - trying https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:40:18 INFO - Downloading https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:40:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:40:19 INFO - Downloaded 57704273 bytes. 14:40:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:40:19 INFO - mkdir: /builds/slave/test/properties 14:40:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:40:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:40:19 INFO - Contents: 14:40:19 INFO - build_url:https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:40:20 INFO - Running post-action listener: _resource_record_post_action 14:40:20 INFO - Running post-action listener: set_extra_try_arguments 14:40:20 INFO - [mozharness: 2017-02-09 22:40:20.068966Z] Finished download-and-extract step (success) 14:40:20 INFO - [mozharness: 2017-02-09 22:40:20.069192Z] Running populate-webroot step. 14:40:20 INFO - Running pre-action listener: _resource_record_pre_action 14:40:20 INFO - Running main action method: populate_webroot 14:40:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:40:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:40:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:40:20 INFO - '--tppagecycles', 14:40:20 INFO - '7'], 14:40:20 INFO - 'tests': ['tsvgm']}}, 14:40:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:40:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:40:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:40:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:40:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:20 INFO - 'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:40:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:40:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:20 INFO - 'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['damp', 'tps']}, 14:40:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:20 INFO - 'tests': ['damp', 'tps']}, 14:40:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['dromaeo_dom']}, 14:40:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:40:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['basic_compositor_video']}, 14:40:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:40:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['a11yr', 14:40:20 INFO - 'ts_paint', 14:40:20 INFO - 'tpaint', 14:40:20 INFO - 'sessionrestore', 14:40:20 INFO - 'sessionrestore_no_auto_restore', 14:40:20 INFO - 'tabpaint']}, 14:40:20 INFO - 'other-e10s': {'tests': ['a11yr', 14:40:20 INFO - 'ts_paint', 14:40:20 INFO - 'tpaint', 14:40:20 INFO - 'sessionrestore', 14:40:20 INFO - 'sessionrestore_no_auto_restore', 14:40:20 INFO - 'tabpaint']}, 14:40:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:40:20 INFO - 'ts_paint', 14:40:20 INFO - 'tpaint', 14:40:20 INFO - 'sessionrestore', 14:40:20 INFO - 'sessionrestore_no_auto_restore', 14:40:20 INFO - 'tabpaint']}, 14:40:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:40:20 INFO - 'ts_paint', 14:40:20 INFO - 'tpaint', 14:40:20 INFO - 'sessionrestore', 14:40:20 INFO - 'sessionrestore_no_auto_restore', 14:40:20 INFO - 'tabpaint']}, 14:40:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['a11yr', 14:40:20 INFO - 'ts_paint', 14:40:20 INFO - 'tpaint', 14:40:20 INFO - 'sessionrestore', 14:40:20 INFO - 'sessionrestore_no_auto_restore', 14:40:20 INFO - 'tabpaint']}, 14:40:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['a11yr', 14:40:20 INFO - 'ts_paint', 14:40:20 INFO - 'tpaint', 14:40:20 INFO - 'sessionrestore', 14:40:20 INFO - 'sessionrestore_no_auto_restore', 14:40:20 INFO - 'tabpaint']}, 14:40:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['tsvgx', 14:40:20 INFO - 'tsvgr_opacity', 14:40:20 INFO - 'tart', 14:40:20 INFO - 'tscrollx', 14:40:20 INFO - 'cart']}, 14:40:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:40:20 INFO - 'tsvgr_opacity', 14:40:20 INFO - 'tart', 14:40:20 INFO - 'tscrollx', 14:40:20 INFO - 'cart']}, 14:40:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:20 INFO - 'talos_options': ['--disable-e10s'], 14:40:20 INFO - 'tests': ['tp5o']}, 14:40:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:20 INFO - 'tests': ['tp5o']}, 14:40:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:20 INFO - 'talos_options': ['--disable-e10s', 14:40:20 INFO - '--xperf_path', 14:40:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:40:20 INFO - 'tests': ['tp5n']}, 14:40:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:20 INFO - 'talos_options': ['--xperf_path', 14:40:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:40:20 INFO - 'tests': ['tp5n']}}, 14:40:20 INFO - 'talos.zip': {'path': '', 14:40:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:40:20 INFO - Running post-action listener: _resource_record_post_action 14:40:20 INFO - [mozharness: 2017-02-09 22:40:20.085324Z] Finished populate-webroot step (success) 14:40:20 INFO - [mozharness: 2017-02-09 22:40:20.085484Z] Running create-virtualenv step. 14:40:20 INFO - Running pre-action listener: _resource_record_pre_action 14:40:20 INFO - Running main action method: create_virtualenv 14:40:20 INFO - Creating virtualenv /builds/slave/test/build/venv 14:40:20 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 14:40:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:40:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:40:20 INFO - Using real prefix '/usr' 14:40:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:40:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:40:22 INFO - Installing pip.................done. 14:40:22 INFO - Return code: 0 14:40:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:40:22 INFO - Reading from file tmpfile_stdout 14:40:22 INFO - Output received: 14:40:22 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) 14:40:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:40:22 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')]} 14:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:22 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')]} 14:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:22 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:22 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 14:40:22 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 14:40:22 INFO - Using env: {'DISPLAY': ':0', 14:40:22 INFO - 'HOME': '/home/cltbld', 14:40:22 INFO - 'LANG': 'en_US.UTF-8', 14:40:22 INFO - 'LANGUAGE': 'en_US:en', 14:40:22 INFO - 'LOGNAME': 'cltbld', 14:40:22 INFO - 'MAIL': '/var/mail/cltbld', 14:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:22 INFO - 'MOZ_NO_REMOTE': '1', 14:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:22 INFO - 'NO_EM_RESTART': '1', 14:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:22 INFO - 'PWD': '/builds/slave/test', 14:40:22 INFO - 'SHELL': '/bin/bash', 14:40:22 INFO - 'SHLVL': '1', 14:40:22 INFO - 'TERM': 'linux', 14:40:22 INFO - 'TMOUT': '86400', 14:40:22 INFO - 'USER': 'cltbld', 14:40:22 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:22 INFO - '_': '/tools/buildbot/bin/python'} 14:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:23 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 14:40:23 INFO - Cleaning up... 14:40:23 INFO - Return code: 0 14:40:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:40:23 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')]} 14:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:23 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')]} 14:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:23 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:23 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 14:40:23 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 14:40:23 INFO - Using env: {'DISPLAY': ':0', 14:40:23 INFO - 'HOME': '/home/cltbld', 14:40:23 INFO - 'LANG': 'en_US.UTF-8', 14:40:23 INFO - 'LANGUAGE': 'en_US:en', 14:40:23 INFO - 'LOGNAME': 'cltbld', 14:40:23 INFO - 'MAIL': '/var/mail/cltbld', 14:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:23 INFO - 'MOZ_NO_REMOTE': '1', 14:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:23 INFO - 'NO_EM_RESTART': '1', 14:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:23 INFO - 'PWD': '/builds/slave/test', 14:40:23 INFO - 'SHELL': '/bin/bash', 14:40:23 INFO - 'SHLVL': '1', 14:40:23 INFO - 'TERM': 'linux', 14:40:23 INFO - 'TMOUT': '86400', 14:40:23 INFO - 'USER': 'cltbld', 14:40:23 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:23 INFO - '_': '/tools/buildbot/bin/python'} 14:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:23 INFO - Downloading/unpacking psutil>=3.1.1 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:40:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:40:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:40:25 INFO - Installing collected packages: psutil 14:40:25 INFO - Running setup.py install for psutil 14:40:25 INFO - building 'psutil._psutil_linux' extension 14:40:25 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 14:40:25 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 14:40:25 INFO - building 'psutil._psutil_posix' extension 14:40:25 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 14:40:25 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 14:40:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:40:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:40:25 INFO - Successfully installed psutil 14:40:25 INFO - Cleaning up... 14:40:26 INFO - Return code: 0 14:40:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:40:26 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')]} 14:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:26 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')]} 14:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:26 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:26 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 14:40:26 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 14:40:26 INFO - Using env: {'DISPLAY': ':0', 14:40:26 INFO - 'HOME': '/home/cltbld', 14:40:26 INFO - 'LANG': 'en_US.UTF-8', 14:40:26 INFO - 'LANGUAGE': 'en_US:en', 14:40:26 INFO - 'LOGNAME': 'cltbld', 14:40:26 INFO - 'MAIL': '/var/mail/cltbld', 14:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:26 INFO - 'MOZ_NO_REMOTE': '1', 14:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:26 INFO - 'NO_EM_RESTART': '1', 14:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:26 INFO - 'PWD': '/builds/slave/test', 14:40:26 INFO - 'SHELL': '/bin/bash', 14:40:26 INFO - 'SHLVL': '1', 14:40:26 INFO - 'TERM': 'linux', 14:40:26 INFO - 'TMOUT': '86400', 14:40:26 INFO - 'USER': 'cltbld', 14:40:26 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:26 INFO - '_': '/tools/buildbot/bin/python'} 14:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:40:26 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 14:40:26 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 14:40:26 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 14:40:26 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 14:40:26 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 14:40:26 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 14:40:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:40:28 INFO - Installing collected packages: mozsystemmonitor 14:40:28 INFO - Running setup.py install for mozsystemmonitor 14:40:28 INFO - Successfully installed mozsystemmonitor 14:40:28 INFO - Cleaning up... 14:40:28 INFO - Return code: 0 14:40:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:40:28 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')]} 14:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:28 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')]} 14:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:28 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:28 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 14:40:28 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 14:40:28 INFO - Using env: {'DISPLAY': ':0', 14:40:28 INFO - 'HOME': '/home/cltbld', 14:40:28 INFO - 'LANG': 'en_US.UTF-8', 14:40:28 INFO - 'LANGUAGE': 'en_US:en', 14:40:28 INFO - 'LOGNAME': 'cltbld', 14:40:28 INFO - 'MAIL': '/var/mail/cltbld', 14:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:28 INFO - 'MOZ_NO_REMOTE': '1', 14:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:28 INFO - 'NO_EM_RESTART': '1', 14:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:28 INFO - 'PWD': '/builds/slave/test', 14:40:28 INFO - 'SHELL': '/bin/bash', 14:40:28 INFO - 'SHLVL': '1', 14:40:28 INFO - 'TERM': 'linux', 14:40:28 INFO - 'TMOUT': '86400', 14:40:28 INFO - 'USER': 'cltbld', 14:40:28 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:28 INFO - '_': '/tools/buildbot/bin/python'} 14:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:40:28 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 14:40:28 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 14:40:28 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 14:40:28 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 14:40:28 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 14:40:28 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 14:40:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:40:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:40:30 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 14:40:30 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 14:40:30 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 14:40:30 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 14:40:30 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 14:40:30 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 14:40:31 INFO - Downloading functools32-3.2.3-2.tar.gz 14:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:40:31 INFO - warning: no files found matching '*.txt' 14:40:31 INFO - no previously-included directories found matching 'build' 14:40:31 INFO - no previously-included directories found matching 'dist' 14:40:31 INFO - no previously-included directories found matching '.git*' 14:40:31 INFO - Installing collected packages: jsonschema, functools32 14:40:31 INFO - Running setup.py install for functools32 14:40:31 INFO - warning: no files found matching '*.txt' 14:40:31 INFO - no previously-included directories found matching 'build' 14:40:31 INFO - no previously-included directories found matching 'dist' 14:40:31 INFO - no previously-included directories found matching '.git*' 14:40:31 INFO - Successfully installed jsonschema functools32 14:40:31 INFO - Cleaning up... 14:40:31 INFO - Return code: 0 14:40:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:31 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:31 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 14:40:31 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 14:40:31 INFO - Using env: {'DISPLAY': ':0', 14:40:31 INFO - 'HOME': '/home/cltbld', 14:40:31 INFO - 'LANG': 'en_US.UTF-8', 14:40:31 INFO - 'LANGUAGE': 'en_US:en', 14:40:31 INFO - 'LOGNAME': 'cltbld', 14:40:31 INFO - 'MAIL': '/var/mail/cltbld', 14:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:31 INFO - 'MOZ_NO_REMOTE': '1', 14:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:31 INFO - 'NO_EM_RESTART': '1', 14:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:31 INFO - 'PWD': '/builds/slave/test', 14:40:31 INFO - 'SHELL': '/bin/bash', 14:40:31 INFO - 'SHLVL': '1', 14:40:31 INFO - 'TERM': 'linux', 14:40:31 INFO - 'TMOUT': '86400', 14:40:31 INFO - 'USER': 'cltbld', 14:40:31 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:31 INFO - '_': '/tools/buildbot/bin/python'} 14:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:40:31 INFO - Cleaning up... 14:40:31 INFO - Return code: 0 14:40:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:31 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:31 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 14:40:31 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 14:40:31 INFO - Using env: {'DISPLAY': ':0', 14:40:31 INFO - 'HOME': '/home/cltbld', 14:40:31 INFO - 'LANG': 'en_US.UTF-8', 14:40:31 INFO - 'LANGUAGE': 'en_US:en', 14:40:31 INFO - 'LOGNAME': 'cltbld', 14:40:31 INFO - 'MAIL': '/var/mail/cltbld', 14:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:31 INFO - 'MOZ_NO_REMOTE': '1', 14:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:31 INFO - 'NO_EM_RESTART': '1', 14:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:31 INFO - 'PWD': '/builds/slave/test', 14:40:31 INFO - 'SHELL': '/bin/bash', 14:40:31 INFO - 'SHLVL': '1', 14:40:31 INFO - 'TERM': 'linux', 14:40:31 INFO - 'TMOUT': '86400', 14:40:31 INFO - 'USER': 'cltbld', 14:40:31 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:31 INFO - '_': '/tools/buildbot/bin/python'} 14:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:31 INFO - Downloading/unpacking blobuploader==1.2.4 14:40:31 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 14:40:31 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 14:40:31 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 14:40:31 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 14:40:31 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 14:40:31 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 14:40:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:40:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:40:33 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 14:40:33 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 14:40:33 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 14:40:33 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 14:40:33 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 14:40:33 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 14:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:40:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:40:34 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 14:40:34 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 14:40:34 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 14:40:34 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 14:40:34 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 14:40:34 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 14:40:34 INFO - Downloading docopt-0.6.1.tar.gz 14:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:40:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:40:34 INFO - Running setup.py install for blobuploader 14:40:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:40:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:40:34 INFO - Running setup.py install for requests 14:40:35 INFO - Running setup.py install for docopt 14:40:35 INFO - Successfully installed blobuploader requests docopt 14:40:35 INFO - Cleaning up... 14:40:35 INFO - Return code: 0 14:40:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:35 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')]} 14:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:35 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')]} 14:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:35 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:35 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 14:40:35 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 14:40:35 INFO - Using env: {'DISPLAY': ':0', 14:40:35 INFO - 'HOME': '/home/cltbld', 14:40:35 INFO - 'LANG': 'en_US.UTF-8', 14:40:35 INFO - 'LANGUAGE': 'en_US:en', 14:40:35 INFO - 'LOGNAME': 'cltbld', 14:40:35 INFO - 'MAIL': '/var/mail/cltbld', 14:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:35 INFO - 'MOZ_NO_REMOTE': '1', 14:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:35 INFO - 'NO_EM_RESTART': '1', 14:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:35 INFO - 'PWD': '/builds/slave/test', 14:40:35 INFO - 'SHELL': '/bin/bash', 14:40:35 INFO - 'SHLVL': '1', 14:40:35 INFO - 'TERM': 'linux', 14:40:35 INFO - 'TMOUT': '86400', 14:40:35 INFO - 'USER': 'cltbld', 14:40:35 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:35 INFO - '_': '/tools/buildbot/bin/python'} 14:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:35 INFO - Running setup.py (path:/tmp/pip-FkxkPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:35 INFO - Running setup.py (path:/tmp/pip-7ce69m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:35 INFO - Running setup.py (path:/tmp/pip-aXE79Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:35 INFO - Running setup.py (path:/tmp/pip-Q4tO82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:35 INFO - Running setup.py (path:/tmp/pip-IC8AXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:35 INFO - Running setup.py (path:/tmp/pip-y7nM0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:35 INFO - Running setup.py (path:/tmp/pip-w2fxmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:35 INFO - Running setup.py (path:/tmp/pip-jBTVe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:36 INFO - Running setup.py (path:/tmp/pip-5h6UDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:36 INFO - Running setup.py (path:/tmp/pip-ziIwXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:36 INFO - Running setup.py (path:/tmp/pip-eNAJOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:36 INFO - Running setup.py (path:/tmp/pip-zPCJtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:36 INFO - Running setup.py (path:/tmp/pip-ysOkiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:36 INFO - Running setup.py (path:/tmp/pip-zbGT8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:36 INFO - Running setup.py (path:/tmp/pip-8JL_dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:36 INFO - Running setup.py (path:/tmp/pip-FRHrg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:36 INFO - Running setup.py (path:/tmp/pip-Nyxu_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:40:36 INFO - Running setup.py install for manifestparser 14:40:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:40:36 INFO - Running setup.py install for mozcrash 14:40:36 INFO - Running setup.py install for mozdebug 14:40:36 INFO - Running setup.py install for mozdevice 14:40:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Running setup.py install for mozfile 14:40:37 INFO - Running setup.py install for mozhttpd 14:40:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Running setup.py install for mozinfo 14:40:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Running setup.py install for mozInstall 14:40:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Running setup.py install for mozleak 14:40:37 INFO - Running setup.py install for mozlog 14:40:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Running setup.py install for moznetwork 14:40:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:40:37 INFO - Running setup.py install for mozprocess 14:40:37 INFO - Running setup.py install for mozprofile 14:40:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:40:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:40:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:40:38 INFO - Running setup.py install for mozrunner 14:40:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:40:38 INFO - Running setup.py install for mozscreenshot 14:40:38 INFO - Running setup.py install for moztest 14:40:38 INFO - Running setup.py install for mozversion 14:40:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:40:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:40:38 INFO - Cleaning up... 14:40:38 INFO - Return code: 0 14:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:38 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')]} 14:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:38 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')]} 14:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:38 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:38 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 14:40:38 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 14:40:38 INFO - Using env: {'DISPLAY': ':0', 14:40:38 INFO - 'HOME': '/home/cltbld', 14:40:38 INFO - 'LANG': 'en_US.UTF-8', 14:40:38 INFO - 'LANGUAGE': 'en_US:en', 14:40:38 INFO - 'LOGNAME': 'cltbld', 14:40:38 INFO - 'MAIL': '/var/mail/cltbld', 14:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:38 INFO - 'MOZ_NO_REMOTE': '1', 14:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:38 INFO - 'NO_EM_RESTART': '1', 14:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:38 INFO - 'PWD': '/builds/slave/test', 14:40:38 INFO - 'SHELL': '/bin/bash', 14:40:38 INFO - 'SHLVL': '1', 14:40:38 INFO - 'TERM': 'linux', 14:40:38 INFO - 'TMOUT': '86400', 14:40:38 INFO - 'USER': 'cltbld', 14:40:38 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:38 INFO - '_': '/tools/buildbot/bin/python'} 14:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:38 INFO - Running setup.py (path:/tmp/pip-UhJuAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:38 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)) 14:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:38 INFO - Running setup.py (path:/tmp/pip-mGX7FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:38 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)) 14:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:38 INFO - Running setup.py (path:/tmp/pip-lDzAAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:38 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)) 14:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:38 INFO - Running setup.py (path:/tmp/pip-KALdkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 14:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:38 INFO - Running setup.py (path:/tmp/pip-7LJjd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:39 INFO - Running setup.py (path:/tmp/pip-lEcZNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:39 INFO - Running setup.py (path:/tmp/pip-0LhY0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:39 INFO - Running setup.py (path:/tmp/pip-Xc7lHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:39 INFO - Running setup.py (path:/tmp/pip-KBlklC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:39 INFO - Running setup.py (path:/tmp/pip-snIuyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:39 INFO - Running setup.py (path:/tmp/pip-O6GAyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:39 INFO - Running setup.py (path:/tmp/pip-k3CEMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:39 INFO - Running setup.py (path:/tmp/pip-BpZ7K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:39 INFO - Running setup.py (path:/tmp/pip-Q7xKDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:39 INFO - Running setup.py (path:/tmp/pip-bmetPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:39 INFO - Running setup.py (path:/tmp/pip-b7_6px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:39 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)) 14:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:39 INFO - Running setup.py (path:/tmp/pip-d2NfgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:39 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)) 14:40:39 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)) 14:40:39 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)) 14:40:39 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)) 14:40:39 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:40:39 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:40:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:40:39 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 14:40:39 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 14:40:39 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 14:40:39 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 14:40:39 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 14:40:39 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 14:40:41 INFO - Downloading blessings-1.6.tar.gz 14:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:40:42 INFO - Installing collected packages: blessings 14:40:42 INFO - Running setup.py install for blessings 14:40:42 INFO - Successfully installed blessings 14:40:42 INFO - Cleaning up... 14:40:42 INFO - Return code: 0 14:40:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:42 INFO - Reading from file tmpfile_stdout 14:40:42 INFO - Current package versions: 14:40:42 INFO - argparse == 1.2.1 14:40:42 INFO - blessings == 1.6 14:40:42 INFO - blobuploader == 1.2.4 14:40:42 INFO - docopt == 0.6.1 14:40:42 INFO - functools32 == 3.2.3-2 14:40:42 INFO - jsonschema == 2.5.1 14:40:42 INFO - manifestparser == 1.1 14:40:42 INFO - mozInstall == 1.12 14:40:42 INFO - mozcrash == 1.0 14:40:42 INFO - mozdebug == 0.1 14:40:42 INFO - mozdevice == 0.48 14:40:42 INFO - mozfile == 1.2 14:40:42 INFO - mozhttpd == 0.7 14:40:42 INFO - mozinfo == 0.9 14:40:42 INFO - mozleak == 0.1 14:40:42 INFO - mozlog == 3.4 14:40:42 INFO - moznetwork == 0.27 14:40:42 INFO - mozprocess == 0.23 14:40:42 INFO - mozprofile == 0.28 14:40:42 INFO - mozrunner == 6.13 14:40:42 INFO - mozscreenshot == 0.1 14:40:42 INFO - mozsystemmonitor == 0.3 14:40:42 INFO - moztest == 0.8 14:40:42 INFO - mozversion == 1.4 14:40:42 INFO - psutil == 3.1.1 14:40:42 INFO - requests == 1.2.3 14:40:42 INFO - wsgiref == 0.1.2 14:40:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:42 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')]} 14:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:42 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')]} 14:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:42 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:42 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 14:40:42 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 14:40:42 INFO - Using env: {'DISPLAY': ':0', 14:40:42 INFO - 'HOME': '/home/cltbld', 14:40:42 INFO - 'LANG': 'en_US.UTF-8', 14:40:42 INFO - 'LANGUAGE': 'en_US:en', 14:40:42 INFO - 'LOGNAME': 'cltbld', 14:40:42 INFO - 'MAIL': '/var/mail/cltbld', 14:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:42 INFO - 'MOZ_NO_REMOTE': '1', 14:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:42 INFO - 'NO_EM_RESTART': '1', 14:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:42 INFO - 'PWD': '/builds/slave/test', 14:40:42 INFO - 'SHELL': '/bin/bash', 14:40:42 INFO - 'SHLVL': '1', 14:40:42 INFO - 'TERM': 'linux', 14:40:42 INFO - 'TMOUT': '86400', 14:40:42 INFO - 'USER': 'cltbld', 14:40:42 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:42 INFO - '_': '/tools/buildbot/bin/python'} 14:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 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)) 14:40:42 INFO - Cleaning up... 14:40:42 INFO - Return code: 0 14:40:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:40:42 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')]} 14:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:42 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')]} 14:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:42 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 0x7f177b3e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, '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': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', '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 14:40:42 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 14:40:42 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 14:40:42 INFO - Using env: {'DISPLAY': ':0', 14:40:42 INFO - 'HOME': '/home/cltbld', 14:40:42 INFO - 'LANG': 'en_US.UTF-8', 14:40:42 INFO - 'LANGUAGE': 'en_US:en', 14:40:42 INFO - 'LOGNAME': 'cltbld', 14:40:42 INFO - 'MAIL': '/var/mail/cltbld', 14:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:42 INFO - 'MOZ_NO_REMOTE': '1', 14:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:42 INFO - 'NO_EM_RESTART': '1', 14:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:42 INFO - 'PWD': '/builds/slave/test', 14:40:42 INFO - 'SHELL': '/bin/bash', 14:40:42 INFO - 'SHLVL': '1', 14:40:42 INFO - 'TERM': 'linux', 14:40:42 INFO - 'TMOUT': '86400', 14:40:42 INFO - 'USER': 'cltbld', 14:40:42 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:42 INFO - '_': '/tools/buildbot/bin/python'} 14:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:40:42 INFO - Cleaning up... 14:40:42 INFO - Return code: 0 14:40:42 INFO - Running post-action listener: _resource_record_post_action 14:40:42 INFO - Running post-action listener: _start_resource_monitoring 14:40:42 INFO - Starting resource monitoring. 14:40:42 INFO - [mozharness: 2017-02-09 22:40:42.904999Z] Finished create-virtualenv step (success) 14:40:42 INFO - [mozharness: 2017-02-09 22:40:42.905553Z] Running install step. 14:40:42 INFO - Running pre-action listener: _resource_record_pre_action 14:40:42 INFO - Running main action method: install 14:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:43 INFO - Reading from file tmpfile_stdout 14:40:43 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:40:43 INFO - Reading from file tmpfile_stdout 14:40:43 INFO - Output received: 14:40:43 INFO - Usage: mozinstall [options] installer 14:40:43 INFO - Options: 14:40:43 INFO - -h, --help show this help message and exit 14:40:43 INFO - -d DEST, --destination=DEST 14:40:43 INFO - Directory to install application into. [default: 14:40:43 INFO - "/builds/slave/test"] 14:40:43 INFO - --app=APP Application being installed. [default: firefox] 14:40:43 INFO - mkdir: /builds/slave/test/build/application 14:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:40:57 INFO - Reading from file tmpfile_stdout 14:40:57 INFO - Output received: 14:40:57 INFO - /builds/slave/test/build/application/firefox/firefox 14:40:57 INFO - Running post-action listener: _resource_record_post_action 14:40:57 INFO - [mozharness: 2017-02-09 22:40:57.347300Z] Finished install step (success) 14:40:57 INFO - [mozharness: 2017-02-09 22:40:57.347541Z] Running run-tests step. 14:40:57 INFO - Running pre-action listener: _resource_record_pre_action 14:40:57 INFO - Running main action method: run_tests 14:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:57 INFO - Python 2.7.3 14:40:57 INFO - Return code: 0 14:40:57 INFO - grabbing minidump binary from tooltool 14:40:57 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')]} 14:40:57 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 0x1cabf60>, '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 0x1cacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:57 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 14:40:57 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 14:40:57 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 14:40:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:57 INFO - Return code: 0 14:40:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:40:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:40:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 14:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-077 --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 14:40:57 INFO - Using env: {'DISPLAY': ':0', 14:40:57 INFO - 'HOME': '/home/cltbld', 14:40:57 INFO - 'LANG': 'en_US.UTF-8', 14:40:57 INFO - 'LANGUAGE': 'en_US:en', 14:40:57 INFO - 'LOGNAME': 'cltbld', 14:40:57 INFO - 'MAIL': '/var/mail/cltbld', 14:40:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:57 INFO - 'MOZ_NO_REMOTE': '1', 14:40:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:57 INFO - 'NO_EM_RESTART': '1', 14:40:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:57 INFO - 'PWD': '/builds/slave/test', 14:40:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:57 INFO - 'SHELL': '/bin/bash', 14:40:57 INFO - 'SHLVL': '1', 14:40:57 INFO - 'TERM': 'linux', 14:40:57 INFO - 'TMOUT': '86400', 14:40:57 INFO - 'USER': 'cltbld', 14:40:57 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402', 14:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:57 INFO - '_': '/tools/buildbot/bin/python'} 14:40:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 14:40:57 INFO - mozversion application_buildid: 20170209125019 14:40:57 INFO - mozversion application_changeset: b6e8246f967b9d786e2b15a53616a90cdc791c93 14:40:57 INFO - mozversion application_display_name: Firefox 14:40:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:57 INFO - mozversion application_name: Firefox 14:40:57 INFO - mozversion application_remotingname: firefox 14:40:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:40:57 INFO - mozversion application_vendor: Mozilla 14:40:57 INFO - mozversion application_version: 52.0 14:40:57 INFO - mozversion platform_buildid: 20170209125019 14:40:57 INFO - mozversion platform_changeset: b6e8246f967b9d786e2b15a53616a90cdc791c93 14:40:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:40:57 INFO - mozversion platform_version: 52.0 14:40:57 INFO - using testdate: 1486680057 14:40:57 INFO - actual date: 1486680057 14:40:57 INFO - starting webserver on 'localhost:57644' 14:40:57 INFO - SUITE-START | Running 2 tests 14:40:57 INFO - TEST-START | dromaeo_css 14:40:57 INFO - operating with platform_type : linux_ 14:40:57 INFO - Initialising browser for dromaeo_css test... 14:40:57 INFO - TEST-INFO | started process 26664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCI51Jq/profile http://localhost:57644/getInfo.html) 14:41:01 INFO - PROCESS | 26664 | __metrics Screen width/height:1600/1200 14:41:01 INFO - PROCESS | 26664 | colorDepth:24 14:41:01 INFO - PROCESS | 26664 | Browser inner width/height: 1024/697 14:41:01 INFO - PROCESS | 26664 | __metrics 14:41:01 INFO - PROCESS | 26664 | 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" 14:41:01 INFO - PROCESS | 26664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:41:02 INFO - PROCESS | 26664 | console.error: PushService: 14:41:02 INFO - PROCESS | 26664 | stateChangeProcessEnqueue: Error transitioning state 14:41:02 INFO - PROCESS | 26664 | UnknownError 14:41:03 INFO - TEST-INFO | 26664: exit 0 14:41:03 INFO - Browser initialized. 14:41:03 INFO - Running cycle 1/1 for dromaeo_css test... 14:41:03 INFO - TEST-INFO | started process 26757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCI51Jq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:14 INFO - PROCESS | 26757 | RSS: Main: 141467648 14:41:14 INFO - PROCESS | 26757 | 14:44:15 INFO - PROCESS | 26757 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57644/tests/dromaeo/cssquery-ext.html) 14:44:17 INFO - PROCESS | 26757 | RSS: Main: 244011008 14:44:17 INFO - PROCESS | 26757 | 14:47:19 INFO - PROCESS | 26757 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-ext.html (next: http://localhost:57644/tests/dromaeo/cssquery-jquery.html) 14:47:20 INFO - PROCESS | 26757 | RSS: Main: 227082240 14:47:20 INFO - PROCESS | 26757 | 14:50:21 INFO - PROCESS | 26757 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57644/tests/dromaeo/cssquery-mootools.html) 14:50:22 INFO - PROCESS | 26757 | RSS: Main: 178249728 14:50:22 INFO - PROCESS | 26757 | 14:53:24 INFO - PROCESS | 26757 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57644/tests/dromaeo/cssquery-prototype.html) 14:53:24 INFO - PROCESS | 26757 | RSS: Main: 181542912 14:53:24 INFO - PROCESS | 26757 | 14:56:27 INFO - PROCESS | 26757 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57644/tests/dromaeo/cssquery-yui.html) 14:56:28 INFO - PROCESS | 26757 | RSS: Main: 171147264 14:56:28 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-yui.html (next: http://localhost:57644/tests/dromaeo/cssquery-dojo.html) 14:59:30 INFO - PROCESS | 26757 | RSS: Main: 256991232 14:59:30 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | __start_tp_report 14:59:30 INFO - PROCESS | 26757 | _x_x_mozilla_page_load 14:59:30 INFO - PROCESS | 26757 | _x_x_mozilla_page_load_details 14:59:30 INFO - PROCESS | 26757 | |i|pagename|runs| 14:59:30 INFO - PROCESS | 26757 | |0;dojo.html;3200.327931134462;3224.6130464344283;3239.3683231769783;3252.951205731913;3273.901782946511;5401.054815407303;5447.972760136204;5458.5087342139195;5493.395726470085;5498.202760599711;5453.291072160613;5490;5506.669599824013;5507.5593952483805;5507.669539827613;4984.501549845014;4996.800127994876;5021.899562008758;5059.949400505985;5066.341375621164;4944.381952255968;4949.208126699728;4959.925601115986;5039.974800125994;5088.313077734514;4985.900281994358;5097.617678674096;5098.107831129556;5098.821541246057;5100.821471248507;5089.592832573385;5094.057599344133;5095.617828662865;5100.69395836251;5137.0496458154985;4846.975765121187;4876.731779752112;4998.10034193845;5014.971930754186;5059.696418214919;5344.144936810092;5347.41178470368;5368.758405871745;5417.918731219035;5437.429069947678;5770.04794208955;5794.6961933565035;5817.650940943557;5864.179014937912;5867.471927526501;5770.394108618619;5936.376680448577;5943.524518038546;5954.821355359303;5957.880842383128;5416.593755468316;5417.729113544347;5444.754986025639;5454.10007348791;5461.972690136524;5931.377205393458;5936.465718085393;5975.910361344583;5985.521158307412;5988.520918326523;5561.6663000220115;5684.175794509773;5688.260526131659;5690.146478028329;5693.82918512437;5698.8290351289525;5761.0782274836665;5811.88376232473;5852.268466441695;5885.970570147122;5846.941530584725;5873.236479257669;5874.853128671732;5876.9118463223085;5877.38287479817;5878.764849406061;5900.852478687982;5906.143609176645;5908.675022873783;5912;4440.955590444054;4463.933041004388;4515.616172625298;4527.909441811145;4538.523455037173;4049.453323801249;4071.3892916062828;4079.8776036718946;4099.098198396348;4102.2821006323775;5607.663540187602;5608.074667679787;5620.269364982608;5630.211770352154;5659.518940890071;5641.661500309994;5669.773209071674;5843.415658434123;5900.704964751745;5924.259467566554;5721.799737009184;5724.856878578069;5726.169705392695;5729.427057294321;5760.884782304331;5128.8461346159675;5138.897222055538;5141.151709967813;5145.897082058413;5172.767225474788;5980.3421623622235;5985.551083668743;6135.049067394561;6244.4380005798785;6267.780627678009;5876.265466816648;5946.494547963299;5949.434803693643;5964.493018093337;5976.820695379146;6232.532560057924;6239.313675495601;6249.406306400884;6262.1546091278915;6264.655443950444;5587.525060369751;5607.971960140173;5785.942140578709;5823.330317013598;5839.270091238595;5815.185873977562;5824.097264923944;5862.648241105548;5931.347551769216;5961.612495187799;5762.538996880324;5769.134629805562;5770.451807078321;5774.711264436845;5775.393583673654;5535.8892822144135;5757.8560535986935;5764.682942438206;5766.682832444088;5767.826965191051;5500.312460942382;5622.212890195294;5666.490015898589;5677.31872175325;5792.0443126885275;5738.254026976467;5790.160426738184;5797.072468405204;5799.5070419014855;5801.535877129904;5466.671999680032;5509.035918714289;5667.149927510906;5681.034224181816;5684.8294551163535 14:59:30 INFO - PROCESS | 26757 | |1;ext.html;580.4949693766424;611.0376157551856;626.8432891777056;645.7804346522183;649.9220093588771;32611.347773044527;44077.33883991743;45034.32448513275;45043;45126;46440.53559464405;46698;46927.296090558586;46940.76529617347;46978;8331.791705207388;9081.682141125062;9227.354085214038;9229.123233292827;9237.722868313962;8621.784455388633;10795.406252656101;11037.83443248352;11045.28205666633;11333.773324533504;11086.390248536327;11095.334279943228;11137.944310278477;11151.665450036471;11156;10962.725931851688;10976.231663783537;10986.835197472044;11043.558257669683;11060.612878549253;10868.67393978182;10952.288101273392;10961.725956851064;10962.835557466644;10969.341839489576;43350.349744753854;43475.56524434747;43560;43637.345439818426;43687;3593;3913.4325522799036;4109.2808758467145;4154.543000269968;4193.077522944947;32262.838685806655;32304.83847580747;32455.6754432455;32848;32875.17812054694;3842.846286148551;3906.3945088511327;3919.8824035278985;3934.429507721364;3940;338854;339129;340008;345924;348060.25969870243;40161;62143;62659;62661.37338626647;62772;40775;40832;41108.38337424941;41119.58880411217;41144;15386.615334616725;15641.765373519407;15648.843511564739;15651.921740391224;15657.451989180325;11877.346745929057;12086.637400877988;12163.756724865452;13152.276624785538;13250.867491324963;9193.724188274362;9328.860067098998;9345.439273643604;9407.247420206368;9435.24518038569;3450.3099380124077;3506.3162683276514;3524.8766293179615;3578.6958108561066;3590.730695197871;1001.6494227020485;1074.6561100447782;1080.8324709670014;1081.6603983288774;1119.7032786311634;33074.8346258272;33155.66844331574;33246.50130248048;33469.16327091842;33684.83157584245;1081.551156270139;1123.5112725964068;1141.073682745742;1181.0433548825479;1210.661014915825;14710.411583536752;17050.209727978632;17965.191566379282;18094.276228950694;18915.432537023913;504190;504822;505255;508256;508714;60578.39421605816;61016.38983610196;61218.38781612216;61251.6937415319;61279.693601531704;1274.6367285323638;1330.8868746156686;1339.7320535892861;1392.9512467063605;1409.9013069085065;29555.408891822473;30724.846375768873;30986.53520197154;31492;32065.51901721523;48803.26795098148;49308.794928329546;49324.01351973012;49342;49396.259056114905;254367;254444;255426;255707;422569;26365.60451593266;28613;29506;29513.85243073771;30818.84590577033;47269.2909606363;47489.28766068581;47550.76224618993;47729.28406073981;48179.5182048189;40229.597704023756;40326.798366007984;40855.795721021204;41946.58053419549;42054;39836;39964.800175998935;40252.3962140574;41558.58441415547;41948.790256049746;41592.37611435771;41723.582764171966;42002.36996444994;42749.14501709886;42767.786161068994;35643;37599.314033079674;38160.80919595384;38624.613753863225;38879.80560097181;28316;28884;28949.7105028947;28949.855250723613;29005.41989160163 14:59:30 INFO - PROCESS | 26757 | |2;jquery.html;405.68153999110706;412.8286760994188;418.76758399088504;426.94449721536205;435.17099924643566;17118.572035699115;18363.724544131834;19058.809411905877;19973.300934467297;19990.200391984323;19196.232150713953;19447.708284375745;19558.217671293132;19655.606887862235;19705.31031413901;5558.110702287625;5721.971390143064;5825.213596164527;5843.9707801461145;5847.093700476433;5671.829845104633;5778.682172480512;5824.592278540504;5850;5863.2670916135485;5739.311282646088;5794.362620111784;5794.420557944214;5799.130130480441;5800.303963524362;5577.358603760538;5768.480836724694;5773.826785196451;5779.190913272124;5811.6803575803315;5236.947630523684;5245.31810864589;5246.134387826004;5253.264542963988;5255.185446255837;22964.54070918589;23003;23049.423764406023;23103.306900792835;23210.41973950648;2287.325239054483;2351.388638953867;2385.3082606044227;2418.4921166555046;2678.8836818913037;9729.513524323755;10331.12185464229;10338.431386273753;10403.895961040369;10617.84073238902;1727.7840269966255;1872.9906350468161;1945.863789534733;1966.252823926913;1997.2011195521761;80830;82054.17945820525;83970;85202;85675.14324856797;10681.198910081775;10999.395033273247;11055.447227638746;11121.443927803577;11330.94334528322;15438;15532;15535.533933981998;15561.299741511659;15598.766018509732;8002.399820013522;8063.838723225503;8065.919340806517;8188.590570471452;8302.252797248277;7695.576743279174;7711.768646940601;7831.921680783234;7957.840843183104;7972.162922893129;4640.164770341371;4674.532546745366;4712.740799256074;4813.446453657874;4875.293082503017;1890.8298253157282;1969.251684359934;2010.497375656086;2011.8692285001428;2031.339814560274;925.6991477769752;1007.2445665750687;1014.2190513304714;1034.4672493665619;1099.70308016835;17554.736678949826;18374.908125459286;18442.262309507736;18668.81331186698;18708.53228669267;936.9250459963187;968.1045033344128;1005.2812239248972;1033.7801394354733;1034.110664828262;9382.85925711115;10320.587176512856;10556.102731267929;10577;10684.893151068545;493413;504539;505238;506815;516694;54324.72837635865;90438.54780726186;90735;90776;92734.53632731792;1020.3469779341079;1054.0144964458257;1058.9894101058892;1072.5870539842217;1086.2993369276771;15933.283002264694;16523.586910327336;16777.161141942608;16787.580310492336;17113.828861711223;37262.44106338461;39935.60064399319;40193.12009655944;40639;41336;55260;55329;55697.44302556923;55753.16370254368;57830;8278.958605206935;8405.243528082501;8525.275351594935;8730.738077857675;8780.868286975829;11461.942690286494;12401.875981240071;12629;12728.936355318165;13250.536231232247;10750.354978701303;10864.239503235014;11007.229493935347;11033.393163375771;11228.101751859995;10998.780024399628;11081.11351091927;11102.833457497982;11153.553857845594;11487.655370338904;10620.09729172998;10682.092022178202;10976.12191024732;11096.500657470595;11191.272567283426;7535.284148005931;8491.95754021226;8536.615852286786;8552.059273480038;8869.157430044135;11262.887371126511;11363.715907102389;11373.488193031168;11475.48360323804;11628.825567616661 14:59:30 INFO - PROCESS | 26757 | |3;mootools.html;1315.4935349890288;1480.274665413947;1494.3424893047059;1645.1445248470795;1819.2359209132162;7712.305892469677;8767.079456657055;9032.051634578373;9037.096290370959;9279.721608351743;9076.092390760938;9154.679586214485;9158.633654653822;9165.541722913844;9165.908340916589;2496.201215611001;2517.949641007179;2518.49630073985;2524.394145405108;2524.4951009798024;2402.0752010476003;2506.486170335077;2511.8744062796877;2512.2965569640437;2515.220281712666;2475.814313926454;2480.875956202192;2487.676602041732;2498;2501.4121681404854;2410.240774156153;2413.432843281836;2416.0818888822137;2435.866027368494;2453.41118131648;2388.5700573896693;2401.6037353836596;2417.10567090176;2425.890834912433;2427.5873101572774;8538.743837684817;8588.484690918565;8595.871061934076;8914.73255802327;9095.045020272843;5430.321209848769;5642.294713160855;5643;5645.350784659776;5659.801906933238;3370.831458427069;3414.9658503415144;3445.3453843769853;3460.757746957714;3622.2212224371888;1055.841623756435;1069.9358038517637;1070.9357438553711;1085.6200329884557;1086.0605576176629;12676;12701.491940322376;12708.93645531785;12793.61619151427;12798.680032999157;4325.178216138924;4587.61005314552;4721.6694831362165;4823.131836269435;4824.49342819006;9986.700398988041;9997.950010249902;9999.750006249902;10007.899921000842;10011.899881001242;5311.282976798083;5313.628046036741;5314.734263286898;5315.6279060465395;5322.0952438085615;4420.778961051935;4455.710378825366;4958.553730164303;5013.473585273567;5107.489251074863;3919.7060220483577;4014.297497937849;4066.3087275163293;4106.650934670586;4110;1158.2182027131653;1189.1913498820884;1189.6193218170276;1204.084895479442;1204.6325870609373;864.321507616518;875.6191056890145;883.3066043156092;884.2925659472396;919.0579655852671;5586.190002449704;5586.385497595261;5646.435356464321;5683.8863222736145;5846.239988801429;897.8742975983367;902.7878448564582;917.1842443697917;927.2521297354535;937.7340590203307;3572.7856328620364;3601.603823579404;3632.20091579852;3732.1042949692423;3802.6007269236884;10837.18721095921;11209.495572699248;11210.327380357205;11312.095032397388;11343.376114313627;11151.38667373286;11181.608643697431;11248.931351521756;11273.436328183558;11277.887221127849;8250.422470427013;8457.746267611981;8681.218690317775;8683.826323473495;8690.608922598498;5383.219433182088;5418.349798024262;5515.806946756844;5589.161625756006;5605.355384130877;9766.706998790047;10057.949710251401;10073.361752750949;10113.241506886865;10527.420991845522;10450.738731531772;10490.055894969184;10540.314879532805;10610.151187905103;10656.786864262516;7758.9612051939375;7900.6049697513745;7963.482373645695;8118.5940702963435;8254.958725206576;8650.351223658377;8681.522516261666;8705.434146780439;8750.649974001224;8761.25529330014;7869.645865935932;7891.960540197262;7893.644785984759;7901.486403383762;7997.720079797179;7789.300902782914;7800.84398312042;7838.490498117604;7852.685892564234;8031.638576264199;6868.347506986828;6927.099477067949;6942.097527321618;6981.441484681111;7042.084529011196;4751.6436267279405;4840.1529732296;4845.927311090407;4873.926891096566;4875.6099512038245;4751.40607424072;4755.476897541337;4914.631402644887;4956;5095.108356037753 14:59:30 INFO - PROCESS | 26757 | |4;prototype.html;347.2863265988394;352.0599998005326;355.5502289603651;363.2100182103923;363.95450568678916;5232.502912223337;5310.8141215057485;5311.73441327934;5344.331958505187;5363.731813409328;5004.974975125119;5119.820806271781;5123.974380128104;5240.659357141783;5257.763400646971;4143.70994030418;4155.314373128445;4163.812628431712;4179.958200417987;4189.266878296301;4167.3332266837315;4179.958200418003;4188.623023927861;4192.119654872466;4205.285101532747;4079.755214687128;4094.34490481523;4106.363513655373;4115.991582062399;4150.252954468195;4103.425520427142;4109.6438175402045;4114.033202197481;4117.5882411758885;4123.670106391482;3615.331163734691;3630.7821530708243;3641.7086633069557;3667.21154951684;3690.8892733218045;5020.748962551895;5193.766280517386;5209.947900520984;5244.325394049024;5253.212018197301;4678.602318802906;4689.226277664181;4700.929486057712;4710.929336059962;4760.190767569521;5519.227308176858;5522.796777868866;5536.778528858841;5540.252065971123;5553.6390134641115;3816.484774555455;4018.3771515415156;4022.597740225983;4034.677225821927;4050.0684842486394;5682.545396368322;5707.143928410772;5722.62802917809;5733.312002559678;5752.8849423011725;4114.868411186948;4116.135611521614;4120.237756015147;4136.131412403369;4142.5857414258335;4208.431861698693;4211.157768446323;4219.261629214937;4220.620144186976;4226.556211597799;4540.500544940054;4722.952770472251;4734.834280800224;4735.147673418817;4751.1470526494695;5529.751161197756;5539.972300138554;5544.556435485151;5556.472135147235;5559.833205003856;1353.29628593133;1393.7769956806862;1405.9876888640163;1417.6172433442912;1431.4059665239017;938.6292414496236;973.7711637765119;984.8969154546953;991.2268430624125;998.1814911772423;5235.162374020215;5265.684058956398;5272.288241087481;5292.311999440049;5307.867303317371;5365.624406291522;5452.236686863842;5499.477549632778;5525.696086715189;5537.2524709163745;5140.9154507295325;5190;5214.243934629533;5225.921611175835;5240.135377662643;2862.6421697287838;2868.942621147565;2880.942381152365;2881.697421770684;2884.206843118159;5643.435656434323;5659.745311460994;5673.659580425106;5676.68778217202;5954.427343593896;5790.507806836382;5810.360860305447;5825.2135961644635;5849.61977471463;5862.736176871966;5972.686009077996;5981.551383646244;5995.460408563163;6004.579679422399;6032.91407546637;5554.222408862682;5695.914561281667;5714.857128571819;5716.771329146787;5734.455226753452;5672.886542269214;5679.403662615366;5692.743826527899;5705;5718.656880587178;5739.885202295847;6020.969895150496;6022.518198544019;6032.366601506778;6039.396060393926;4141;4165.687573431944;4168.812403441913;4170.895727606834;4187.455630768102;5752.453516915886;5771.422857714195;5786.3056433228285;5808.925348810483;5819.534437244925;5590.748416321357;5603.789656151447;5604.495595396434;5609.467100625434;5707.546934104973;5592.468715472024;5595.8880822384135;5600.635958662674;5623.98768221724;5631.746571404215;5329.827437963641;5389.8113566025;5470.288862448016;5610.7755689773585;5638.4925356718095;5600.803971860965;5604.2539155814175;5617.382087970238;5627.549796016391;5630.831075067755;5493.423190565093;5495.203195536705;5504.669719816824;5529;5546.58400619947 14:59:30 INFO - PROCESS | 26757 | |5;yui.html;735.3308489274759;756.557413912861;769.7036640893256;803.6624617660582;841.1546395872156;15011.474598389059;15842.28709708063;15855.84144158558;15910.761338579916;15917.04497730137;14815.259237038132;15224.391024359013;15281.770773438408;15751.054936703806;15761.133137677423;681.0567364200593;699.3321378083944;832.2301870769544;840.9621567029499;849.6134258912211;840.970566030189;857.7898414888361;857.8927634045745;858.9570521473933;859.4198915731887;896.6771962093641;896.735463038402;896.7758060484879;896.8027034052498;896.8878890138733;877.7366789962986;882.6425297754356;884.2881480408269;885.3050355470924;885.3979294080023;650.6779144323543;657.0308794528081;657.9934200658028;659.8911179655352;660.6960798032862;14468.638284042878;14574;14605.269736513132;14611.707765844623;15999.600009999727;13919.719106138615;14004.579862604138;14027.509037183752;14506.70986580273;14779.408823647042;11404;11526.366049867254;11757.764844703059;11970.88029119715;11978.700532486757;3537.204129070964;3633.709303255733;3679.356112680297;3734.1971476132762;3767.472553842464;65847.67076164589;66535;66815;67001.66499167473;68528.31471685269;10892.760232811765;10915.890841091647;10936.726581835359;10939.617113400993;11285.492152853141;17365.131743412778;17420.738688919675;17444.563885902953;17480.47558573245;17860.374886878897;6970.372666460043;6976.407005404598;7011.193712723102;7072.575645461289;7308.30571095745;3943.960560394417;3945.5659877413464;3981.144054028398;4018.0959284161413;4065.57311482296;3414.283000569908;3545.4327307630656;3546.7871927684423;3554.9466757998653;3560.038789526813;609.250621735268;614.8493619063358;615.9692015399302;617.3209469583422;626.1234272019119;680.6222546486747;721.4661150748514;739.1315204634533;741.3846507398846;756.856197322507;8325.500469971821;8713.738587842376;8772.298216142693;8968.461892286483;9003.414778039407;653.9280679125293;725.742361461684;740.4261697184725;750.7897788619196;765.517723833981;4051.453053837753;4266.424032755538;4352.521222665504;4356.324769660708;4413.933790993137;90635;90979;91554;94213.5289323549;96168.51915740517;75691.24308756842;80122.59938700269;80308;82168.17831821725;84492;73994;74393.62803186057;74474.62762686152;74646.62676686581;74828;7989;8184.685202492999;8412;8454.196851299117;8469.280111190617;50095.74952125216;50391.24413133733;50539.49460505348;51223.74388128035;51425;63857;65938.34061659322;67280.32719672937;68361.65819170872;69400.30599693938;10754.40850753216;11151.442427878736;11506.482208300815;11508.251963622337;11824.822627660764;12088.939555302168;12343.567975120828;12371.072169587136;12373.381330933238;12491.437885295001;10581;10603.204759643211;10735.355878647306;10742.677719668422;10778.083862871743;10396.719549336243;10401.84397234027;10475.52860121281;10662.46687665598;11016.17378696585;10322.2258330624;10595.735106622396;10668.359898406121;10706.197035222545;10707;9111.225545828678;9271.443713377219;9355;9525.52372381392;9625.759356016155;8514.191151840565;8664.263537599374;8717.171868672465;8809.603567839335;8825.38222324431 14:59:30 INFO - PROCESS | 26757 | __end_tp_report 14:59:30 INFO - PROCESS | 26757 | __start_cc_report 14:59:30 INFO - PROCESS | 26757 | _x_x_mozilla_cycle_collect,1043 14:59:30 INFO - PROCESS | 26757 | __end_cc_report 14:59:30 INFO - PROCESS | 26757 | __startTimestamp1486681170720__endTimestamp 14:59:30 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | ------- Summary: start ------- 14:59:30 INFO - PROCESS | 26757 | Number of tests: 6 14:59:30 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | [#0] dojo.html Cycles:165 Average:5467.81 Median:5677.32 stddev:607.39 (10.7%) stddev-sans-first:582.63 14:59:30 INFO - PROCESS | 26757 | Values: 3200.3 3224.6 3239.4 3253.0 3273.9 5401.1 5448.0 5458.5 5493.4 5498.2 5453.3 5490.0 5506.7 5507.6 5507.7 4984.5 4996.8 5021.9 5059.9 5066.3 4944.4 4949.2 4959.9 5040.0 5088.3 4985.9 5097.6 5098.1 5098.8 5100.8 5089.6 5094.1 5095.6 5100.7 5137.0 4847.0 4876.7 4998.1 5015.0 5059.7 5344.1 5347.4 5368.8 5417.9 5437.4 5770.0 5794.7 5817.7 5864.2 5867.5 5770.4 5936.4 5943.5 5954.8 5957.9 5416.6 5417.7 5444.8 5454.1 5462.0 5931.4 5936.5 5975.9 5985.5 5988.5 5561.7 5684.2 5688.3 5690.1 5693.8 5698.8 5761.1 5811.9 5852.3 5886.0 5846.9 5873.2 5874.9 5876.9 5877.4 5878.8 5900.9 5906.1 5908.7 5912.0 4441.0 4463.9 4515.6 4527.9 4538.5 4049.5 4071.4 4079.9 4099.1 4102.3 5607.7 5608.1 5620.3 5630.2 5659.5 5641.7 5669.8 5843.4 5900.7 5924.3 5721.8 5724.9 5726.2 5729.4 5760.9 5128.8 5138.9 5141.2 5145.9 5172.8 5980.3 5985.6 6135.0 6244.4 6267.8 5876.3 5946.5 5949.4 5964.5 5976.8 6232.5 6239.3 6249.4 6262.2 6264.7 5587.5 5608.0 5785.9 5823.3 5839.3 5815.2 5824.1 5862.6 5931.3 5961.6 5762.5 5769.1 5770.5 5774.7 5775.4 5535.9 5757.9 5764.7 5766.7 5767.8 5500.3 5622.2 5666.5 5677.3 5792.0 5738.3 5790.2 5797.1 5799.5 5801.5 5466.7 5509.0 5667.1 5681.0 5684.8 14:59:30 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | [#1] ext.html Cycles:180 Average:54620.33 Median:20596.16 stddev:103847.92 (504.2%) stddev-sans-first:104059.98 14:59:30 INFO - PROCESS | 26757 | Values: 580.5 611.0 626.8 645.8 649.9 32611.3 44077.3 45034.3 45043.0 45126.0 46440.5 46698.0 46927.3 46940.8 46978.0 8331.8 9081.7 9227.4 9229.1 9237.7 8621.8 10795.4 11037.8 11045.3 11333.8 11086.4 11095.3 11137.9 11151.7 11156.0 10962.7 10976.2 10986.8 11043.6 11060.6 10868.7 10952.3 10961.7 10962.8 10969.3 43350.3 43475.6 43560.0 43637.3 43687.0 3593.0 3913.4 4109.3 4154.5 4193.1 32262.8 32304.8 32455.7 32848.0 32875.2 3842.8 3906.4 3919.9 3934.4 3940.0 338854.0 339129.0 340008.0 345924.0 348060.3 40161.0 62143.0 62659.0 62661.4 62772.0 40775.0 40832.0 41108.4 41119.6 41144.0 15386.6 15641.8 15648.8 15651.9 15657.5 11877.3 12086.6 12163.8 13152.3 13250.9 9193.7 9328.9 9345.4 9407.2 9435.2 3450.3 3506.3 3524.9 3578.7 3590.7 1001.6 1074.7 1080.8 1081.7 1119.7 33074.8 33155.7 33246.5 33469.2 33684.8 1081.6 1123.5 1141.1 1181.0 1210.7 14710.4 17050.2 17965.2 18094.3 18915.4 504190.0 504822.0 505255.0 508256.0 508714.0 60578.4 61016.4 61218.4 61251.7 61279.7 1274.6 1330.9 1339.7 1393.0 1409.9 29555.4 30724.8 30986.5 31492.0 32065.5 48803.3 49308.8 49324.0 49342.0 49396.3 254367.0 254444.0 255426.0 255707.0 422569.0 26365.6 28613.0 29506.0 29513.9 30818.8 47269.3 47489.3 47550.8 47729.3 48179.5 40229.6 40326.8 40855.8 41946.6 42054.0 39836.0 39964.8 40252.4 41558.6 41948.8 41592.4 41723.6 42002.4 42749.1 42767.8 35643.0 37599.3 38160.8 38624.6 38879.8 28316.0 28884.0 28949.7 28949.9 29005.4 14:59:30 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | [#2] jquery.html Cycles:180 Average:29024.86 Median:12780.90 stddev:83168.34 (650.7%) stddev-sans-first:83373.89 14:59:30 INFO - PROCESS | 26757 | Values: 405.7 412.8 418.8 426.9 435.2 17118.6 18363.7 19058.8 19973.3 19990.2 19196.2 19447.7 19558.2 19655.6 19705.3 5558.1 5722.0 5825.2 5844.0 5847.1 5671.8 5778.7 5824.6 5850.0 5863.3 5739.3 5794.4 5794.4 5799.1 5800.3 5577.4 5768.5 5773.8 5779.2 5811.7 5236.9 5245.3 5246.1 5253.3 5255.2 22964.5 23003.0 23049.4 23103.3 23210.4 2287.3 2351.4 2385.3 2418.5 2678.9 9729.5 10331.1 10338.4 10403.9 10617.8 1727.8 1873.0 1945.9 1966.3 1997.2 80830.0 82054.2 83970.0 85202.0 85675.1 10681.2 10999.4 11055.4 11121.4 11330.9 15438.0 15532.0 15535.5 15561.3 15598.8 8002.4 8063.8 8065.9 8188.6 8302.3 7695.6 7711.8 7831.9 7957.8 7972.2 4640.2 4674.5 4712.7 4813.4 4875.3 1890.8 1969.3 2010.5 2011.9 2031.3 925.7 1007.2 1014.2 1034.5 1099.7 17554.7 18374.9 18442.3 18668.8 18708.5 936.9 968.1 1005.3 1033.8 1034.1 9382.9 10320.6 10556.1 10577.0 10684.9 493413.0 504539.0 505238.0 506815.0 516694.0 54324.7 90438.5 90735.0 90776.0 92734.5 1020.3 1054.0 1059.0 1072.6 1086.3 15933.3 16523.6 16777.2 16787.6 17113.8 37262.4 39935.6 40193.1 40639.0 41336.0 55260.0 55329.0 55697.4 55753.2 57830.0 8279.0 8405.2 8525.3 8730.7 8780.9 11461.9 12401.9 12629.0 12728.9 13250.5 10750.4 10864.2 11007.2 11033.4 11228.1 10998.8 11081.1 11102.8 11153.6 11487.7 10620.1 10682.1 10976.1 11096.5 11191.3 7535.3 8492.0 8536.6 8552.1 8869.2 11262.9 11363.7 11373.5 11475.5 11628.8 14:59:30 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | [#3] mootools.html Cycles:180 Average:5856.70 Median:4832.32 stddev:3376.99 (69.9%) stddev-sans-first:3369.22 14:59:30 INFO - PROCESS | 26757 | Values: 1315.5 1480.3 1494.3 1645.1 1819.2 7712.3 8767.1 9032.1 9037.1 9279.7 9076.1 9154.7 9158.6 9165.5 9165.9 2496.2 2517.9 2518.5 2524.4 2524.5 2402.1 2506.5 2511.9 2512.3 2515.2 2475.8 2480.9 2487.7 2498.0 2501.4 2410.2 2413.4 2416.1 2435.9 2453.4 2388.6 2401.6 2417.1 2425.9 2427.6 8538.7 8588.5 8595.9 8914.7 9095.0 5430.3 5642.3 5643.0 5645.4 5659.8 3370.8 3415.0 3445.3 3460.8 3622.2 1055.8 1069.9 1070.9 1085.6 1086.1 12676.0 12701.5 12708.9 12793.6 12798.7 4325.2 4587.6 4721.7 4823.1 4824.5 9986.7 9998.0 9999.8 10007.9 10011.9 5311.3 5313.6 5314.7 5315.6 5322.1 4420.8 4455.7 4958.6 5013.5 5107.5 3919.7 4014.3 4066.3 4106.7 4110.0 1158.2 1189.2 1189.6 1204.1 1204.6 864.3 875.6 883.3 884.3 919.1 5586.2 5586.4 5646.4 5683.9 5846.2 897.9 902.8 917.2 927.3 937.7 3572.8 3601.6 3632.2 3732.1 3802.6 10837.2 11209.5 11210.3 11312.1 11343.4 11151.4 11181.6 11248.9 11273.4 11277.9 8250.4 8457.7 8681.2 8683.8 8690.6 5383.2 5418.3 5515.8 5589.2 5605.4 9766.7 10057.9 10073.4 10113.2 10527.4 10450.7 10490.1 10540.3 10610.2 10656.8 7759.0 7900.6 7963.5 8118.6 8255.0 8650.4 8681.5 8705.4 8750.6 8761.3 7869.6 7892.0 7893.6 7901.5 7997.7 7789.3 7800.8 7838.5 7852.7 8031.6 6868.3 6927.1 6942.1 6981.4 7042.1 4751.6 4840.2 4845.9 4873.9 4875.6 4751.4 4755.5 4914.6 4956.0 5095.1 14:59:30 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | [#4] prototype.html Cycles:180 Average:4685.29 Median:5309.34 stddev:1375.41 (25.9%) stddev-sans-first:1340.18 14:59:30 INFO - PROCESS | 26757 | Values: 347.3 352.1 355.6 363.2 364.0 5232.5 5310.8 5311.7 5344.3 5363.7 5005.0 5119.8 5124.0 5240.7 5257.8 4143.7 4155.3 4163.8 4180.0 4189.3 4167.3 4180.0 4188.6 4192.1 4205.3 4079.8 4094.3 4106.4 4116.0 4150.3 4103.4 4109.6 4114.0 4117.6 4123.7 3615.3 3630.8 3641.7 3667.2 3690.9 5020.7 5193.8 5209.9 5244.3 5253.2 4678.6 4689.2 4700.9 4710.9 4760.2 5519.2 5522.8 5536.8 5540.3 5553.6 3816.5 4018.4 4022.6 4034.7 4050.1 5682.5 5707.1 5722.6 5733.3 5752.9 4114.9 4116.1 4120.2 4136.1 4142.6 4208.4 4211.2 4219.3 4220.6 4226.6 4540.5 4723.0 4734.8 4735.1 4751.1 5529.8 5540.0 5544.6 5556.5 5559.8 1353.3 1393.8 1406.0 1417.6 1431.4 938.6 973.8 984.9 991.2 998.2 5235.2 5265.7 5272.3 5292.3 5307.9 5365.6 5452.2 5499.5 5525.7 5537.3 5140.9 5190.0 5214.2 5225.9 5240.1 2862.6 2868.9 2880.9 2881.7 2884.2 5643.4 5659.7 5673.7 5676.7 5954.4 5790.5 5810.4 5825.2 5849.6 5862.7 5972.7 5981.6 5995.5 6004.6 6032.9 5554.2 5695.9 5714.9 5716.8 5734.5 5672.9 5679.4 5692.7 5705.0 5718.7 5739.9 6021.0 6022.5 6032.4 6039.4 4141.0 4165.7 4168.8 4170.9 4187.5 5752.5 5771.4 5786.3 5808.9 5819.5 5590.7 5603.8 5604.5 5609.5 5707.5 5592.5 5595.9 5600.6 5624.0 5631.7 5329.8 5389.8 5470.3 5610.8 5638.5 5600.8 5604.3 5617.4 5627.5 5630.8 5493.4 5495.2 5504.7 5529.0 5546.6 14:59:30 INFO - PROCESS | 26757 | 14:59:30 INFO - PROCESS | 26757 | [#5] yui.html Cycles:180 Average:18137.85 Median:32253.84 stddev:25270.69 (78.3%) stddev-sans-first:25307.79 14:59:30 INFO - PROCESS | 26757 | Values: 735.3 756.6 769.7 803.7 841.2 15011.5 15842.3 15855.8 15910.8 15917.0 14815.3 15224.4 15281.8 15751.1 15761.1 681.1 699.3 832.2 841.0 849.6 841.0 857.8 857.9 859.0 859.4 896.7 896.7 896.8 896.8 896.9 877.7 882.6 884.3 885.3 885.4 650.7 657.0 658.0 659.9 660.7 14468.6 14574.0 14605.3 14611.7 15999.6 13919.7 14004.6 14027.5 14506.7 14779.4 11404.0 11526.4 11757.8 11970.9 11978.7 3537.2 3633.7 3679.4 3734.2 3767.5 65847.7 66535.0 66815.0 67001.7 68528.3 10892.8 10915.9 10936.7 10939.6 11285.5 17365.1 17420.7 17444.6 17480.5 17860.4 6970.4 6976.4 7011.2 7072.6 7308.3 3944.0 3945.6 3981.1 4018.1 4065.6 3414.3 3545.4 3546.8 3554.9 3560.0 609.3 614.8 616.0 617.3 626.1 680.6 721.5 739.1 741.4 756.9 8325.5 8713.7 8772.3 8968.5 9003.4 653.9 725.7 740.4 750.8 765.5 4051.5 4266.4 4352.5 4356.3 4413.9 90635.0 90979.0 91554.0 94213.5 96168.5 75691.2 80122.6 80308.0 82168.2 84492.0 73994.0 74393.6 74474.6 74646.6 74828.0 7989.0 8184.7 8412.0 8454.2 8469.3 50095.7 50391.2 50539.5 51223.7 51425.0 63857.0 65938.3 67280.3 68361.7 69400.3 10754.4 11151.4 11506.5 11508.3 11824.8 12088.9 12343.6 12371.1 12373.4 12491.4 10581.0 10603.2 10735.4 10742.7 10778.1 10396.7 10401.8 10475.5 10662.5 11016.2 10322.2 10595.7 10668.4 10706.2 10707.0 9111.2 9271.4 9355.0 9525.5 9625.8 8514.2 8664.3 8717.2 8809.6 8825.4 14:59:30 INFO - PROCESS | 26757 | -------- Summary: end -------- 14:59:30 INFO - PROCESS | 26757 | 14:59:31 INFO - TEST-INFO | 26757: exit 0 14:59:31 INFO - TEST-OK | dromaeo_css | took 1113825ms 14:59:31 INFO - TEST-START | kraken 14:59:31 INFO - operating with platform_type : linux_ 14:59:31 INFO - Initialising browser for kraken test... 14:59:31 INFO - TEST-INFO | started process 27054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp18CNyQ/profile http://localhost:57644/getInfo.html) 14:59:35 INFO - PROCESS | 27054 | __metrics Screen width/height:1600/1200 14:59:35 INFO - PROCESS | 27054 | colorDepth:24 14:59:35 INFO - PROCESS | 27054 | Browser inner width/height: 1024/697 14:59:35 INFO - PROCESS | 27054 | __metrics 14:59:35 INFO - PROCESS | 27054 | 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" 14:59:35 INFO - PROCESS | 27054 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:59:36 INFO - PROCESS | 27054 | console.error: PushService: 14:59:36 INFO - PROCESS | 27054 | stateChangeProcessEnqueue: Error transitioning state 14:59:36 INFO - PROCESS | 27054 | UnknownError 14:59:36 INFO - TEST-INFO | 27054: exit 0 14:59:36 INFO - Browser initialized. 14:59:36 INFO - Running cycle 1/1 for kraken test... 14:59:36 INFO - TEST-INFO | started process 27144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp18CNyQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:48 INFO - PROCESS | 27144 | RSS: Main: 145068032 14:59:48 INFO - PROCESS | 27144 | 14:59:50 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57644/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:51 INFO - PROCESS | 27144 | RSS: Main: 186568704 14:59:51 INFO - PROCESS | 27144 | 14:59:54 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57644/tests/kraken/driver.html?testName=audio-dft) 14:59:54 INFO - PROCESS | 27144 | RSS: Main: 176242688 14:59:54 INFO - PROCESS | 27144 | 14:59:57 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57644/tests/kraken/driver.html?testName=audio-fft) 14:59:58 INFO - PROCESS | 27144 | RSS: Main: 267354112 14:59:58 INFO - PROCESS | 27144 | 15:00:00 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57644/tests/kraken/driver.html?testName=audio-oscillator) 15:00:01 INFO - PROCESS | 27144 | RSS: Main: 173883392 15:00:01 INFO - PROCESS | 27144 | 15:00:03 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:00:03 INFO - PROCESS | 27144 | RSS: Main: 176144384 15:00:03 INFO - PROCESS | 27144 | 15:00:06 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57644/tests/kraken/driver.html?testName=imaging-darkroom) 15:00:07 INFO - PROCESS | 27144 | RSS: Main: 215261184 15:00:07 INFO - PROCESS | 27144 | 15:00:10 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57644/tests/kraken/driver.html?testName=imaging-desaturate) 15:00:11 INFO - PROCESS | 27144 | RSS: Main: 213864448 15:00:11 INFO - PROCESS | 27144 | 15:00:13 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57644/tests/kraken/driver.html?testName=json-parse-financial) 15:00:14 INFO - PROCESS | 27144 | RSS: Main: 213110784 15:00:14 INFO - PROCESS | 27144 | 15:00:15 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:00:16 INFO - PROCESS | 27144 | RSS: Main: 175362048 15:00:16 INFO - PROCESS | 27144 | 15:00:18 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:00:18 INFO - PROCESS | 27144 | RSS: Main: 182259712 15:00:18 INFO - PROCESS | 27144 | 15:00:20 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:00:21 INFO - PROCESS | 27144 | RSS: Main: 188395520 15:00:21 INFO - PROCESS | 27144 | 15:00:23 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:00:24 INFO - PROCESS | 27144 | RSS: Main: 196829184 15:00:24 INFO - PROCESS | 27144 | 15:00:27 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:00:27 INFO - PROCESS | 27144 | RSS: Main: 192835584 15:00:27 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57644/tests/kraken/driver.html?testName=ai-astar) 15:00:29 INFO - PROCESS | 27144 | RSS: Main: 244527104 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | __start_tp_report 15:00:29 INFO - PROCESS | 27144 | _x_x_mozilla_page_load 15:00:29 INFO - PROCESS | 27144 | _x_x_mozilla_page_load_details 15:00:29 INFO - PROCESS | 27144 | |i|pagename|runs| 15:00:29 INFO - PROCESS | 27144 | |0;ai-astar;102;112;111;111;110;113;111;111;111;110 15:00:29 INFO - PROCESS | 27144 | |1;audio-beat-detection;147;119;121;154;118;124;117;117;148;119 15:00:29 INFO - PROCESS | 27144 | |2;audio-dft;171;162;161;162;162;161;162;162;160;161 15:00:29 INFO - PROCESS | 27144 | |3;audio-fft;74;74;74;117;75;75;75;75;97;76 15:00:29 INFO - PROCESS | 27144 | |4;audio-oscillator;82;82;112;81;81;83;97;82;83;115 15:00:29 INFO - PROCESS | 27144 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;117;116 15:00:29 INFO - PROCESS | 27144 | |6;imaging-darkroom;145;145;146;146;145;146;146;146;145;145 15:00:29 INFO - PROCESS | 27144 | |7;imaging-desaturate;84;85;84;85;84;87;85;85;85;84 15:00:29 INFO - PROCESS | 27144 | |8;json-parse-financial;51;54;51;51;51;52;51;51;51;51 15:00:29 INFO - PROCESS | 27144 | |9;json-stringify-tinderbox;59;61;59;60;61;60;60;60;60;59 15:00:29 INFO - PROCESS | 27144 | |10;stanford-crypto-aes;75;75;75;76;74;77;74;74;78;75 15:00:29 INFO - PROCESS | 27144 | |11;stanford-crypto-ccm;126;129;127;127;135;135;123;121;177;131 15:00:29 INFO - PROCESS | 27144 | |12;stanford-crypto-pbkdf2;159;158;156;158;158;161;160;163;157;156 15:00:29 INFO - PROCESS | 27144 | |13;stanford-crypto-sha256-iterative;63;63;64;62;63;66;63;62;65;63 15:00:29 INFO - PROCESS | 27144 | __end_tp_report 15:00:29 INFO - PROCESS | 27144 | __start_cc_report 15:00:29 INFO - PROCESS | 27144 | _x_x_mozilla_cycle_collect,1603 15:00:29 INFO - PROCESS | 27144 | __end_cc_report 15:00:29 INFO - PROCESS | 27144 | __startTimestamp1486681229786__endTimestamp 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | ------- Summary: start ------- 15:00:29 INFO - PROCESS | 27144 | Number of tests: 14 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.01 (2.7%) stddev-sans-first:0.93 15:00:29 INFO - PROCESS | 27144 | Values: 102.0 112.0 111.0 111.0 110.0 113.0 111.0 111.0 111.0 110.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:122.50 stddev:14.92 (12.2%) stddev-sans-first:14.23 15:00:29 INFO - PROCESS | 27144 | Values: 147.0 119.0 121.0 154.0 118.0 124.0 117.0 117.0 148.0 119.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:3.10 (1.9%) stddev-sans-first:0.73 15:00:29 INFO - PROCESS | 27144 | Values: 171.0 162.0 161.0 162.0 162.0 161.0 162.0 162.0 160.0 161.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:14.41 (19.2%) stddev-sans-first:15.04 15:00:29 INFO - PROCESS | 27144 | Values: 74.0 74.0 74.0 117.0 75.0 75.0 75.0 75.0 97.0 76.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.00 stddev:13.37 (16.3%) stddev-sans-first:13.88 15:00:29 INFO - PROCESS | 27144 | Values: 82.0 82.0 112.0 81.0 81.0 83.0 97.0 82.0 83.0 115.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:00:29 INFO - PROCESS | 27144 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 15:00:29 INFO - PROCESS | 27144 | Values: 145.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 15:00:29 INFO - PROCESS | 27144 | Values: 84.0 85.0 84.0 85.0 84.0 87.0 85.0 85.0 85.0 84.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 15:00:29 INFO - PROCESS | 27144 | Values: 51.0 54.0 51.0 51.0 51.0 52.0 51.0 51.0 51.0 51.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 15:00:29 INFO - PROCESS | 27144 | Values: 59.0 61.0 59.0 60.0 61.0 60.0 60.0 60.0 60.0 59.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:1.34 (1.8%) stddev-sans-first:1.41 15:00:29 INFO - PROCESS | 27144 | Values: 75.0 75.0 75.0 76.0 74.0 77.0 74.0 74.0 78.0 75.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:130.00 stddev:16.09 (12.4%) stddev-sans-first:16.86 15:00:29 INFO - PROCESS | 27144 | Values: 126.0 129.0 127.0 127.0 135.0 135.0 123.0 121.0 177.0 131.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.50 stddev:2.22 (1.4%) stddev-sans-first:2.35 15:00:29 INFO - PROCESS | 27144 | Values: 159.0 158.0 156.0 158.0 158.0 161.0 160.0 163.0 157.0 156.0 15:00:29 INFO - PROCESS | 27144 | 15:00:29 INFO - PROCESS | 27144 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 15:00:29 INFO - PROCESS | 27144 | Values: 63.0 63.0 64.0 62.0 63.0 66.0 63.0 62.0 65.0 63.0 15:00:29 INFO - PROCESS | 27144 | -------- Summary: end -------- 15:00:29 INFO - PROCESS | 27144 | 15:00:30 INFO - TEST-INFO | 27144: exit 0 15:00:30 INFO - TEST-OK | kraken | took 59376ms 15:00:30 INFO - SUITE-END | took 1173s 15:00:30 INFO - Completed test suite (00:19:33) 15:00:30 INFO - javascript benchmark 15:00:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3200.327931134462, 3224.6130464344283, 3239.3683231769783, 3252.951205731913, 3273.901782946511, 5401.054815407303, 5447.972760136204, 5458.5087342139195, 5493.395726470085, 5498.202760599711, 5453.291072160613, 5490.0, 5506.669599824013, 5507.5593952483805, 5507.669539827613, 4984.501549845014, 4996.800127994876, 5021.899562008758, 5059.949400505985, 5066.341375621164, 4944.381952255968, 4949.208126699728, 4959.925601115986, 5039.974800125994, 5088.313077734514, 4985.900281994358, 5097.617678674096, 5098.107831129556, 5098.821541246057, 5100.821471248507, 5089.592832573385, 5094.057599344133, 5095.617828662865, 5100.69395836251, 5137.0496458154985, 4846.975765121187, 4876.731779752112, 4998.10034193845, 5014.971930754186, 5059.696418214919, 5344.144936810092, 5347.41178470368, 5368.758405871745, 5417.918731219035, 5437.429069947678, 5770.04794208955, 5794.6961933565035, 5817.650940943557, 5864.179014937912, 5867.471927526501, 5770.394108618619, 5936.376680448577, 5943.524518038546, 5954.821355359303, 5957.880842383128, 5416.593755468316, 5417.729113544347, 5444.754986025639, 5454.10007348791, 5461.972690136524, 5931.377205393458, 5936.465718085393, 5975.910361344583, 5985.521158307412, 5988.520918326523, 5561.6663000220115, 5684.175794509773, 5688.260526131659, 5690.146478028329, 5693.82918512437, 5698.8290351289525, 5761.0782274836665, 5811.88376232473, 5852.268466441695, 5885.970570147122, 5846.941530584725, 5873.236479257669, 5874.853128671732, 5876.9118463223085, 5877.38287479817, 5878.764849406061, 5900.852478687982, 5906.143609176645, 5908.675022873783, 5912.0, 4440.955590444054, 4463.933041004388, 4515.616172625298, 4527.909441811145, 4538.523455037173, 4049.453323801249, 4071.3892916062828, 4079.8776036718946, 4099.098198396348, 4102.2821006323775, 5607.663540187602, 5608.074667679787, 5620.269364982608, 5630.211770352154, 5659.518940890071, 5641.661500309994, 5669.773209071674, 5843.415658434123, 5900.704964751745, 5924.259467566554, 5721.799737009184, 5724.856878578069, 5726.169705392695, 5729.427057294321, 5760.884782304331, 5128.8461346159675, 5138.897222055538, 5141.151709967813, 5145.897082058413, 5172.767225474788, 5980.3421623622235, 5985.551083668743, 6135.049067394561, 6244.4380005798785, 6267.780627678009, 5876.265466816648, 5946.494547963299, 5949.434803693643, 5964.493018093337, 5976.820695379146, 6232.532560057924, 6239.313675495601, 6249.406306400884, 6262.1546091278915, 6264.655443950444, 5587.525060369751, 5607.971960140173, 5785.942140578709, 5823.330317013598, 5839.270091238595, 5815.185873977562, 5824.097264923944, 5862.648241105548, 5931.347551769216, 5961.612495187799, 5762.538996880324, 5769.134629805562, 5770.451807078321, 5774.711264436845, 5775.393583673654, 5535.8892822144135, 5757.8560535986935, 5764.682942438206, 5766.682832444088, 5767.826965191051, 5500.312460942382, 5622.212890195294, 5666.490015898589, 5677.31872175325, 5792.0443126885275, 5738.254026976467, 5790.160426738184, 5797.072468405204, 5799.5070419014855, 5801.535877129904, 5466.671999680032, 5509.035918714289, 5667.149927510906, 5681.034224181816, 5684.8294551163535], "value": 5428.110704576536, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.4949693766424, 611.0376157551856, 626.8432891777056, 645.7804346522183, 649.9220093588771, 32611.347773044527, 44077.33883991743, 45034.32448513275, 45043.0, 45126.0, 46440.53559464405, 46698.0, 46927.296090558586, 46940.76529617347, 46978.0, 8331.791705207388, 9081.682141125062, 9227.354085214038, 9229.123233292827, 9237.722868313962, 8621.784455388633, 10795.406252656101, 11037.83443248352, 11045.28205666633, 11333.773324533504, 11086.390248536327, 11095.334279943228, 11137.944310278477, 11151.665450036471, 11156.0, 10962.725931851688, 10976.231663783537, 10986.835197472044, 11043.558257669683, 11060.612878549253, 10868.67393978182, 10952.288101273392, 10961.725956851064, 10962.835557466644, 10969.341839489576, 43350.349744753854, 43475.56524434747, 43560.0, 43637.345439818426, 43687.0, 3593.0, 3913.4325522799036, 4109.2808758467145, 4154.543000269968, 4193.077522944947, 32262.838685806655, 32304.83847580747, 32455.6754432455, 32848.0, 32875.17812054694, 3842.846286148551, 3906.3945088511327, 3919.8824035278985, 3934.429507721364, 3940.0, 338854.0, 339129.0, 340008.0, 345924.0, 348060.25969870243, 40161.0, 62143.0, 62659.0, 62661.37338626647, 62772.0, 40775.0, 40832.0, 41108.38337424941, 41119.58880411217, 41144.0, 15386.615334616725, 15641.765373519407, 15648.843511564739, 15651.921740391224, 15657.451989180325, 11877.346745929057, 12086.637400877988, 12163.756724865452, 13152.276624785538, 13250.867491324963, 9193.724188274362, 9328.860067098998, 9345.439273643604, 9407.247420206368, 9435.24518038569, 3450.3099380124077, 3506.3162683276514, 3524.8766293179615, 3578.6958108561066, 3590.730695197871, 1001.6494227020485, 1074.6561100447782, 1080.8324709670014, 1081.6603983288774, 1119.7032786311634, 33074.8346258272, 33155.66844331574, 33246.50130248048, 33469.16327091842, 33684.83157584245, 1081.551156270139, 1123.5112725964068, 1141.073682745742, 1181.0433548825479, 1210.661014915825, 14710.411583536752, 17050.209727978632, 17965.191566379282, 18094.276228950694, 18915.432537023913, 504190.0, 504822.0, 505255.0, 508256.0, 508714.0, 60578.39421605816, 61016.38983610196, 61218.38781612216, 61251.6937415319, 61279.693601531704, 1274.6367285323638, 1330.8868746156686, 1339.7320535892861, 1392.9512467063605, 1409.9013069085065, 29555.408891822473, 30724.846375768873, 30986.53520197154, 31492.0, 32065.51901721523, 48803.26795098148, 49308.794928329546, 49324.01351973012, 49342.0, 49396.259056114905, 254367.0, 254444.0, 255426.0, 255707.0, 422569.0, 26365.60451593266, 28613.0, 29506.0, 29513.85243073771, 30818.84590577033, 47269.2909606363, 47489.28766068581, 47550.76224618993, 47729.28406073981, 48179.5182048189, 40229.597704023756, 40326.798366007984, 40855.795721021204, 41946.58053419549, 42054.0, 39836.0, 39964.800175998935, 40252.3962140574, 41558.58441415547, 41948.790256049746, 41592.37611435771, 41723.582764171966, 42002.36996444994, 42749.14501709886, 42767.786161068994, 35643.0, 37599.314033079674, 38160.80919595384, 38624.613753863225, 38879.80560097181, 28316.0, 28884.0, 28949.7105028947, 28949.855250723613, 29005.41989160163], "value": 19454.972232841155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.68153999110706, 412.8286760994188, 418.76758399088504, 426.94449721536205, 435.17099924643566, 17118.572035699115, 18363.724544131834, 19058.809411905877, 19973.300934467297, 19990.200391984323, 19196.232150713953, 19447.708284375745, 19558.217671293132, 19655.606887862235, 19705.31031413901, 5558.110702287625, 5721.971390143064, 5825.213596164527, 5843.9707801461145, 5847.093700476433, 5671.829845104633, 5778.682172480512, 5824.592278540504, 5850.0, 5863.2670916135485, 5739.311282646088, 5794.362620111784, 5794.420557944214, 5799.130130480441, 5800.303963524362, 5577.358603760538, 5768.480836724694, 5773.826785196451, 5779.190913272124, 5811.6803575803315, 5236.947630523684, 5245.31810864589, 5246.134387826004, 5253.264542963988, 5255.185446255837, 22964.54070918589, 23003.0, 23049.423764406023, 23103.306900792835, 23210.41973950648, 2287.325239054483, 2351.388638953867, 2385.3082606044227, 2418.4921166555046, 2678.8836818913037, 9729.513524323755, 10331.12185464229, 10338.431386273753, 10403.895961040369, 10617.84073238902, 1727.7840269966255, 1872.9906350468161, 1945.863789534733, 1966.252823926913, 1997.2011195521761, 80830.0, 82054.17945820525, 83970.0, 85202.0, 85675.14324856797, 10681.198910081775, 10999.395033273247, 11055.447227638746, 11121.443927803577, 11330.94334528322, 15438.0, 15532.0, 15535.533933981998, 15561.299741511659, 15598.766018509732, 8002.399820013522, 8063.838723225503, 8065.919340806517, 8188.590570471452, 8302.252797248277, 7695.576743279174, 7711.768646940601, 7831.921680783234, 7957.840843183104, 7972.162922893129, 4640.164770341371, 4674.532546745366, 4712.740799256074, 4813.446453657874, 4875.293082503017, 1890.8298253157282, 1969.251684359934, 2010.497375656086, 2011.8692285001428, 2031.339814560274, 925.6991477769752, 1007.2445665750687, 1014.2190513304714, 1034.4672493665619, 1099.70308016835, 17554.736678949826, 18374.908125459286, 18442.262309507736, 18668.81331186698, 18708.53228669267, 936.9250459963187, 968.1045033344128, 1005.2812239248972, 1033.7801394354733, 1034.110664828262, 9382.85925711115, 10320.587176512856, 10556.102731267929, 10577.0, 10684.893151068545, 493413.0, 504539.0, 505238.0, 506815.0, 516694.0, 54324.72837635865, 90438.54780726186, 90735.0, 90776.0, 92734.53632731792, 1020.3469779341079, 1054.0144964458257, 1058.9894101058892, 1072.5870539842217, 1086.2993369276771, 15933.283002264694, 16523.586910327336, 16777.161141942608, 16787.580310492336, 17113.828861711223, 37262.44106338461, 39935.60064399319, 40193.12009655944, 40639.0, 41336.0, 55260.0, 55329.0, 55697.44302556923, 55753.16370254368, 57830.0, 8278.958605206935, 8405.243528082501, 8525.275351594935, 8730.738077857675, 8780.868286975829, 11461.942690286494, 12401.875981240071, 12629.0, 12728.936355318165, 13250.536231232247, 10750.354978701303, 10864.239503235014, 11007.229493935347, 11033.393163375771, 11228.101751859995, 10998.780024399628, 11081.11351091927, 11102.833457497982, 11153.553857845594, 11487.655370338904, 10620.09729172998, 10682.092022178202, 10976.12191024732, 11096.500657470595, 11191.272567283426, 7535.284148005931, 8491.95754021226, 8536.615852286786, 8552.059273480038, 8869.157430044135, 11262.887371126511, 11363.715907102389, 11373.488193031168, 11475.48360323804, 11628.825567616661], "value": 9125.158574022918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.4935349890288, 1480.274665413947, 1494.3424893047059, 1645.1445248470795, 1819.2359209132162, 7712.305892469677, 8767.079456657055, 9032.051634578373, 9037.096290370959, 9279.721608351743, 9076.092390760938, 9154.679586214485, 9158.633654653822, 9165.541722913844, 9165.908340916589, 2496.201215611001, 2517.949641007179, 2518.49630073985, 2524.394145405108, 2524.4951009798024, 2402.0752010476003, 2506.486170335077, 2511.8744062796877, 2512.2965569640437, 2515.220281712666, 2475.814313926454, 2480.875956202192, 2487.676602041732, 2498.0, 2501.4121681404854, 2410.240774156153, 2413.432843281836, 2416.0818888822137, 2435.866027368494, 2453.41118131648, 2388.5700573896693, 2401.6037353836596, 2417.10567090176, 2425.890834912433, 2427.5873101572774, 8538.743837684817, 8588.484690918565, 8595.871061934076, 8914.73255802327, 9095.045020272843, 5430.321209848769, 5642.294713160855, 5643.0, 5645.350784659776, 5659.801906933238, 3370.831458427069, 3414.9658503415144, 3445.3453843769853, 3460.757746957714, 3622.2212224371888, 1055.841623756435, 1069.9358038517637, 1070.9357438553711, 1085.6200329884557, 1086.0605576176629, 12676.0, 12701.491940322376, 12708.93645531785, 12793.61619151427, 12798.680032999157, 4325.178216138924, 4587.61005314552, 4721.6694831362165, 4823.131836269435, 4824.49342819006, 9986.700398988041, 9997.950010249902, 9999.750006249902, 10007.899921000842, 10011.899881001242, 5311.282976798083, 5313.628046036741, 5314.734263286898, 5315.6279060465395, 5322.0952438085615, 4420.778961051935, 4455.710378825366, 4958.553730164303, 5013.473585273567, 5107.489251074863, 3919.7060220483577, 4014.297497937849, 4066.3087275163293, 4106.650934670586, 4110.0, 1158.2182027131653, 1189.1913498820884, 1189.6193218170276, 1204.084895479442, 1204.6325870609373, 864.321507616518, 875.6191056890145, 883.3066043156092, 884.2925659472396, 919.0579655852671, 5586.190002449704, 5586.385497595261, 5646.435356464321, 5683.8863222736145, 5846.239988801429, 897.8742975983367, 902.7878448564582, 917.1842443697917, 927.2521297354535, 937.7340590203307, 3572.7856328620364, 3601.603823579404, 3632.20091579852, 3732.1042949692423, 3802.6007269236884, 10837.18721095921, 11209.495572699248, 11210.327380357205, 11312.095032397388, 11343.376114313627, 11151.38667373286, 11181.608643697431, 11248.931351521756, 11273.436328183558, 11277.887221127849, 8250.422470427013, 8457.746267611981, 8681.218690317775, 8683.826323473495, 8690.608922598498, 5383.219433182088, 5418.349798024262, 5515.806946756844, 5589.161625756006, 5605.355384130877, 9766.706998790047, 10057.949710251401, 10073.361752750949, 10113.241506886865, 10527.420991845522, 10450.738731531772, 10490.055894969184, 10540.314879532805, 10610.151187905103, 10656.786864262516, 7758.9612051939375, 7900.6049697513745, 7963.482373645695, 8118.5940702963435, 8254.958725206576, 8650.351223658377, 8681.522516261666, 8705.434146780439, 8750.649974001224, 8761.25529330014, 7869.645865935932, 7891.960540197262, 7893.644785984759, 7901.486403383762, 7997.720079797179, 7789.300902782914, 7800.84398312042, 7838.490498117604, 7852.685892564234, 8031.638576264199, 6868.347506986828, 6927.099477067949, 6942.097527321618, 6981.441484681111, 7042.084529011196, 4751.6436267279405, 4840.1529732296, 4845.927311090407, 4873.926891096566, 4875.6099512038245, 4751.40607424072, 4755.476897541337, 4914.631402644887, 4956.0, 5095.108356037753], "value": 4658.719202931166, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.2863265988394, 352.0599998005326, 355.5502289603651, 363.2100182103923, 363.95450568678916, 5232.502912223337, 5310.8141215057485, 5311.73441327934, 5344.331958505187, 5363.731813409328, 5004.974975125119, 5119.820806271781, 5123.974380128104, 5240.659357141783, 5257.763400646971, 4143.70994030418, 4155.314373128445, 4163.812628431712, 4179.958200417987, 4189.266878296301, 4167.3332266837315, 4179.958200418003, 4188.623023927861, 4192.119654872466, 4205.285101532747, 4079.755214687128, 4094.34490481523, 4106.363513655373, 4115.991582062399, 4150.252954468195, 4103.425520427142, 4109.6438175402045, 4114.033202197481, 4117.5882411758885, 4123.670106391482, 3615.331163734691, 3630.7821530708243, 3641.7086633069557, 3667.21154951684, 3690.8892733218045, 5020.748962551895, 5193.766280517386, 5209.947900520984, 5244.325394049024, 5253.212018197301, 4678.602318802906, 4689.226277664181, 4700.929486057712, 4710.929336059962, 4760.190767569521, 5519.227308176858, 5522.796777868866, 5536.778528858841, 5540.252065971123, 5553.6390134641115, 3816.484774555455, 4018.3771515415156, 4022.597740225983, 4034.677225821927, 4050.0684842486394, 5682.545396368322, 5707.143928410772, 5722.62802917809, 5733.312002559678, 5752.8849423011725, 4114.868411186948, 4116.135611521614, 4120.237756015147, 4136.131412403369, 4142.5857414258335, 4208.431861698693, 4211.157768446323, 4219.261629214937, 4220.620144186976, 4226.556211597799, 4540.500544940054, 4722.952770472251, 4734.834280800224, 4735.147673418817, 4751.1470526494695, 5529.751161197756, 5539.972300138554, 5544.556435485151, 5556.472135147235, 5559.833205003856, 1353.29628593133, 1393.7769956806862, 1405.9876888640163, 1417.6172433442912, 1431.4059665239017, 938.6292414496236, 973.7711637765119, 984.8969154546953, 991.2268430624125, 998.1814911772423, 5235.162374020215, 5265.684058956398, 5272.288241087481, 5292.311999440049, 5307.867303317371, 5365.624406291522, 5452.236686863842, 5499.477549632778, 5525.696086715189, 5537.2524709163745, 5140.9154507295325, 5190.0, 5214.243934629533, 5225.921611175835, 5240.135377662643, 2862.6421697287838, 2868.942621147565, 2880.942381152365, 2881.697421770684, 2884.206843118159, 5643.435656434323, 5659.745311460994, 5673.659580425106, 5676.68778217202, 5954.427343593896, 5790.507806836382, 5810.360860305447, 5825.2135961644635, 5849.61977471463, 5862.736176871966, 5972.686009077996, 5981.551383646244, 5995.460408563163, 6004.579679422399, 6032.91407546637, 5554.222408862682, 5695.914561281667, 5714.857128571819, 5716.771329146787, 5734.455226753452, 5672.886542269214, 5679.403662615366, 5692.743826527899, 5705.0, 5718.656880587178, 5739.885202295847, 6020.969895150496, 6022.518198544019, 6032.366601506778, 6039.396060393926, 4141.0, 4165.687573431944, 4168.812403441913, 4170.895727606834, 4187.455630768102, 5752.453516915886, 5771.422857714195, 5786.3056433228285, 5808.925348810483, 5819.534437244925, 5590.748416321357, 5603.789656151447, 5604.495595396434, 5609.467100625434, 5707.546934104973, 5592.468715472024, 5595.8880822384135, 5600.635958662674, 5623.98768221724, 5631.746571404215, 5329.827437963641, 5389.8113566025, 5470.288862448016, 5610.7755689773585, 5638.4925356718095, 5600.803971860965, 5604.2539155814175, 5617.382087970238, 5627.549796016391, 5630.831075067755, 5493.423190565093, 5495.203195536705, 5504.669719816824, 5529.0, 5546.58400619947], "value": 4254.245338974102, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.3308489274759, 756.557413912861, 769.7036640893256, 803.6624617660582, 841.1546395872156, 15011.474598389059, 15842.28709708063, 15855.84144158558, 15910.761338579916, 15917.04497730137, 14815.259237038132, 15224.391024359013, 15281.770773438408, 15751.054936703806, 15761.133137677423, 681.0567364200593, 699.3321378083944, 832.2301870769544, 840.9621567029499, 849.6134258912211, 840.970566030189, 857.7898414888361, 857.8927634045745, 858.9570521473933, 859.4198915731887, 896.6771962093641, 896.735463038402, 896.7758060484879, 896.8027034052498, 896.8878890138733, 877.7366789962986, 882.6425297754356, 884.2881480408269, 885.3050355470924, 885.3979294080023, 650.6779144323543, 657.0308794528081, 657.9934200658028, 659.8911179655352, 660.6960798032862, 14468.638284042878, 14574.0, 14605.269736513132, 14611.707765844623, 15999.600009999727, 13919.719106138615, 14004.579862604138, 14027.509037183752, 14506.70986580273, 14779.408823647042, 11404.0, 11526.366049867254, 11757.764844703059, 11970.88029119715, 11978.700532486757, 3537.204129070964, 3633.709303255733, 3679.356112680297, 3734.1971476132762, 3767.472553842464, 65847.67076164589, 66535.0, 66815.0, 67001.66499167473, 68528.31471685269, 10892.760232811765, 10915.890841091647, 10936.726581835359, 10939.617113400993, 11285.492152853141, 17365.131743412778, 17420.738688919675, 17444.563885902953, 17480.47558573245, 17860.374886878897, 6970.372666460043, 6976.407005404598, 7011.193712723102, 7072.575645461289, 7308.30571095745, 3943.960560394417, 3945.5659877413464, 3981.144054028398, 4018.0959284161413, 4065.57311482296, 3414.283000569908, 3545.4327307630656, 3546.7871927684423, 3554.9466757998653, 3560.038789526813, 609.250621735268, 614.8493619063358, 615.9692015399302, 617.3209469583422, 626.1234272019119, 680.6222546486747, 721.4661150748514, 739.1315204634533, 741.3846507398846, 756.856197322507, 8325.500469971821, 8713.738587842376, 8772.298216142693, 8968.461892286483, 9003.414778039407, 653.9280679125293, 725.742361461684, 740.4261697184725, 750.7897788619196, 765.517723833981, 4051.453053837753, 4266.424032755538, 4352.521222665504, 4356.324769660708, 4413.933790993137, 90635.0, 90979.0, 91554.0, 94213.5289323549, 96168.51915740517, 75691.24308756842, 80122.59938700269, 80308.0, 82168.17831821725, 84492.0, 73994.0, 74393.62803186057, 74474.62762686152, 74646.62676686581, 74828.0, 7989.0, 8184.685202492999, 8412.0, 8454.196851299117, 8469.280111190617, 50095.74952125216, 50391.24413133733, 50539.49460505348, 51223.74388128035, 51425.0, 63857.0, 65938.34061659322, 67280.32719672937, 68361.65819170872, 69400.30599693938, 10754.40850753216, 11151.442427878736, 11506.482208300815, 11508.251963622337, 11824.822627660764, 12088.939555302168, 12343.567975120828, 12371.072169587136, 12373.381330933238, 12491.437885295001, 10581.0, 10603.204759643211, 10735.355878647306, 10742.677719668422, 10778.083862871743, 10396.719549336243, 10401.84397234027, 10475.52860121281, 10662.46687665598, 11016.17378696585, 10322.2258330624, 10595.735106622396, 10668.359898406121, 10706.197035222545, 10707.0, 9111.225545828678, 9271.443713377219, 9355.0, 9525.52372381392, 9625.759356016155, 8514.191151840565, 8664.263537599374, 8717.171868672465, 8809.603567839335, 8825.38222324431], "value": 6948.741107666461, "unit": "score"}], "name": "dromaeo_css", "value": 7142.106149366115, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 110.0, 113.0, 111.0, 111.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 121.0, 154.0, 118.0, 124.0, 117.0, 117.0, 148.0, 119.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0, 162.0, 160.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 117.0, 75.0, 75.0, 75.0, 75.0, 97.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 81.0, 81.0, 83.0, 97.0, 82.0, 83.0, 115.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 87.0, 85.0, 85.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 51.0, 51.0, 51.0, 52.0, 51.0, 51.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 74.0, 77.0, 74.0, 74.0, 78.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 127.0, 127.0, 135.0, 135.0, 123.0, 121.0, 177.0, 131.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 156.0, 158.0, 158.0, 161.0, 160.0, 163.0, 157.0, 156.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 63.0, 66.0, 63.0, 62.0, 65.0, 63.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1460.6999999999998, "alertThreshold": 2.0}]} 15:00:31 INFO - Return code: 0 15:00:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:00:31 INFO - # TBPL SUCCESS # 15:00:31 INFO - Running post-action listener: _resource_record_post_action 15:00:31 INFO - [mozharness: 2017-02-09 23:00:31.080424Z] Finished run-tests step (success) 15:00:31 INFO - Running post-run listener: _resource_record_post_run 15:00:31 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 323649536; Read time: 0; Write time: 163732 15:00:31 INFO - TinderboxPrint: CPU usage
12.9% 15:00:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:00:31 INFO - TinderboxPrint: I/O write bytes / time
323,649,536 / 163,732 15:00:31 INFO - TinderboxPrint: CPU idle
8,257.7 (87.1%) 15:00:31 INFO - TinderboxPrint: CPU user
1,185.1 (12.5%) 15:00:31 INFO - TinderboxPrint: Swap in / out
0 / 0 15:00:31 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101085184; Read time: 0; Write time: 41804 15:00:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 222564352; Read time: 0; Write time: 121928 15:00:31 INFO - Running post-run listener: _upload_blobber_files 15:00:31 INFO - Blob upload gear active. 15:00:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:00:31 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 15:00:31 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:00:31 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:00:32 INFO - (blobuploader) - INFO - Open directory for files ... 15:00:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:00:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:00:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:33 INFO - (blobuploader) - INFO - Done attempting. 15:00:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:00:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:00:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:34 INFO - (blobuploader) - INFO - Done attempting. 15:00:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:00:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:00:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:38 INFO - (blobuploader) - INFO - Done attempting. 15:00:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:00:38 INFO - Return code: 0 15:00:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:00:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:00:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f09828322bad4d9fdd6fe160450e9f5c76ff3072bcdbc285e084af6db8470ed31372837082a8635d90f6cdf36a30a2135301f8d961439c5c87835acaad44ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dcdfffaba1f0c8e4455d5ca750ecf8be5c331373f52a05f6ea912e6d0db9b3825120e0a1d7462e867f2f4e686858f870febb32b2010df869b71ff76b32229e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a3c51064bc4e3abe53e14f245c5464d76a91f985dbdb39d94faf9fc8b518c497a7f38faad33aa659bce69f132e7c8c76a1999ec5acb63252043ce020320c4de"} 15:00:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:00:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:00:38 INFO - Contents: 15:00:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f09828322bad4d9fdd6fe160450e9f5c76ff3072bcdbc285e084af6db8470ed31372837082a8635d90f6cdf36a30a2135301f8d961439c5c87835acaad44ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dcdfffaba1f0c8e4455d5ca750ecf8be5c331373f52a05f6ea912e6d0db9b3825120e0a1d7462e867f2f4e686858f870febb32b2010df869b71ff76b32229e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a3c51064bc4e3abe53e14f245c5464d76a91f985dbdb39d94faf9fc8b518c497a7f38faad33aa659bce69f132e7c8c76a1999ec5acb63252043ce020320c4de"} 15:00:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:00:38 INFO - Copying logs to upload dir... 15:00:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:00:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.632785 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-09 15:00:38.327046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 15:00:38.330436) ========= 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=20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402 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-Beta/sha512/6f09828322bad4d9fdd6fe160450e9f5c76ff3072bcdbc285e084af6db8470ed31372837082a8635d90f6cdf36a30a2135301f8d961439c5c87835acaad44ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dcdfffaba1f0c8e4455d5ca750ecf8be5c331373f52a05f6ea912e6d0db9b3825120e0a1d7462e867f2f4e686858f870febb32b2010df869b71ff76b32229e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a3c51064bc4e3abe53e14f245c5464d76a91f985dbdb39d94faf9fc8b518c497a7f38faad33aa659bce69f132e7c8c76a1999ec5acb63252043ce020320c4de"} build_url:https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/eVOip2iiQWGQyMlI8pAvyw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f09828322bad4d9fdd6fe160450e9f5c76ff3072bcdbc285e084af6db8470ed31372837082a8635d90f6cdf36a30a2135301f8d961439c5c87835acaad44ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dcdfffaba1f0c8e4455d5ca750ecf8be5c331373f52a05f6ea912e6d0db9b3825120e0a1d7462e867f2f4e686858f870febb32b2010df869b71ff76b32229e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a3c51064bc4e3abe53e14f245c5464d76a91f985dbdb39d94faf9fc8b518c497a7f38faad33aa659bce69f132e7c8c76a1999ec5acb63252043ce020320c4de"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 15:00:38.354347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 15:00:38.354650) ========= 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=20e20d796406ba5117c4a6f1000001ba-1486680003.501524-911294402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 15:00:38.437759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 15:00:38.438117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 15:00:38.438440) ========= ========= Total master_lag: 0.16 =========