builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1485350181.4 results: success (0) buildid: 20170125032347 builduid: a05964a10add4257b90463c97a8afbb1 revision: d3b5028a47eca5e20b75063c06e61d7ac9a7f295 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:21.402921) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:21.403440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:21.403752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:21.418821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:21.419262) ========= 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=db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-25 05:16:21-- 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% 95.6M=0s 2017-01-25 05:16:21 (95.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:21.534384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:21.534874) ========= 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=db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:21.586876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 05:16:21.587482) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d3b5028a47eca5e20b75063c06e61d7ac9a7f295 --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 d3b5028a47eca5e20b75063c06e61d7ac9a7f295 --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=db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-25 05:16:21,995 truncating revision to first 12 chars 2017-01-25 05:16:21,995 Setting DEBUG logging. 2017-01-25 05:16:21,995 attempt 1/10 2017-01-25 05:16:21,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d3b5028a47ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 05:16:23,345 unpacking tar archive at: mozilla-beta-d3b5028a47ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.695298 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 05:16:23.297346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:23.297687) ========= script_repo_revision: d3b5028a47eca5e20b75063c06e61d7ac9a7f295 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:23.298096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:23.298397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 05:16:23.307082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-01-25 05:16:23.307403) ========= /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=db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:16:23 INFO - MultiFileLogger online at 20170125 05:16:23 in /builds/slave/test 05:16:23 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 05:16:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:23 INFO - {'append_to_log': False, 05:16:23 INFO - 'base_work_dir': '/builds/slave/test', 05:16:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:16:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:23 INFO - 'branch': 'Mozilla-Beta', 05:16:23 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:23 INFO - 'config_files': ('talos/linux_config.py',), 05:16:23 INFO - 'default_actions': ('clobber', 05:16:23 INFO - 'read-buildbot-config', 05:16:23 INFO - 'download-and-extract', 05:16:23 INFO - 'populate-webroot', 05:16:23 INFO - 'create-virtualenv', 05:16:23 INFO - 'install', 05:16:23 INFO - 'run-tests'), 05:16:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:23 INFO - 'download_minidump_stackwalk': True, 05:16:23 INFO - 'download_symbols': 'ondemand', 05:16:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:23 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:23 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:23 INFO - 'installer_path': 'installer.exe', 05:16:23 INFO - 'log_level': 'info', 05:16:23 INFO - 'log_name': 'talos', 05:16:23 INFO - 'log_to_console': True, 05:16:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:16:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:16:23 INFO - 'opt_config_files': (), 05:16:23 INFO - 'pip_index': False, 05:16:23 INFO - 'sps_profile': False, 05:16:23 INFO - 'sps_profile_interval': 0, 05:16:23 INFO - 'suite': 'dromaeojs', 05:16:23 INFO - 'system_bits': '32', 05:16:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:23 INFO - 'title': 'talos-linux64-ix-049', 05:16:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:23 INFO - 'use_talos_json': True, 05:16:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:23 INFO - 'work_dir': 'build'} 05:16:23 INFO - [mozharness: 2017-01-25 13:16:23.814662Z] Running clobber step. 05:16:23 INFO - Running pre-action listener: _resource_record_pre_action 05:16:23 INFO - Running main action method: clobber 05:16:23 INFO - rmtree: /builds/slave/test/build 05:16:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:24 INFO - Running post-action listener: _resource_record_post_action 05:16:24 INFO - [mozharness: 2017-01-25 13:16:24.279234Z] Finished clobber step (success) 05:16:24 INFO - [mozharness: 2017-01-25 13:16:24.279333Z] Running read-buildbot-config step. 05:16:24 INFO - Running pre-action listener: _resource_record_pre_action 05:16:24 INFO - Running main action method: read_buildbot_config 05:16:24 INFO - Using buildbot properties: 05:16:24 INFO - { 05:16:24 INFO - "project": "", 05:16:24 INFO - "product": "firefox", 05:16:24 INFO - "script_repo_revision": "production", 05:16:24 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:16:24 INFO - "repository": "", 05:16:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:16:24 INFO - "buildid": "20170125032347", 05:16:24 INFO - "pgo_build": "True", 05:16:24 INFO - "basedir": "/builds/slave/test", 05:16:24 INFO - "buildnumber": 111, 05:16:24 INFO - "slavename": "talos-linux64-ix-049", 05:16:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:16:24 INFO - "platform": "ubuntu64_hw", 05:16:24 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:16:24 INFO - "branch": "mozilla-beta", 05:16:24 INFO - "repo_path": "releases/mozilla-beta", 05:16:24 INFO - "revision": "d3b5028a47eca5e20b75063c06e61d7ac9a7f295", 05:16:24 INFO - "stage_platform": "linux64-pgo", 05:16:24 INFO - "builduid": "a05964a10add4257b90463c97a8afbb1", 05:16:24 INFO - "slavebuilddir": "test" 05:16:24 INFO - } 05:16:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 05:16:24 INFO - Running post-action listener: _resource_record_post_action 05:16:24 INFO - [mozharness: 2017-01-25 13:16:24.281750Z] Finished read-buildbot-config step (success) 05:16:24 INFO - [mozharness: 2017-01-25 13:16:24.281837Z] Running download-and-extract step. 05:16:24 INFO - Running pre-action listener: _resource_record_pre_action 05:16:24 INFO - Running main action method: download_and_extract 05:16:24 INFO - mkdir: /builds/slave/test/build/tests 05:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:24 INFO - trying https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:16:24 INFO - Downloading https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/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 05:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/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 05:16:24 INFO - Downloaded 1327 bytes. 05:16:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:16:24 INFO - Using the following test package requirements: 05:16:24 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:16:24 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:16:24 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:24 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:16:24 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 05:16:24 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:16:24 INFO - u'jsshell-linux-x86_64.zip'], 05:16:24 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:16:24 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:24 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:16:24 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:16:24 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 05:16:24 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:16:24 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 05:16:24 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:16:24 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:24 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:16:24 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:24 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:16:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:24 INFO - Fetch https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:16:25 INFO - Http code: 200 05:16:25 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 05:16:25 INFO - x-amz-cf-id: kYVzWksXIxeaOysHQ9PgOaYDnPo-ZxLT2_5jgURdKOL41Io-wCUOYQ== 05:16:25 INFO - x-amz-version-id: A6tHct8ZWfaVGxSvDGQIPBy4tSIoss8n 05:16:25 INFO - Expected file size: 21951280 05:16:25 INFO - Obtained file size: 21951280 05:16:29 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 05:16:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:16:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:29 INFO - Fetch https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:16:30 INFO - Http code: 200 05:16:30 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:16:30 INFO - x-amz-cf-id: lA86EAS_jZw-yPkdz8qSDln1DbP7fOe3jGUXqvfdsrYMGDbSc5MaDg== 05:16:30 INFO - x-amz-version-id: A6tHct8ZWfaVGxSvDGQIPBy4tSIoss8n 05:16:30 INFO - Expected file size: 21951280 05:16:30 INFO - Obtained file size: 21951280 05:16:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 05:16:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:16:34 INFO - Fetch https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 05:16:35 INFO - Http code: 200 05:16:35 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 05:16:35 INFO - x-amz-cf-id: 9JUMygU-XHisE2Iw88t22nWCnXjNRX2wdlqFUKykjw0SbXidotsnXQ== 05:16:35 INFO - x-amz-version-id: ppHFhV_VKySNKcDf7JamL3kvUMk7Xzbc 05:16:35 INFO - Expected file size: 14402992 05:16:35 INFO - Obtained file size: 14402992 05:16: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')]} 05:16:35 INFO - trying https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:16:35 INFO - Downloading https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/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 05:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/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 05:16:36 INFO - Downloaded 57681568 bytes. 05:16:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:16:36 INFO - mkdir: /builds/slave/test/properties 05:16:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:36 INFO - Contents: 05:16:36 INFO - build_url:https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:16:37 INFO - Running post-action listener: _resource_record_post_action 05:16:37 INFO - Running post-action listener: set_extra_try_arguments 05:16:37 INFO - [mozharness: 2017-01-25 13:16:37.649197Z] Finished download-and-extract step (success) 05:16:37 INFO - [mozharness: 2017-01-25 13:16:37.649423Z] Running populate-webroot step. 05:16:37 INFO - Running pre-action listener: _resource_record_pre_action 05:16:37 INFO - Running main action method: populate_webroot 05:16:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:37 INFO - '--tppagecycles', 05:16:37 INFO - '7'], 05:16:37 INFO - 'tests': ['tsvgm']}}, 05:16:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:37 INFO - 'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:37 INFO - 'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['damp', 'tps']}, 05:16:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:37 INFO - 'tests': ['damp', 'tps']}, 05:16:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['dromaeo_dom']}, 05:16:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['basic_compositor_video']}, 05:16:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:16:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['a11yr', 05:16:37 INFO - 'ts_paint', 05:16:37 INFO - 'tpaint', 05:16:37 INFO - 'sessionrestore', 05:16:37 INFO - 'sessionrestore_no_auto_restore', 05:16:37 INFO - 'tabpaint']}, 05:16:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:37 INFO - 'ts_paint', 05:16:37 INFO - 'tpaint', 05:16:37 INFO - 'sessionrestore', 05:16:37 INFO - 'sessionrestore_no_auto_restore', 05:16:37 INFO - 'tabpaint']}, 05:16:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:37 INFO - 'ts_paint', 05:16:37 INFO - 'tpaint', 05:16:37 INFO - 'sessionrestore', 05:16:37 INFO - 'sessionrestore_no_auto_restore', 05:16:37 INFO - 'tabpaint']}, 05:16:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:37 INFO - 'ts_paint', 05:16:37 INFO - 'tpaint', 05:16:37 INFO - 'sessionrestore', 05:16:37 INFO - 'sessionrestore_no_auto_restore', 05:16:37 INFO - 'tabpaint']}, 05:16:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['a11yr', 05:16:37 INFO - 'ts_paint', 05:16:37 INFO - 'tpaint', 05:16:37 INFO - 'sessionrestore', 05:16:37 INFO - 'sessionrestore_no_auto_restore', 05:16:37 INFO - 'tabpaint']}, 05:16:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['a11yr', 05:16:37 INFO - 'ts_paint', 05:16:37 INFO - 'tpaint', 05:16:37 INFO - 'sessionrestore', 05:16:37 INFO - 'sessionrestore_no_auto_restore', 05:16:37 INFO - 'tabpaint']}, 05:16:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['tsvgx', 05:16:37 INFO - 'tsvgr_opacity', 05:16:37 INFO - 'tart', 05:16:37 INFO - 'tscrollx', 05:16:37 INFO - 'cart']}, 05:16:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:37 INFO - 'tsvgr_opacity', 05:16:37 INFO - 'tart', 05:16:37 INFO - 'tscrollx', 05:16:37 INFO - 'cart']}, 05:16:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:37 INFO - 'talos_options': ['--disable-e10s'], 05:16:37 INFO - 'tests': ['tp5o']}, 05:16:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:37 INFO - 'tests': ['tp5o']}, 05:16:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:37 INFO - 'talos_options': ['--disable-e10s', 05:16:37 INFO - '--xperf_path', 05:16:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:37 INFO - 'tests': ['tp5n']}, 05:16:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:37 INFO - 'talos_options': ['--xperf_path', 05:16:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:37 INFO - 'tests': ['tp5n']}}, 05:16:37 INFO - 'talos.zip': {'path': '', 05:16:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:37 INFO - Running post-action listener: _resource_record_post_action 05:16:37 INFO - [mozharness: 2017-01-25 13:16:37.669341Z] Finished populate-webroot step (success) 05:16:37 INFO - [mozharness: 2017-01-25 13:16:37.669428Z] Running create-virtualenv step. 05:16:37 INFO - Running pre-action listener: _resource_record_pre_action 05:16:37 INFO - Running main action method: create_virtualenv 05:16:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:37 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 05:16:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:37 INFO - Using real prefix '/usr' 05:16:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:40 INFO - Installing pip.................done. 05:16:40 INFO - Return code: 0 05:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:16:40 INFO - Reading from file tmpfile_stdout 05:16:40 INFO - Output received: 05:16:40 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) 05:16:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:40 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')]} 05:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:40 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')]} 05:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:40 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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:16:40 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 05:16:40 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 05:16:40 INFO - Using env: {'DISPLAY': ':0', 05:16:40 INFO - 'HOME': '/home/cltbld', 05:16:40 INFO - 'LANG': 'en_US.UTF-8', 05:16:40 INFO - 'LANGUAGE': 'en_US:en', 05:16:40 INFO - 'LOGNAME': 'cltbld', 05:16:40 INFO - 'MAIL': '/var/mail/cltbld', 05:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:40 INFO - 'MOZ_NO_REMOTE': '1', 05:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:40 INFO - 'NO_EM_RESTART': '1', 05:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:40 INFO - 'PWD': '/builds/slave/test', 05:16:40 INFO - 'SHELL': '/bin/bash', 05:16:40 INFO - 'SHLVL': '1', 05:16:40 INFO - 'TERM': 'linux', 05:16:40 INFO - 'TMOUT': '86400', 05:16:40 INFO - 'USER': 'cltbld', 05:16:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:40 INFO - '_': '/tools/buildbot/bin/python'} 05:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:40 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 05:16:40 INFO - Cleaning up... 05:16:40 INFO - Return code: 0 05:16:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:16:40 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')]} 05:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:40 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')]} 05:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:40 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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:16:40 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 05:16:40 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 05:16:40 INFO - Using env: {'DISPLAY': ':0', 05:16:40 INFO - 'HOME': '/home/cltbld', 05:16:40 INFO - 'LANG': 'en_US.UTF-8', 05:16:40 INFO - 'LANGUAGE': 'en_US:en', 05:16:40 INFO - 'LOGNAME': 'cltbld', 05:16:40 INFO - 'MAIL': '/var/mail/cltbld', 05:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:40 INFO - 'MOZ_NO_REMOTE': '1', 05:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:40 INFO - 'NO_EM_RESTART': '1', 05:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:40 INFO - 'PWD': '/builds/slave/test', 05:16:40 INFO - 'SHELL': '/bin/bash', 05:16:40 INFO - 'SHLVL': '1', 05:16:40 INFO - 'TERM': 'linux', 05:16:40 INFO - 'TMOUT': '86400', 05:16:40 INFO - 'USER': 'cltbld', 05:16:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:40 INFO - '_': '/tools/buildbot/bin/python'} 05:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:40 INFO - Downloading/unpacking psutil>=3.1.1 05:16:40 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 05:16:40 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 05:16:40 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 05:16:40 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 05:16:40 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 05:16:40 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 05:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:43 INFO - Installing collected packages: psutil 05:16:43 INFO - Running setup.py install for psutil 05:16:43 INFO - building 'psutil._psutil_linux' extension 05:16:43 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 05:16:43 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 05:16:43 INFO - building 'psutil._psutil_posix' extension 05:16:43 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 05:16:43 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 05:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:43 INFO - Successfully installed psutil 05:16:43 INFO - Cleaning up... 05:16:43 INFO - Return code: 0 05:16:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:43 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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:16:43 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 05:16:43 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 05:16:43 INFO - Using env: {'DISPLAY': ':0', 05:16:43 INFO - 'HOME': '/home/cltbld', 05:16:43 INFO - 'LANG': 'en_US.UTF-8', 05:16:43 INFO - 'LANGUAGE': 'en_US:en', 05:16:43 INFO - 'LOGNAME': 'cltbld', 05:16:43 INFO - 'MAIL': '/var/mail/cltbld', 05:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:43 INFO - 'MOZ_NO_REMOTE': '1', 05:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:43 INFO - 'NO_EM_RESTART': '1', 05:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:43 INFO - 'PWD': '/builds/slave/test', 05:16:43 INFO - 'SHELL': '/bin/bash', 05:16:43 INFO - 'SHLVL': '1', 05:16:43 INFO - 'TERM': 'linux', 05:16:43 INFO - 'TMOUT': '86400', 05:16:43 INFO - 'USER': 'cltbld', 05:16:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:43 INFO - '_': '/tools/buildbot/bin/python'} 05:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16:43 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 05:16:43 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 05:16:43 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 05:16:43 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 05:16:43 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 05:16:43 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 05:16:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:16:45 INFO - Installing collected packages: mozsystemmonitor 05:16:45 INFO - Running setup.py install for mozsystemmonitor 05:16:45 INFO - Successfully installed mozsystemmonitor 05:16:45 INFO - Cleaning up... 05:16:46 INFO - Return code: 0 05:16:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:16:46 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')]} 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 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')]} 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:16:46 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 05:16:46 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 05:16:46 INFO - Using env: {'DISPLAY': ':0', 05:16:46 INFO - 'HOME': '/home/cltbld', 05:16:46 INFO - 'LANG': 'en_US.UTF-8', 05:16:46 INFO - 'LANGUAGE': 'en_US:en', 05:16:46 INFO - 'LOGNAME': 'cltbld', 05:16:46 INFO - 'MAIL': '/var/mail/cltbld', 05:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:46 INFO - 'MOZ_NO_REMOTE': '1', 05:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:46 INFO - 'NO_EM_RESTART': '1', 05:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:46 INFO - 'PWD': '/builds/slave/test', 05:16:46 INFO - 'SHELL': '/bin/bash', 05:16:46 INFO - 'SHLVL': '1', 05:16:46 INFO - 'TERM': 'linux', 05:16:46 INFO - 'TMOUT': '86400', 05:16:46 INFO - 'USER': 'cltbld', 05:16:46 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:46 INFO - '_': '/tools/buildbot/bin/python'} 05:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:46 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 05:16:46 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 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:48 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 05:16:48 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 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:48 INFO - warning: no files found matching '*.txt' 05:16:48 INFO - no previously-included directories found matching 'build' 05:16:48 INFO - no previously-included directories found matching 'dist' 05:16:48 INFO - no previously-included directories found matching '.git*' 05:16:48 INFO - Installing collected packages: jsonschema, functools32 05:16:48 INFO - Running setup.py install for functools32 05:16:48 INFO - warning: no files found matching '*.txt' 05:16:48 INFO - no previously-included directories found matching 'build' 05:16:48 INFO - no previously-included directories found matching 'dist' 05:16:48 INFO - no previously-included directories found matching '.git*' 05:16:48 INFO - Successfully installed jsonschema functools32 05:16:48 INFO - Cleaning up... 05:16:48 INFO - Return code: 0 05:16:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:16:48 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')]} 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 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')]} 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:16:48 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 05:16:48 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 05:16:48 INFO - Using env: {'DISPLAY': ':0', 05:16:48 INFO - 'HOME': '/home/cltbld', 05:16:48 INFO - 'LANG': 'en_US.UTF-8', 05:16:48 INFO - 'LANGUAGE': 'en_US:en', 05:16:48 INFO - 'LOGNAME': 'cltbld', 05:16:48 INFO - 'MAIL': '/var/mail/cltbld', 05:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:48 INFO - 'MOZ_NO_REMOTE': '1', 05:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:48 INFO - 'NO_EM_RESTART': '1', 05:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:48 INFO - 'PWD': '/builds/slave/test', 05:16:48 INFO - 'SHELL': '/bin/bash', 05:16:48 INFO - 'SHLVL': '1', 05:16:48 INFO - 'TERM': 'linux', 05:16:48 INFO - 'TMOUT': '86400', 05:16:48 INFO - 'USER': 'cltbld', 05:16:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:48 INFO - '_': '/tools/buildbot/bin/python'} 05:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:16:48 INFO - Cleaning up... 05:16:48 INFO - Return code: 0 05:16:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:48 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')]} 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 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')]} 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:16:48 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 05:16:48 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 05:16:48 INFO - Using env: {'DISPLAY': ':0', 05:16:48 INFO - 'HOME': '/home/cltbld', 05:16:48 INFO - 'LANG': 'en_US.UTF-8', 05:16:48 INFO - 'LANGUAGE': 'en_US:en', 05:16:48 INFO - 'LOGNAME': 'cltbld', 05:16:48 INFO - 'MAIL': '/var/mail/cltbld', 05:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:48 INFO - 'MOZ_NO_REMOTE': '1', 05:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:48 INFO - 'NO_EM_RESTART': '1', 05:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:48 INFO - 'PWD': '/builds/slave/test', 05:16:48 INFO - 'SHELL': '/bin/bash', 05:16:48 INFO - 'SHLVL': '1', 05:16:48 INFO - 'TERM': 'linux', 05:16:48 INFO - 'TMOUT': '86400', 05:16:48 INFO - 'USER': 'cltbld', 05:16:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:48 INFO - '_': '/tools/buildbot/bin/python'} 05:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:49 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 05:16:49 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 05:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 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 05:16:51 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 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 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 05:16:51 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 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - Downloading docopt-0.6.1.tar.gz 05:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:51 INFO - Running setup.py install for blobuploader 05:16:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:52 INFO - Running setup.py install for requests 05:16:52 INFO - Running setup.py install for docopt 05:16:52 INFO - Successfully installed blobuploader requests docopt 05:16:52 INFO - Cleaning up... 05:16:52 INFO - Return code: 0 05:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:52 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')]} 05:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:52 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')]} 05:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:52 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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:16:52 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 05:16:52 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 05:16:52 INFO - Using env: {'DISPLAY': ':0', 05:16:52 INFO - 'HOME': '/home/cltbld', 05:16:52 INFO - 'LANG': 'en_US.UTF-8', 05:16:52 INFO - 'LANGUAGE': 'en_US:en', 05:16:52 INFO - 'LOGNAME': 'cltbld', 05:16:52 INFO - 'MAIL': '/var/mail/cltbld', 05:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:52 INFO - 'MOZ_NO_REMOTE': '1', 05:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:52 INFO - 'NO_EM_RESTART': '1', 05:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:52 INFO - 'PWD': '/builds/slave/test', 05:16:52 INFO - 'SHELL': '/bin/bash', 05:16:52 INFO - 'SHLVL': '1', 05:16:52 INFO - 'TERM': 'linux', 05:16:52 INFO - 'TMOUT': '86400', 05:16:52 INFO - 'USER': 'cltbld', 05:16:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:52 INFO - '_': '/tools/buildbot/bin/python'} 05:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:52 INFO - Running setup.py (path:/tmp/pip-HroLq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:52 INFO - Running setup.py (path:/tmp/pip-w1tkuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:52 INFO - Running setup.py (path:/tmp/pip-wUtTom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:53 INFO - Running setup.py (path:/tmp/pip-OjHCCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:53 INFO - Running setup.py (path:/tmp/pip-S9Xn2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:53 INFO - Running setup.py (path:/tmp/pip-4hCbGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:53 INFO - Running setup.py (path:/tmp/pip-h9CmHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:53 INFO - Running setup.py (path:/tmp/pip-h4CzWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:53 INFO - Running setup.py (path:/tmp/pip-FvbBZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:53 INFO - Running setup.py (path:/tmp/pip-xlj3QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:53 INFO - Running setup.py (path:/tmp/pip-8ukxDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:53 INFO - Running setup.py (path:/tmp/pip-Jx9rSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:53 INFO - Running setup.py (path:/tmp/pip-kCAWbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:53 INFO - Running setup.py (path:/tmp/pip-6KTYgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:53 INFO - Running setup.py (path:/tmp/pip-1ARAXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:53 INFO - Running setup.py (path:/tmp/pip-wqm8lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:53 INFO - Running setup.py (path:/tmp/pip-NKfze6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:54 INFO - Running setup.py install for manifestparser 05:16:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Running setup.py install for mozcrash 05:16:54 INFO - Running setup.py install for mozdebug 05:16:54 INFO - Running setup.py install for mozdevice 05:16:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Running setup.py install for mozfile 05:16:54 INFO - Running setup.py install for mozhttpd 05:16:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Running setup.py install for mozinfo 05:16:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Running setup.py install for mozInstall 05:16:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:54 INFO - Running setup.py install for mozleak 05:16:54 INFO - Running setup.py install for mozlog 05:16:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:55 INFO - Running setup.py install for moznetwork 05:16:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:55 INFO - Running setup.py install for mozprocess 05:16:55 INFO - Running setup.py install for mozprofile 05:16:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:55 INFO - Running setup.py install for mozrunner 05:16:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:55 INFO - Running setup.py install for mozscreenshot 05:16:55 INFO - Running setup.py install for moztest 05:16:55 INFO - Running setup.py install for mozversion 05:16:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:55 INFO - Cleaning up... 05:16:55 INFO - Return code: 0 05:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:55 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')]} 05:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:55 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')]} 05:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:55 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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:16:55 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 05:16:55 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 05:16:55 INFO - Using env: {'DISPLAY': ':0', 05:16:55 INFO - 'HOME': '/home/cltbld', 05:16:55 INFO - 'LANG': 'en_US.UTF-8', 05:16:55 INFO - 'LANGUAGE': 'en_US:en', 05:16:55 INFO - 'LOGNAME': 'cltbld', 05:16:55 INFO - 'MAIL': '/var/mail/cltbld', 05:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:55 INFO - 'MOZ_NO_REMOTE': '1', 05:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:55 INFO - 'NO_EM_RESTART': '1', 05:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:55 INFO - 'PWD': '/builds/slave/test', 05:16:55 INFO - 'SHELL': '/bin/bash', 05:16:55 INFO - 'SHLVL': '1', 05:16:55 INFO - 'TERM': 'linux', 05:16:55 INFO - 'TMOUT': '86400', 05:16:55 INFO - 'USER': 'cltbld', 05:16:55 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:55 INFO - '_': '/tools/buildbot/bin/python'} 05:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:56 INFO - Running setup.py (path:/tmp/pip-tL1QLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:56 INFO - Running setup.py (path:/tmp/pip-K94hpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:56 INFO - Running setup.py (path:/tmp/pip-iCt9Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:56 INFO - Running setup.py (path:/tmp/pip-u586ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:56 INFO - Running setup.py (path:/tmp/pip-pHlZD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:56 INFO - Running setup.py (path:/tmp/pip-lRc1AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:56 INFO - Running setup.py (path:/tmp/pip-tTfUDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:56 INFO - Running setup.py (path:/tmp/pip-3NlYsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:56 INFO - Running setup.py (path:/tmp/pip-r4QG1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:56 INFO - Running setup.py (path:/tmp/pip-bhB3AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:56 INFO - Running setup.py (path:/tmp/pip-aCs0jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:56 INFO - Running setup.py (path:/tmp/pip-BwbdfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:56 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)) 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:56 INFO - Running setup.py (path:/tmp/pip-JTttsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:57 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)) 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:57 INFO - Running setup.py (path:/tmp/pip-M3qo0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:57 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)) 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:57 INFO - Running setup.py (path:/tmp/pip-jeAbaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:57 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)) 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:57 INFO - Running setup.py (path:/tmp/pip-IcW60N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:57 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)) 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:57 INFO - Running setup.py (path:/tmp/pip-JFX02r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:57 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)) 05:16:57 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)) 05:16:57 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)) 05:16:57 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)) 05:16:57 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)) 05:16:57 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)) 05:16:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:57 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 05:16:57 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 05:16:57 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 05:16:57 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 05:16:57 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 05:16:57 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 05:16:59 INFO - Downloading blessings-1.6.tar.gz 05:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:59 INFO - Installing collected packages: blessings 05:16:59 INFO - Running setup.py install for blessings 05:16:59 INFO - Successfully installed blessings 05:16:59 INFO - Cleaning up... 05:16:59 INFO - Return code: 0 05:16:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:00 INFO - Reading from file tmpfile_stdout 05:17:00 INFO - Current package versions: 05:17:00 INFO - argparse == 1.2.1 05:17:00 INFO - blessings == 1.6 05:17:00 INFO - blobuploader == 1.2.4 05:17:00 INFO - docopt == 0.6.1 05:17:00 INFO - functools32 == 3.2.3-2 05:17:00 INFO - jsonschema == 2.5.1 05:17:00 INFO - manifestparser == 1.1 05:17:00 INFO - mozInstall == 1.12 05:17:00 INFO - mozcrash == 1.0 05:17:00 INFO - mozdebug == 0.1 05:17:00 INFO - mozdevice == 0.48 05:17:00 INFO - mozfile == 1.2 05:17:00 INFO - mozhttpd == 0.7 05:17:00 INFO - mozinfo == 0.9 05:17:00 INFO - mozleak == 0.1 05:17:00 INFO - mozlog == 3.4 05:17:00 INFO - moznetwork == 0.27 05:17:00 INFO - mozprocess == 0.23 05:17:00 INFO - mozprofile == 0.28 05:17:00 INFO - mozrunner == 6.13 05:17:00 INFO - mozscreenshot == 0.1 05:17:00 INFO - mozsystemmonitor == 0.3 05:17:00 INFO - moztest == 0.8 05:17:00 INFO - mozversion == 1.4 05:17:00 INFO - psutil == 3.1.1 05:17:00 INFO - requests == 1.2.3 05:17:00 INFO - wsgiref == 0.1.2 05:17:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:00 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')]} 05:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 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')]} 05:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 05:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 05:17:00 INFO - Using env: {'DISPLAY': ':0', 05:17:00 INFO - 'HOME': '/home/cltbld', 05:17:00 INFO - 'LANG': 'en_US.UTF-8', 05:17:00 INFO - 'LANGUAGE': 'en_US:en', 05:17:00 INFO - 'LOGNAME': 'cltbld', 05:17:00 INFO - 'MAIL': '/var/mail/cltbld', 05:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:00 INFO - 'MOZ_NO_REMOTE': '1', 05:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:00 INFO - 'NO_EM_RESTART': '1', 05:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:00 INFO - 'PWD': '/builds/slave/test', 05:17:00 INFO - 'SHELL': '/bin/bash', 05:17:00 INFO - 'SHLVL': '1', 05:17:00 INFO - 'TERM': 'linux', 05:17:00 INFO - 'TMOUT': '86400', 05:17:00 INFO - 'USER': 'cltbld', 05:17:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:00 INFO - '_': '/tools/buildbot/bin/python'} 05:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 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)) 05:17:00 INFO - Cleaning up... 05:17:00 INFO - Return code: 0 05:17:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:00 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')]} 05:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 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')]} 05:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 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 0x7fcbb511ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', '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 05:17:00 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 05:17:00 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 05:17:00 INFO - Using env: {'DISPLAY': ':0', 05:17:00 INFO - 'HOME': '/home/cltbld', 05:17:00 INFO - 'LANG': 'en_US.UTF-8', 05:17:00 INFO - 'LANGUAGE': 'en_US:en', 05:17:00 INFO - 'LOGNAME': 'cltbld', 05:17:00 INFO - 'MAIL': '/var/mail/cltbld', 05:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:00 INFO - 'MOZ_NO_REMOTE': '1', 05:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:00 INFO - 'NO_EM_RESTART': '1', 05:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:00 INFO - 'PWD': '/builds/slave/test', 05:17:00 INFO - 'SHELL': '/bin/bash', 05:17:00 INFO - 'SHLVL': '1', 05:17:00 INFO - 'TERM': 'linux', 05:17:00 INFO - 'TMOUT': '86400', 05:17:00 INFO - 'USER': 'cltbld', 05:17:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:00 INFO - '_': '/tools/buildbot/bin/python'} 05:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:00 INFO - Cleaning up... 05:17:00 INFO - Return code: 0 05:17:00 INFO - Running post-action listener: _resource_record_post_action 05:17:00 INFO - Running post-action listener: _start_resource_monitoring 05:17:00 INFO - Starting resource monitoring. 05:17:00 INFO - [mozharness: 2017-01-25 13:17:00.499064Z] Finished create-virtualenv step (success) 05:17:00 INFO - [mozharness: 2017-01-25 13:17:00.499562Z] Running install step. 05:17:00 INFO - Running pre-action listener: _resource_record_pre_action 05:17:00 INFO - Running main action method: install 05:17:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:00 INFO - Reading from file tmpfile_stdout 05:17:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:00 INFO - Reading from file tmpfile_stdout 05:17:00 INFO - Output received: 05:17:00 INFO - Usage: mozinstall [options] installer 05:17:00 INFO - Options: 05:17:00 INFO - -h, --help show this help message and exit 05:17:00 INFO - -d DEST, --destination=DEST 05:17:00 INFO - Directory to install application into. [default: 05:17:00 INFO - "/builds/slave/test"] 05:17:00 INFO - --app=APP Application being installed. [default: firefox] 05:17:00 INFO - mkdir: /builds/slave/test/build/application 05:17:00 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'] 05:17:00 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 05:17:14 INFO - Reading from file tmpfile_stdout 05:17:14 INFO - Output received: 05:17:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:14 INFO - Running post-action listener: _resource_record_post_action 05:17:14 INFO - [mozharness: 2017-01-25 13:17:14.440952Z] Finished install step (success) 05:17:14 INFO - [mozharness: 2017-01-25 13:17:14.441194Z] Running run-tests step. 05:17:14 INFO - Running pre-action listener: _resource_record_pre_action 05:17:14 INFO - Running main action method: run_tests 05:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:14 INFO - Python 2.7.3 05:17:14 INFO - Return code: 0 05:17:14 INFO - grabbing minidump binary from tooltool 05:17:14 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')]} 05:17:14 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 0x23f4f60>, '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 0x23f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:14 INFO - Return code: 0 05:17:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:14 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/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 05:17:14 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/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 05:17:14 INFO - Using env: {'DISPLAY': ':0', 05:17:14 INFO - 'HOME': '/home/cltbld', 05:17:14 INFO - 'LANG': 'en_US.UTF-8', 05:17:14 INFO - 'LANGUAGE': 'en_US:en', 05:17:14 INFO - 'LOGNAME': 'cltbld', 05:17:14 INFO - 'MAIL': '/var/mail/cltbld', 05:17:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:14 INFO - 'MOZ_NO_REMOTE': '1', 05:17:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:14 INFO - 'NO_EM_RESTART': '1', 05:17:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:14 INFO - 'PWD': '/builds/slave/test', 05:17:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:14 INFO - 'SHELL': '/bin/bash', 05:17:14 INFO - 'SHLVL': '1', 05:17:14 INFO - 'TERM': 'linux', 05:17:14 INFO - 'TMOUT': '86400', 05:17:14 INFO - 'USER': 'cltbld', 05:17:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030', 05:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:14 INFO - '_': '/tools/buildbot/bin/python'} 05:17:14 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/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 05:17:14 INFO - mozversion application_buildid: 20170125032347 05:17:14 INFO - mozversion application_changeset: d3b5028a47eca5e20b75063c06e61d7ac9a7f295 05:17:14 INFO - mozversion application_display_name: Firefox 05:17:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:14 INFO - mozversion application_name: Firefox 05:17:14 INFO - mozversion application_remotingname: firefox 05:17:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:17:14 INFO - mozversion application_vendor: Mozilla 05:17:14 INFO - mozversion application_version: 52.0 05:17:14 INFO - mozversion platform_buildid: 20170125032347 05:17:14 INFO - mozversion platform_changeset: d3b5028a47eca5e20b75063c06e61d7ac9a7f295 05:17:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:17:14 INFO - mozversion platform_version: 52.0 05:17:14 INFO - using testdate: 1485350234 05:17:14 INFO - actual date: 1485350234 05:17:14 INFO - starting webserver on 'localhost:34932' 05:17:14 INFO - SUITE-START | Running 2 tests 05:17:14 INFO - TEST-START | dromaeo_css 05:17:14 INFO - operating with platform_type : linux_ 05:17:14 INFO - Initialising browser for dromaeo_css test... 05:17:14 INFO - TEST-INFO | started process 6718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7RJ1ts/profile http://localhost:34932/getInfo.html) 05:17:18 INFO - PROCESS | 6718 | __metrics Screen width/height:1600/1200 05:17:18 INFO - PROCESS | 6718 | colorDepth:24 05:17:18 INFO - PROCESS | 6718 | Browser inner width/height: 1024/697 05:17:18 INFO - PROCESS | 6718 | __metrics 05:17:19 INFO - PROCESS | 6718 | 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" 05:17:19 INFO - PROCESS | 6718 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:19 INFO - PROCESS | 6718 | console.error: PushService: 05:17:19 INFO - PROCESS | 6718 | stateChangeProcessEnqueue: Error transitioning state 05:17:19 INFO - PROCESS | 6718 | UnknownError 05:17:20 INFO - TEST-INFO | 6718: exit 0 05:17:20 INFO - Browser initialized. 05:17:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:20 INFO - TEST-INFO | started process 6812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7RJ1ts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:32 INFO - PROCESS | 6812 | RSS: Main: 145076224 05:17:32 INFO - PROCESS | 6812 | 05:20:33 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:34932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34932/tests/dromaeo/cssquery-ext.html) 05:20:34 INFO - PROCESS | 6812 | RSS: Main: 239624192 05:20:34 INFO - PROCESS | 6812 | 05:23:36 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:34932/tests/dromaeo/cssquery-ext.html (next: http://localhost:34932/tests/dromaeo/cssquery-jquery.html) 05:23:37 INFO - PROCESS | 6812 | RSS: Main: 231821312 05:23:37 INFO - PROCESS | 6812 | 05:26:39 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:34932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34932/tests/dromaeo/cssquery-mootools.html) 05:26:39 INFO - PROCESS | 6812 | RSS: Main: 217260032 05:26:39 INFO - PROCESS | 6812 | 05:29:41 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:34932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34932/tests/dromaeo/cssquery-prototype.html) 05:29:42 INFO - PROCESS | 6812 | RSS: Main: 213364736 05:29:42 INFO - PROCESS | 6812 | 05:32:44 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:34932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34932/tests/dromaeo/cssquery-yui.html) 05:32:45 INFO - PROCESS | 6812 | RSS: Main: 176340992 05:32:45 INFO - PROCESS | 6812 | 05:35:47 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:34932/tests/dromaeo/cssquery-yui.html (next: http://localhost:34932/tests/dromaeo/cssquery-dojo.html) 05:35:48 INFO - PROCESS | 6812 | RSS: Main: 258658304 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - PROCESS | 6812 | __start_tp_report 05:35:48 INFO - PROCESS | 6812 | _x_x_mozilla_page_load 05:35:48 INFO - PROCESS | 6812 | _x_x_mozilla_page_load_details 05:35:48 INFO - PROCESS | 6812 | |i|pagename|runs| 05:35:48 INFO - PROCESS | 6812 | |0;dojo.html;3226.0160651001443;3247.139508030371;3277.4592192288274;3277.5739153909994;3298.835058247087;5414.269073675057;5462.344518657762;5487.890242195163;5500.614956953005;5511.421300763417;5533.916991245124;5558.249636299099;5571.025070612647;5573.665580065189;5575.665460072399;4999.425066117397;5051.570616497602;5084.13569693153;5089.440161582223;5146.279520867081;4954.628402869781;5077.5684066854365;5122.564582010534;5134;5136.306598609196;4927.950720492803;5001.749912504379;5003.849884503471;5076.695398276097;5097.133487307166;5052.115879721053;5071.822486212984;5090.465501122403;5141.177411614161;5177.948220517822;4782.880427989293;5033.723145227011;5045.672031317952;5095.79616815327;5113.821016264413;5256.842294731164;5299.046171689094;5370.650907691027;5376.301080859464;5376.489233522848;5812.88374232513;5818.912716309259;5826.941730582682;5875.588708790387;5878.5003274721275;5830.941690583125;5941.376155503696;5951.9107213391835;5957.523398128139;5963.194968679216;5486.780528778844;5507.118860982264;5528.585356098309;5559.6664200148125;5611.130274807411;6048.546359023091;6068.726907289182;6084.726187321581;6086.178365920633;6105.908411373833;5691.658500489983;5843.328017277982;5851.1223316502865;5852.297724273115;5854.853628659318;5799.159121927297;5846.356900740915;5913.438223368773;5915.822525324247;5994.100884867305;5934.436228558367;5935.821925342247;5943.881122377615;5947.970260148758;5981.312149102821;5904.439078287556;5956.076808094752;5960.970195148997;5963.850903727442;5981.342052374235;4465.776711164429;4475.351074094303;4513.954860451419;4520.977395113004;4531.954680453219;4004.799760011988;4028.778417187083;4049.635532802003;4056.229316429869;4078.9796051019557;5537.529310008614;5554.944560533567;5607.383187849333;5615.8596035098635;5619.185218143346;5706.629069110494;5791.044477661138;5841.036229022164;5891.440313170242;5931.436513531207;5456.317960254968;5497.532709719719;5516.972415137979;5523.4200408956485;5523.6685798851395;4989.376327959005;4994.9750251248515;4996.475370086161;4999.975000124976;5050.267711181858;5973.283206015132;5976.491998180117;5978.55160862937;6010.308814486302;6032.758689652364;5788.9131663024245;5937.940620593911;6021.096835474714;6022.45797878193;6027;6150.367777052875;6183.81448556544;6187.443130118311;6192.628442293477;6197.907031394623;5700.600957932905;5840.386759390203;5840.970795145997;5850.151727999501;5882.411758824083;5856.443637854397;5885.47030767233;5947.910781338197;5963.493103086286;6044.063170208625;5757.165211044459;5813.7674493021495;5816.47651711348;5820.912686309794;5862.062070068939;5775.826725198251;5820.447057529528;5823.388544202798;5827.475527202402;5829;5538.889222215453;5548.250986116823;5665.49010589049;5693.345265294544;5749.8275051748515;5852.502537284378;5857.7949771757785;5859.853503662443;5867.882642347215;5882.352941176553;5571.025070612545;5745.109508026263;5746.827595172152;5760;5760.222369979999 05:35:48 INFO - PROCESS | 6812 | |1;ext.html;583.597317850683;607.8814631146926;635.1267007864187;662.542845436649;663.2140913018077;34433.82783086087;44770.55229447704;45581;45599.31601025987;45637.08725825482;46445.30332045013;47028.76485617576;47078.52921470784;47092;47108.76445617767;8453.915460845405;8974.416662916921;9076.8638470423;9124.680636177734;9143.588538515784;8686.261667758248;10836;11086.667399977974;11094.667159985172;11386.259893106962;11088.667339979813;11126.6105686301;11147.386893720843;11147.498362573704;11155.05182059526;10993.505292261827;11043.99999999996;11048.723781905437;11051.115910727203;11064.778704425866;10873.728156796064;10907.18196135293;10910.61812836547;10925.508352124174;10928.508217130247;44492.332615010804;44816.32775508337;44848.103037939385;44885.10229795386;44892;3692.2430901665093;3781.9621803781884;3811.561670407883;3970.563238043813;4238.385434112037;34048.80829170967;34085.31829363399;34442.65557344419;34461;34608.307833843435;4229.471316085489;4345.283028300327;4402.7578483183415;4431.711938723973;4500.191783687923;346407;346918;348852;349085.99999999744;350045;65688.34311656823;66233.33766662369;66368.33631663621;66391.33608663948;66452.66773666197;40512.79743601263;41271;41628.58371416308;43162.35256471155;70372.64813675899;18630.441086767147;18865.90567047156;18880.622387552172;18884.43346699601;18885.90557047206;12930.67673308156;13141;14286.642833929234;14467.059641123293;14490.130592164503;19708.21167153298;20639.174433022512;20666.07002684883;20759.896200518902;20767.065482053345;7326.67029983652;7396.926030739732;7496.212897645669;7552.811179720551;7647.464677472635;969.413504829582;1033.261218228955;1061.4639606998571;1126.921115521922;1169.351010189353;33776;34350.312993739986;34361.82819085888;34553.65446345555;34869.825650871586;1138.3362930742103;1144.2733863996423;1191.7259030423052;1257.9308138052495;1299.811527328551;18005.549861253574;18227.36204232872;18258.726119108225;18395.264189432273;18420.447386578424;535649;545055;546147;546365;551505;62553.374466255664;63420.36579634237;63440.68279658572;63534.364656352845;63567;1296;1336.4587342126454;1404.368034384531;1435.131745294103;1457.4898785425016;30905.53641695421;34529.654703452645;35472.82263588665;35486.46770298396;35640;53155.734221330196;53760;53785.46214537804;53789;53791.731041344545;371386;371729;372616;373646;485013;26007.73992260129;27740.30649233785;28674.283142921595;29658.851705741334;30608.84695576508;48548.514514854396;49157.75421122871;49872.75318117076;50071.499285006685;50381.49618503915;42580.36129457998;43161.78419107884;43227.78386108049;43695.56304436915;44338;42129.157416852104;42394;43085;44048.55951440573;44097;39036.609633903296;39342.2131557373;40047.19905601814;40205.79897100496;40473.1905361897;35487.64512354947;37873.431898522096;38046.429303561024;38643;38984;29610.407791844475;29746.256343591584;29952.550711738906;30067;30158.69841301559 05:35:48 INFO - PROCESS | 6812 | |2;jquery.html;422.98605289230994;429.1010333351628;431.58352190136515;435.71678409034126;451.3951305250963;18393.63212735746;18610.255589776425;20047.498812529677;20225.292114775984;20361.592768144626;19578.216871325167;19998.90000549999;20181.697274540893;20259.49351266219;20896;5306.814261500858;5513.61404701671;5522.972385138089;5528.087865502187;5532.75102620383;5408.91886621701;5479.643823151502;5500.119980803072;5745.913811292813;5951.285845698522;6103.054026625858;6105.725242364082;6106.969465152668;6107.083937409379;6113.32753397126;5890.116482527612;6008.639481631116;6038.516918646497;6051.243594550681;6101.840650276433;5897.4102589741115;5898.056310990264;5902.291724993029;5907.438793314628;5908.4091590841;15743.291551880193;15921.044737315682;23421.648675269884;23971.28086157418;24061.759382406126;2329.8369114162015;2505.3360859372283;2560.8591527465983;2624.7244039375973;2998.025641666445;10960.56157753689;11008.504617292161;11020.063294619968;12982;14919.254037298091;2002.209127394671;2073.3572592496375;2084.791520847918;2094.979050209494;2126.5321629241544;80401.59799201025;86886;87228.56385718031;88094.5595272026;88920;11599.826002609967;11748;11779.469923853447;11828.70428239301;12001.519939202508;16744.16279186036;16755.162241887858;16779.412720554967;16781.328746850235;16807.243674034697;8462.153784621489;8566.3146948244;8578.356623253281;8664.436811607351;8709.433886797464;8108.878366824502;8262.8347433051;8277.58612069406;8341.24928756415;8511.872321915176;4898.21628539432;5057.165567681292;5091.338126043591;5111.463296353903;5226.137687281632;2002.8998550072438;2029.604227175716;2064.958700825975;2165.220520612578;2169.0998235731995;922.1838672774643;1013.2603199664139;1025.220832167558;1034.8706411698538;1044.4777611194402;19849.900750496443;20449;20597;20793.688094678593;20828.89585552093;997.8902320744712;1004.8894621591619;1005.8340373838381;1029.583018877356;1086.5327908999207;10389.84415233772;11458.770824583462;11583.594574189863;11609;11611.374407582945;468294;506780;512968;513775;517557;90919;97350;100693.49653251833;102089;102748;1026.471367245869;1031.7214352124884;1080.6974047266779;1082.2370228988702;1083.041508265191;17777.20002599912;17881.642367152843;18251.178696958403;18406.907965460086;18410.447686569423;42223.78888105663;43192;45379.092418150794;45649.77175114103;46246;61831.38168618256;62624.68687656533;63571.68214158899;64101.35898640954;64477;8678.609462574326;8698.47809131454;8804.955975220082;8811.162939520735;9012.86480702803;12329.198602090835;12796.360181990676;13069.215847048827;14120;14621.92689036548;11406.885931140583;12017.81973270419;12155;12172;12193.756124877274;11262.7747445049;11456.3698996556;11907.702307442383;12065.879341206826;12563.120581559204;11583.189176757884;11711.121665874924;11930.582429614922;11961.64115076549;11982.940085299517;7876.212378762078;8382.203690649378;8434.536100514286;8605.440646358216;9011.098890110936;12096.75806483883;12385.876141238472;12402.25586464815;12489.625311240678;12524.935380492396 05:35:48 INFO - PROCESS | 6812 | |3;mootools.html;1430.4850253908598;1513.4929798517492;1537.0470308408787;1694.2375930831129;1820.0899550224879;7457.627118644066;8056.879146812795;8349.123342049088;8352.373571982096;8501.192386723267;8227.794305142374;8318.83362332753;8337.291330236922;8348.791280217998;8362.958185209065;2361.9055237790512;2385.4751954569965;2388.4625959159225;2393.162393162388;2394.209910729464;2366.5503554324623;2382.761723827612;2425.0784701813286;2427.9923831609863;2436.7319594844553;2378.9643155352683;2383.1658919378165;2402.3753824005707;2415.7946574541184;2420.8426452280632;2257.7403598586206;2270.477790108268;2294.919677811277;2299.1033496936207;2316.0851463671925;2340.6840076589783;2363.4800343924308;2379.167291447997;2385.797207237387;2385.85684858909;8153.5923203839575;8313.542755148464;8451.661933522651;8509.74470765878;8542.402031857773;5137.280780690707;5328.227407025998;5329.920051199235;5336.199570064521;5337.946620533823;3068.739157171643;3072.9231769205726;3123.937521249585;3134.6238451385752;3137.1529686984613;1039.449091981251;1045.0855501436242;1059.2743970380236;1082.5236895765916;1086.6033897627387;11490.253133546294;11503.539858405653;11534.077273818075;11558.075353971662;11578.594749183738;4200.4959404871615;4500.347449619787;4535.365048893158;4566.543345665407;4574.817007319736;9181.58682859273;9186.540672966325;9198.126178013077;9207.125323094295;9212.170904618617;5092.541671249605;5127;5130.7947682093045;5131;5139.383274007068;4252.192083504125;4397.274449715761;4641.419822522184;4711.057788442256;4789.281607758864;3756.342640038037;3836.290286297044;3873.786941718176;3923.195744872294;3933;1210.305572198911;1212.4846940050443;1213.7815193265296;1219.939003049844;1222.248317284881;899.8020435504178;955.0592666223903;959.4483172176027;1017.8320577104695;1048.0933992096782;5404.891902161935;5626.690532020778;5675.808080303183;5809.912851307234;6103.755849765959;999.550202408919;1027.9434631095362;1032.1536340201112;1060.7401186709305;1077.9191560632985;4038.2932986727205;4188.036751547101;4210.810513526899;4260.275753121977;4268.786560671954;9581.425114493153;9712.660056897974;9854.162396196403;9937.45344006072;10332.173426125892;9971.102600765966;10039.04629060238;10054.69835904924;10060.899391006142;10084.49577521121;7590.544567325978;7939.920600794034;8044.316233120133;8046.235607617267;8048.5170889746805;5810.82567522975;5953.047512397996;5963.582549221513;6000.669963152069;6032.336442991355;9430.764230894283;9484.905150948402;9546.474943878153;9572.617095316109;9585.424874507551;9502.04979502072;9625.663101791404;9704.078112579293;9758.853617195606;9782.364146330467;6603.834904127243;6797.5581587196675;7428.665710043169;7445.7766267012075;7554.848903022019;8016.1182269949095;8344.624491898001;8353.749387518385;8369.707060252862;8371.748847534584;7246.782596522113;7272.636368181676;7342.045534080536;7516.3611093055515;7558.886616700864;7111.573305601473;7179;7275.236100209613;7327.670254838438;7415.369693575891;6693.2972037935315;6783.3555812197765;6789.083473730983;6802.6258555779905;6817;4584.564466375689;4705.55297246761;4739.431268247695;4749.121412538553;4756.667033307774;5154.407243166934;5157.638965272395;5182.870428239325;5296.682199067915;5299.046171688979 05:35:48 INFO - PROCESS | 6812 | |4;prototype.html;346.91500582357327;356.4208161737177;359.3441968407657;360.51330703550195;362.97822130672154;5332.786688532459;5386.703731294777;5397.838064858056;5406.67559946403;5427.747484793816;5007.874803129924;5162.432132465426;5162.845114646557;5236.842894713155;5320.308359913215;4214.578542145791;4224.598663126998;4251.447311849463;4252;4258.765767882765;4246.171996460676;4253;4264.872053838374;4271.145770845827;4280.229558679436;4130.731502452346;4182.749035057906;4198.391233271173;4227.87316380509;4259.956310703867;4225.154969006211;4228.513720922103;4234.407182994383;4242.490901091858;4245.8513952011845;3773.5471743390694;3783.9054023649355;3788.7726736395903;3791.829367678461;3812.7521711088966;5041.949580504184;5227.26818245446;5228.215767634885;5238.554722848562;5239.5546378557865;4877.561019508261;4878.487758785312;4879.39007624047;4895.6083513318845;4896.706197628154;5603.459048761623;5605.411431799684;5612.943870561283;5631.493165615114;5651.2481130849565;4089.427480152781;4129.504459464853;4159.646430053449;4195;4198.223328684173;5807.274090738658;5811.854703632401;5815.941840581582;5820.650760954356;5826.300843898717;4225.366195070703;4256.57434256578;4257.212415703105;4259.61663450291;4272.722273052242;4173.351526147216;4283.20760659279;4300.591443812833;4316.093620339701;4322.675799315064;4816.627261230533;4828.420589529279;4836.927446088312;4838.685485443435;4842;5620.522255608237;5627.409122042127;5637.590602349413;5644.435556444323;5649.548036157097;1397.1826481508228;1441.3369849868968;1451.4339407631032;1455.2432734977751;1464.1507925403241;1011.3426272922512;1018.7367664096467;1020.9897901021043;1029.7591402360138;1041;5294.7617357219015;5299.602529810202;5300.390455097636;5326.946730532645;5329.523200511589;5515.145152501369;5571.857769157313;5577.995960727027;5604.85987850307;5607;5237.869053273623;5255.947440525546;5311.628186026941;5320.483662156267;5541.5289700375915;2987.193457766391;3003.219163017631;3004.774641901822;3006.6548092487897;3007.5639032340187;5796.362400135981;5799.739011744482;5827.708614569255;5834.5624078194305;5859;5467.589930755209;5671.943280567224;5720.997650822263;5724.484796368347;5728.942710572925;5773.278340207474;5783.797567085132;5791.5656325775735;5815.534757219412;5817.603775093947;5344.278522399582;5478.726063696719;5546.528545073714;5559.861003474945;5572.275604171432;5512.062949298549;5534.335879694462;5558.333000039859;5565.916511252415;5566.387697353207;5754.56840736938;5759.337676167127;5770.740316685676;5804.593678442468;5835.44563266489;3965.068208970947;4085.3667681509414;4099.487564054493;4103.158852435304;4136.565660605593;5545.201536947204;5585.273914391266;5607.719614019365;5785.82642520725;5798.59409841307;5625.268715067015;5639.488409272648;5641.182028605911;5649.548036157015;5672.7163641816915;5538.750756215899;5615.438456154352;5623.268975033383;5633.549316054624;5640.464155905182;5566.860828479321;5576.525995290446;5584.3857175711455;5596.188552659923;5599.972000139973;5657.5473962082115;5658.151277308437;5659.745311460912;5668.801591944262;5670.886582268414;5407.567394608501;5448.447192550104;5493.7802487900035;5504.504594586347;5559.388467268678 05:35:48 INFO - PROCESS | 6812 | |5;yui.html;793.9523628582285;795.0141824138069;806.66523392792;832.2842355574202;914.1452741686528;13922.651933701662;14890.851091489096;15397.461088861864;15475.84524154761;15659.13874736889;16011.27949242284;16240.83759162408;16243.756343654824;16416.425425110123;16467.423640172565;856.1053698884649;870.4429165334191;872.8341615093144;875.0811647769848;875.5928493250638;721.2859269323359;739.7632757517597;840.7561807075971;860.0582362313288;868.097178933908;892.1613683137862;895.7357579514058;896.4083704754863;896.6144557840158;896.8206358728248;871.3247233394106;872.3283072034498;878.108719649553;879.7932485865848;879.8196369744219;651.8663673946877;654.0222367560527;655.7639249870043;658.4534836086085;658.9967050164719;14463.349149288308;14630.926845365811;14669.559913202622;14670.04644698102;14894.329755161043;11843.289402635783;14480;14513.20177390243;14969.649403419538;15190.164540950243;12369.69075773104;12458.563950261698;12530.74938501234;12716.046296527797;12868;3852.3836186210074;3858.575556688762;3878.6897048236356;3963.920721585581;4029.315016447211;52943;64995.675021625066;65806.01290980639;66734;67145;11196.328220306808;11448;11531.596394126165;11562.710932226593;11700.824487632692;21110.683339749918;21416.357509274745;21455;22073.11707531713;22142.88928555347;8750.124987501198;8892.555372231363;9474.478903660227;9509.286803489766;9513.738923225827;4344.761038142932;4620.1914664934175;4634.606058485067;4670.8365207217585;4718.7168769873915;3581.426971684518;3686.981565092211;3691.8523259069875;3702.777833330009;3707.7775333480076;648.1056142523288;648.4099469482748;656.0258016844981;656.1306269193337;667.559410788877;650.3821369698805;764.4152223548989;766.9616519174019;783.8158032862273;791.2364568191723;9298.67454639098;9451.952740236255;9452.763680907894;9543.9045609543;9835.164011058998;671.7783131566571;764.1670579068841;778.9766307010685;779.0806847919396;781.1563511407666;4492.752898590544;4730.337752714623;4758.833440829554;4791.928121078186;4802.951970480321;51466;84036.57981710053;93141.5342923281;95914;95987;46956.29565556519;52909.7354513225;71570.64214678998;77638.61180694061;77775;43023.35464968028;44747;67414.66292668505;71517.6424117876;74186;9752.414855108716;10144.64493742745;10193.23550733683;10273.537690803782;10406.323588966692;46631.30053049139;47062.76468617635;47167.528324717685;47922.5207747918;48603.27095093647;53143;60050.39949600623;60401.09398359116;61112;62059;13051.394479944514;13611.25138117413;13735.519256826363;13780.517681881087;13905.582832515041;15002.924985375439;15085.849141508445;15114.244287785787;15121.319540620478;15194.772078419053;13794.448222071005;14253.28733563297;14402.063865848686;14847.851521484647;15370.84629153739;12531.686707832378;12743.980481561639;14435.494757683431;14437.06159099655;14808.851911480748;11954.820677689668;12927.5475358362;12977.935110324388;13358.131721438076;13566.525171619342;11244.156688248251;11485.942570287429;11528.423578821194;11582;11662.94168529152;11980.64058078259;12030.518779248732;12042.698932526406;12250.754984900073;12267.509299627915 05:35:48 INFO - PROCESS | 6812 | __end_tp_report 05:35:48 INFO - PROCESS | 6812 | __start_cc_report 05:35:48 INFO - PROCESS | 6812 | _x_x_mozilla_cycle_collect,973 05:35:48 INFO - PROCESS | 6812 | __end_cc_report 05:35:48 INFO - PROCESS | 6812 | __startTimestamp1485351348130__endTimestamp 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - PROCESS | 6812 | ------- Summary: start ------- 05:35:48 INFO - PROCESS | 6812 | Number of tests: 6 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - PROCESS | 6812 | [#0] dojo.html Cycles:165 Average:5489.89 Median:5706.63 stddev:616.80 (10.8%) stddev-sans-first:592.57 05:35:48 INFO - PROCESS | 6812 | Values: 3226.0 3247.1 3277.5 3277.6 3298.8 5414.3 5462.3 5487.9 5500.6 5511.4 5533.9 5558.2 5571.0 5573.7 5575.7 4999.4 5051.6 5084.1 5089.4 5146.3 4954.6 5077.6 5122.6 5134.0 5136.3 4928.0 5001.7 5003.8 5076.7 5097.1 5052.1 5071.8 5090.5 5141.2 5177.9 4782.9 5033.7 5045.7 5095.8 5113.8 5256.8 5299.0 5370.7 5376.3 5376.5 5812.9 5818.9 5826.9 5875.6 5878.5 5830.9 5941.4 5951.9 5957.5 5963.2 5486.8 5507.1 5528.6 5559.7 5611.1 6048.5 6068.7 6084.7 6086.2 6105.9 5691.7 5843.3 5851.1 5852.3 5854.9 5799.2 5846.4 5913.4 5915.8 5994.1 5934.4 5935.8 5943.9 5948.0 5981.3 5904.4 5956.1 5961.0 5963.9 5981.3 4465.8 4475.4 4514.0 4521.0 4532.0 4004.8 4028.8 4049.6 4056.2 4079.0 5537.5 5554.9 5607.4 5615.9 5619.2 5706.6 5791.0 5841.0 5891.4 5931.4 5456.3 5497.5 5517.0 5523.4 5523.7 4989.4 4995.0 4996.5 5000.0 5050.3 5973.3 5976.5 5978.6 6010.3 6032.8 5788.9 5937.9 6021.1 6022.5 6027.0 6150.4 6183.8 6187.4 6192.6 6197.9 5700.6 5840.4 5841.0 5850.2 5882.4 5856.4 5885.5 5947.9 5963.5 6044.1 5757.2 5813.8 5816.5 5820.9 5862.1 5775.8 5820.4 5823.4 5827.5 5829.0 5538.9 5548.3 5665.5 5693.3 5749.8 5852.5 5857.8 5859.9 5867.9 5882.4 5571.0 5745.1 5746.8 5760.0 5760.2 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - PROCESS | 6812 | [#1] ext.html Cycles:180 Average:60364.66 Median:20827.70 stddev:115942.35 (556.7%) stddev-sans-first:116180.72 05:35:48 INFO - PROCESS | 6812 | Values: 583.6 607.9 635.1 662.5 663.2 34433.8 44770.6 45581.0 45599.3 45637.1 46445.3 47028.8 47078.5 47092.0 47108.8 8453.9 8974.4 9076.9 9124.7 9143.6 8686.3 10836.0 11086.7 11094.7 11386.3 11088.7 11126.6 11147.4 11147.5 11155.1 10993.5 11044.0 11048.7 11051.1 11064.8 10873.7 10907.2 10910.6 10925.5 10928.5 44492.3 44816.3 44848.1 44885.1 44892.0 3692.2 3782.0 3811.6 3970.6 4238.4 34048.8 34085.3 34442.7 34461.0 34608.3 4229.5 4345.3 4402.8 4431.7 4500.2 346407.0 346918.0 348852.0 349086.0 350045.0 65688.3 66233.3 66368.3 66391.3 66452.7 40512.8 41271.0 41628.6 43162.4 70372.6 18630.4 18865.9 18880.6 18884.4 18885.9 12930.7 13141.0 14286.6 14467.1 14490.1 19708.2 20639.2 20666.1 20759.9 20767.1 7326.7 7396.9 7496.2 7552.8 7647.5 969.4 1033.3 1061.5 1126.9 1169.4 33776.0 34350.3 34361.8 34553.7 34869.8 1138.3 1144.3 1191.7 1257.9 1299.8 18005.5 18227.4 18258.7 18395.3 18420.4 535649.0 545055.0 546147.0 546365.0 551505.0 62553.4 63420.4 63440.7 63534.4 63567.0 1296.0 1336.5 1404.4 1435.1 1457.5 30905.5 34529.7 35472.8 35486.5 35640.0 53155.7 53760.0 53785.5 53789.0 53791.7 371386.0 371729.0 372616.0 373646.0 485013.0 26007.7 27740.3 28674.3 29658.9 30608.8 48548.5 49157.8 49872.8 50071.5 50381.5 42580.4 43161.8 43227.8 43695.6 44338.0 42129.2 42394.0 43085.0 44048.6 44097.0 39036.6 39342.2 40047.2 40205.8 40473.2 35487.6 37873.4 38046.4 38643.0 38984.0 29610.4 29746.3 29952.6 30067.0 30158.7 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - PROCESS | 6812 | [#2] jquery.html Cycles:180 Average:30220.99 Median:2145.88 stddev:83316.47 (3882.6%) stddev-sans-first:83520.15 05:35:48 INFO - PROCESS | 6812 | Values: 423.0 429.1 431.6 435.7 451.4 18393.6 18610.3 20047.5 20225.3 20361.6 19578.2 19998.9 20181.7 20259.5 20896.0 5306.8 5513.6 5523.0 5528.1 5532.8 5408.9 5479.6 5500.1 5745.9 5951.3 6103.1 6105.7 6107.0 6107.1 6113.3 5890.1 6008.6 6038.5 6051.2 6101.8 5897.4 5898.1 5902.3 5907.4 5908.4 15743.3 15921.0 23421.6 23971.3 24061.8 2329.8 2505.3 2560.9 2624.7 2998.0 10960.6 11008.5 11020.1 12982.0 14919.3 2002.2 2073.4 2084.8 2095.0 2126.5 80401.6 86886.0 87228.6 88094.6 88920.0 11599.8 11748.0 11779.5 11828.7 12001.5 16744.2 16755.2 16779.4 16781.3 16807.2 8462.2 8566.3 8578.4 8664.4 8709.4 8108.9 8262.8 8277.6 8341.2 8511.9 4898.2 5057.2 5091.3 5111.5 5226.1 2002.9 2029.6 2065.0 2165.2 2169.1 922.2 1013.3 1025.2 1034.9 1044.5 19849.9 20449.0 20597.0 20793.7 20828.9 997.9 1004.9 1005.8 1029.6 1086.5 10389.8 11458.8 11583.6 11609.0 11611.4 468294.0 506780.0 512968.0 513775.0 517557.0 90919.0 97350.0 100693.5 102089.0 102748.0 1026.5 1031.7 1080.7 1082.2 1083.0 17777.2 17881.6 18251.2 18406.9 18410.4 42223.8 43192.0 45379.1 45649.8 46246.0 61831.4 62624.7 63571.7 64101.4 64477.0 8678.6 8698.5 8805.0 8811.2 9012.9 12329.2 12796.4 13069.2 14120.0 14621.9 11406.9 12017.8 12155.0 12172.0 12193.8 11262.8 11456.4 11907.7 12065.9 12563.1 11583.2 11711.1 11930.6 11961.6 11982.9 7876.2 8382.2 8434.5 8605.4 9011.1 12096.8 12385.9 12402.3 12489.6 12524.9 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - PROCESS | 6812 | [#3] mootools.html Cycles:180 Average:5541.43 Median:5138.33 stddev:3026.93 (58.9%) stddev-sans-first:3019.65 05:35:48 INFO - PROCESS | 6812 | Values: 1430.5 1513.5 1537.0 1694.2 1820.1 7457.6 8056.9 8349.1 8352.4 8501.2 8227.8 8318.8 8337.3 8348.8 8363.0 2361.9 2385.5 2388.5 2393.2 2394.2 2366.6 2382.8 2425.1 2428.0 2436.7 2379.0 2383.2 2402.4 2415.8 2420.8 2257.7 2270.5 2294.9 2299.1 2316.1 2340.7 2363.5 2379.2 2385.8 2385.9 8153.6 8313.5 8451.7 8509.7 8542.4 5137.3 5328.2 5329.9 5336.2 5337.9 3068.7 3072.9 3123.9 3134.6 3137.2 1039.4 1045.1 1059.3 1082.5 1086.6 11490.3 11503.5 11534.1 11558.1 11578.6 4200.5 4500.3 4535.4 4566.5 4574.8 9181.6 9186.5 9198.1 9207.1 9212.2 5092.5 5127.0 5130.8 5131.0 5139.4 4252.2 4397.3 4641.4 4711.1 4789.3 3756.3 3836.3 3873.8 3923.2 3933.0 1210.3 1212.5 1213.8 1219.9 1222.2 899.8 955.1 959.4 1017.8 1048.1 5404.9 5626.7 5675.8 5809.9 6103.8 999.6 1027.9 1032.2 1060.7 1077.9 4038.3 4188.0 4210.8 4260.3 4268.8 9581.4 9712.7 9854.2 9937.5 10332.2 9971.1 10039.0 10054.7 10060.9 10084.5 7590.5 7939.9 8044.3 8046.2 8048.5 5810.8 5953.0 5963.6 6000.7 6032.3 9430.8 9484.9 9546.5 9572.6 9585.4 9502.0 9625.7 9704.1 9758.9 9782.4 6603.8 6797.6 7428.7 7445.8 7554.8 8016.1 8344.6 8353.7 8369.7 8371.7 7246.8 7272.6 7342.0 7516.4 7558.9 7111.6 7179.0 7275.2 7327.7 7415.4 6693.3 6783.4 6789.1 6802.6 6817.0 4584.6 4705.6 4739.4 4749.1 4756.7 5154.4 5157.6 5182.9 5296.7 5299.0 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - PROCESS | 6812 | [#4] prototype.html Cycles:180 Average:4718.34 Median:5320.40 stddev:1348.57 (25.3%) stddev-sans-first:1311.83 05:35:48 INFO - PROCESS | 6812 | Values: 346.9 356.4 359.3 360.5 363.0 5332.8 5386.7 5397.8 5406.7 5427.7 5007.9 5162.4 5162.8 5236.8 5320.3 4214.6 4224.6 4251.4 4252.0 4258.8 4246.2 4253.0 4264.9 4271.1 4280.2 4130.7 4182.7 4198.4 4227.9 4260.0 4225.2 4228.5 4234.4 4242.5 4245.9 3773.5 3783.9 3788.8 3791.8 3812.8 5041.9 5227.3 5228.2 5238.6 5239.6 4877.6 4878.5 4879.4 4895.6 4896.7 5603.5 5605.4 5612.9 5631.5 5651.2 4089.4 4129.5 4159.6 4195.0 4198.2 5807.3 5811.9 5815.9 5820.7 5826.3 4225.4 4256.6 4257.2 4259.6 4272.7 4173.4 4283.2 4300.6 4316.1 4322.7 4816.6 4828.4 4836.9 4838.7 4842.0 5620.5 5627.4 5637.6 5644.4 5649.5 1397.2 1441.3 1451.4 1455.2 1464.2 1011.3 1018.7 1021.0 1029.8 1041.0 5294.8 5299.6 5300.4 5326.9 5329.5 5515.1 5571.9 5578.0 5604.9 5607.0 5237.9 5255.9 5311.6 5320.5 5541.5 2987.2 3003.2 3004.8 3006.7 3007.6 5796.4 5799.7 5827.7 5834.6 5859.0 5467.6 5671.9 5721.0 5724.5 5728.9 5773.3 5783.8 5791.6 5815.5 5817.6 5344.3 5478.7 5546.5 5559.9 5572.3 5512.1 5534.3 5558.3 5565.9 5566.4 5754.6 5759.3 5770.7 5804.6 5835.4 3965.1 4085.4 4099.5 4103.2 4136.6 5545.2 5585.3 5607.7 5785.8 5798.6 5625.3 5639.5 5641.2 5649.5 5672.7 5538.8 5615.4 5623.3 5633.5 5640.5 5566.9 5576.5 5584.4 5596.2 5600.0 5657.5 5658.2 5659.7 5668.8 5670.9 5407.6 5448.4 5493.8 5504.5 5559.4 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - PROCESS | 6812 | [#5] yui.html Cycles:180 Average:17568.12 Median:25651.07 stddev:22194.06 (86.5%) stddev-sans-first:22220.57 05:35:48 INFO - PROCESS | 6812 | Values: 794.0 795.0 806.7 832.3 914.1 13922.7 14890.9 15397.5 15475.8 15659.1 16011.3 16240.8 16243.8 16416.4 16467.4 856.1 870.4 872.8 875.1 875.6 721.3 739.8 840.8 860.1 868.1 892.2 895.7 896.4 896.6 896.8 871.3 872.3 878.1 879.8 879.8 651.9 654.0 655.8 658.5 659.0 14463.3 14630.9 14669.6 14670.0 14894.3 11843.3 14480.0 14513.2 14969.6 15190.2 12369.7 12458.6 12530.7 12716.0 12868.0 3852.4 3858.6 3878.7 3963.9 4029.3 52943.0 64995.7 65806.0 66734.0 67145.0 11196.3 11448.0 11531.6 11562.7 11700.8 21110.7 21416.4 21455.0 22073.1 22142.9 8750.1 8892.6 9474.5 9509.3 9513.7 4344.8 4620.2 4634.6 4670.8 4718.7 3581.4 3687.0 3691.9 3702.8 3707.8 648.1 648.4 656.0 656.1 667.6 650.4 764.4 767.0 783.8 791.2 9298.7 9452.0 9452.8 9543.9 9835.2 671.8 764.2 779.0 779.1 781.2 4492.8 4730.3 4758.8 4791.9 4803.0 51466.0 84036.6 93141.5 95914.0 95987.0 46956.3 52909.7 71570.6 77638.6 77775.0 43023.4 44747.0 67414.7 71517.6 74186.0 9752.4 10144.6 10193.2 10273.5 10406.3 46631.3 47062.8 47167.5 47922.5 48603.3 53143.0 60050.4 60401.1 61112.0 62059.0 13051.4 13611.3 13735.5 13780.5 13905.6 15002.9 15085.8 15114.2 15121.3 15194.8 13794.4 14253.3 14402.1 14847.9 15370.8 12531.7 12744.0 14435.5 14437.1 14808.9 11954.8 12927.5 12977.9 13358.1 13566.5 11244.2 11485.9 11528.4 11582.0 11662.9 11980.6 12030.5 12042.7 12250.8 12267.5 05:35:48 INFO - PROCESS | 6812 | -------- Summary: end -------- 05:35:48 INFO - PROCESS | 6812 | 05:35:48 INFO - TEST-INFO | 6812: exit 0 05:35:48 INFO - TEST-OK | dromaeo_css | took 1114163ms 05:35:48 INFO - TEST-START | kraken 05:35:48 INFO - operating with platform_type : linux_ 05:35:48 INFO - Initialising browser for kraken test... 05:35:48 INFO - TEST-INFO | started process 7114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfHG2_P/profile http://localhost:34932/getInfo.html) 05:35:53 INFO - PROCESS | 7114 | __metrics Screen width/height:1600/1200 05:35:53 INFO - PROCESS | 7114 | colorDepth:24 05:35:53 INFO - PROCESS | 7114 | Browser inner width/height: 1024/697 05:35:53 INFO - PROCESS | 7114 | __metrics 05:35:53 INFO - PROCESS | 7114 | 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" 05:35:53 INFO - PROCESS | 7114 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:35:54 INFO - PROCESS | 7114 | console.error: PushService: 05:35:54 INFO - PROCESS | 7114 | stateChangeProcessEnqueue: Error transitioning state 05:35:54 INFO - PROCESS | 7114 | UnknownError 05:35:54 INFO - TEST-INFO | 7114: exit 0 05:35:54 INFO - Browser initialized. 05:35:54 INFO - Running cycle 1/1 for kraken test... 05:35:54 INFO - TEST-INFO | started process 7204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfHG2_P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:06 INFO - PROCESS | 7204 | RSS: Main: 141877248 05:36:06 INFO - PROCESS | 7204 | 05:36:08 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34932/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:09 INFO - PROCESS | 7204 | RSS: Main: 182816768 05:36:09 INFO - PROCESS | 7204 | 05:36:12 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34932/tests/kraken/driver.html?testName=audio-dft) 05:36:12 INFO - PROCESS | 7204 | RSS: Main: 172785664 05:36:12 INFO - PROCESS | 7204 | 05:36:15 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34932/tests/kraken/driver.html?testName=audio-fft) 05:36:16 INFO - PROCESS | 7204 | RSS: Main: 264036352 05:36:16 INFO - PROCESS | 7204 | 05:36:18 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34932/tests/kraken/driver.html?testName=audio-oscillator) 05:36:18 INFO - PROCESS | 7204 | RSS: Main: 170938368 05:36:18 INFO - PROCESS | 7204 | 05:36:21 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:21 INFO - PROCESS | 7204 | RSS: Main: 173621248 05:36:21 INFO - PROCESS | 7204 | 05:36:24 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34932/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:25 INFO - PROCESS | 7204 | RSS: Main: 212045824 05:36:25 INFO - PROCESS | 7204 | 05:36:28 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34932/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:29 INFO - PROCESS | 7204 | RSS: Main: 210513920 05:36:29 INFO - PROCESS | 7204 | 05:36:31 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34932/tests/kraken/driver.html?testName=json-parse-financial) 05:36:32 INFO - PROCESS | 7204 | RSS: Main: 209051648 05:36:32 INFO - PROCESS | 7204 | 05:36:33 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:34 INFO - PROCESS | 7204 | RSS: Main: 171237376 05:36:34 INFO - PROCESS | 7204 | 05:36:35 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34932/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:36 INFO - PROCESS | 7204 | RSS: Main: 177987584 05:36:36 INFO - PROCESS | 7204 | 05:36:38 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:39 INFO - PROCESS | 7204 | RSS: Main: 187121664 05:36:39 INFO - PROCESS | 7204 | 05:36:41 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:42 INFO - PROCESS | 7204 | RSS: Main: 196280320 05:36:42 INFO - PROCESS | 7204 | 05:36:45 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:45 INFO - PROCESS | 7204 | RSS: Main: 192724992 05:36:45 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | Cycle 1(1): loaded http://localhost:34932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34932/tests/kraken/driver.html?testName=ai-astar) 05:36:47 INFO - PROCESS | 7204 | RSS: Main: 244473856 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | __start_tp_report 05:36:47 INFO - PROCESS | 7204 | _x_x_mozilla_page_load 05:36:47 INFO - PROCESS | 7204 | _x_x_mozilla_page_load_details 05:36:47 INFO - PROCESS | 7204 | |i|pagename|runs| 05:36:47 INFO - PROCESS | 7204 | |0;ai-astar;102;111;110;109;111;110;110;111;111;110 05:36:47 INFO - PROCESS | 7204 | |1;audio-beat-detection;149;116;119;156;118;121;123;119;146;119 05:36:47 INFO - PROCESS | 7204 | |2;audio-dft;161;170;159;160;161;161;161;163;160;162 05:36:47 INFO - PROCESS | 7204 | |3;audio-fft;74;76;75;123;77;75;76;75;99;75 05:36:47 INFO - PROCESS | 7204 | |4;audio-oscillator;82;82;112;83;81;83;100;82;82;101 05:36:47 INFO - PROCESS | 7204 | |5;imaging-gaussian-blur;116;117;117;117;118;117;116;117;116;117 05:36:47 INFO - PROCESS | 7204 | |6;imaging-darkroom;146;146;146;146;145;145;145;146;145;145 05:36:47 INFO - PROCESS | 7204 | |7;imaging-desaturate;84;85;84;85;84;84;84;84;85;84 05:36:47 INFO - PROCESS | 7204 | |8;json-parse-financial;51;53;51;53;51;52;52;50;51;51 05:36:47 INFO - PROCESS | 7204 | |9;json-stringify-tinderbox;59;58;58;60;58;59;58;58;58;58 05:36:47 INFO - PROCESS | 7204 | |10;stanford-crypto-aes;75;77;81;76;76;74;74;74;75;76 05:36:47 INFO - PROCESS | 7204 | |11;stanford-crypto-ccm;125;121;127;124;126;129;120;121;167;121 05:36:47 INFO - PROCESS | 7204 | |12;stanford-crypto-pbkdf2;162;156;159;155;162;158;162;169;161;155 05:36:47 INFO - PROCESS | 7204 | |13;stanford-crypto-sha256-iterative;63;66;63;62;61;64;62;64;61;61 05:36:47 INFO - PROCESS | 7204 | __end_tp_report 05:36:47 INFO - PROCESS | 7204 | __start_cc_report 05:36:47 INFO - PROCESS | 7204 | _x_x_mozilla_cycle_collect,1561 05:36:47 INFO - PROCESS | 7204 | __end_cc_report 05:36:47 INFO - PROCESS | 7204 | __startTimestamp1485351407563__endTimestamp 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | ------- Summary: start ------- 05:36:47 INFO - PROCESS | 7204 | Number of tests: 14 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.72 (2.5%) stddev-sans-first:0.71 05:36:47 INFO - PROCESS | 7204 | Values: 102.0 111.0 110.0 109.0 111.0 110.0 110.0 111.0 111.0 110.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:122.00 stddev:15.30 (12.5%) stddev-sans-first:14.34 05:36:47 INFO - PROCESS | 7204 | Values: 149.0 116.0 119.0 156.0 118.0 121.0 123.0 119.0 146.0 119.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.00 stddev:3.08 (1.9%) stddev-sans-first:3.26 05:36:47 INFO - PROCESS | 7204 | Values: 161.0 170.0 159.0 160.0 161.0 161.0 161.0 163.0 160.0 162.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.50 stddev:16.07 (21.3%) stddev-sans-first:16.75 05:36:47 INFO - PROCESS | 7204 | Values: 74.0 76.0 75.0 123.0 77.0 75.0 76.0 75.0 99.0 75.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:11.18 (13.6%) stddev-sans-first:11.59 05:36:47 INFO - PROCESS | 7204 | Values: 82.0 82.0 112.0 83.0 81.0 83.0 100.0 82.0 82.0 101.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 05:36:47 INFO - PROCESS | 7204 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 116.0 117.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:36:47 INFO - PROCESS | 7204 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 05:36:47 INFO - PROCESS | 7204 | Values: 84.0 85.0 84.0 85.0 84.0 84.0 84.0 84.0 85.0 84.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:0.97 (1.9%) stddev-sans-first:1.01 05:36:47 INFO - PROCESS | 7204 | Values: 51.0 53.0 51.0 53.0 51.0 52.0 52.0 50.0 51.0 51.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 05:36:47 INFO - PROCESS | 7204 | Values: 59.0 58.0 58.0 60.0 58.0 59.0 58.0 58.0 58.0 58.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:2.10 (2.8%) stddev-sans-first:2.20 05:36:47 INFO - PROCESS | 7204 | Values: 75.0 77.0 81.0 76.0 76.0 74.0 74.0 74.0 75.0 76.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:125.50 stddev:14.00 (11.2%) stddev-sans-first:14.80 05:36:47 INFO - PROCESS | 7204 | Values: 125.0 121.0 127.0 124.0 126.0 129.0 120.0 121.0 167.0 121.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:161.50 stddev:4.28 (2.7%) stddev-sans-first:4.47 05:36:47 INFO - PROCESS | 7204 | Values: 162.0 156.0 159.0 155.0 162.0 158.0 162.0 169.0 161.0 155.0 05:36:47 INFO - PROCESS | 7204 | 05:36:47 INFO - PROCESS | 7204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.64 (2.6%) stddev-sans-first:1.73 05:36:47 INFO - PROCESS | 7204 | Values: 63.0 66.0 63.0 62.0 61.0 64.0 62.0 64.0 61.0 61.0 05:36:47 INFO - PROCESS | 7204 | -------- Summary: end -------- 05:36:47 INFO - PROCESS | 7204 | 05:36:48 INFO - TEST-INFO | 7204: exit 0 05:36:48 INFO - TEST-OK | kraken | took 59959ms 05:36:48 INFO - SUITE-END | took 1174s 05:36:49 INFO - Completed test suite (00:19:34) 05:36:49 INFO - javascript benchmark 05:36:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3226.0160651001443, 3247.139508030371, 3277.4592192288274, 3277.5739153909994, 3298.835058247087, 5414.269073675057, 5462.344518657762, 5487.890242195163, 5500.614956953005, 5511.421300763417, 5533.916991245124, 5558.249636299099, 5571.025070612647, 5573.665580065189, 5575.665460072399, 4999.425066117397, 5051.570616497602, 5084.13569693153, 5089.440161582223, 5146.279520867081, 4954.628402869781, 5077.5684066854365, 5122.564582010534, 5134.0, 5136.306598609196, 4927.950720492803, 5001.749912504379, 5003.849884503471, 5076.695398276097, 5097.133487307166, 5052.115879721053, 5071.822486212984, 5090.465501122403, 5141.177411614161, 5177.948220517822, 4782.880427989293, 5033.723145227011, 5045.672031317952, 5095.79616815327, 5113.821016264413, 5256.842294731164, 5299.046171689094, 5370.650907691027, 5376.301080859464, 5376.489233522848, 5812.88374232513, 5818.912716309259, 5826.941730582682, 5875.588708790387, 5878.5003274721275, 5830.941690583125, 5941.376155503696, 5951.9107213391835, 5957.523398128139, 5963.194968679216, 5486.780528778844, 5507.118860982264, 5528.585356098309, 5559.6664200148125, 5611.130274807411, 6048.546359023091, 6068.726907289182, 6084.726187321581, 6086.178365920633, 6105.908411373833, 5691.658500489983, 5843.328017277982, 5851.1223316502865, 5852.297724273115, 5854.853628659318, 5799.159121927297, 5846.356900740915, 5913.438223368773, 5915.822525324247, 5994.100884867305, 5934.436228558367, 5935.821925342247, 5943.881122377615, 5947.970260148758, 5981.312149102821, 5904.439078287556, 5956.076808094752, 5960.970195148997, 5963.850903727442, 5981.342052374235, 4465.776711164429, 4475.351074094303, 4513.954860451419, 4520.977395113004, 4531.954680453219, 4004.799760011988, 4028.778417187083, 4049.635532802003, 4056.229316429869, 4078.9796051019557, 5537.529310008614, 5554.944560533567, 5607.383187849333, 5615.8596035098635, 5619.185218143346, 5706.629069110494, 5791.044477661138, 5841.036229022164, 5891.440313170242, 5931.436513531207, 5456.317960254968, 5497.532709719719, 5516.972415137979, 5523.4200408956485, 5523.6685798851395, 4989.376327959005, 4994.9750251248515, 4996.475370086161, 4999.975000124976, 5050.267711181858, 5973.283206015132, 5976.491998180117, 5978.55160862937, 6010.308814486302, 6032.758689652364, 5788.9131663024245, 5937.940620593911, 6021.096835474714, 6022.45797878193, 6027.0, 6150.367777052875, 6183.81448556544, 6187.443130118311, 6192.628442293477, 6197.907031394623, 5700.600957932905, 5840.386759390203, 5840.970795145997, 5850.151727999501, 5882.411758824083, 5856.443637854397, 5885.47030767233, 5947.910781338197, 5963.493103086286, 6044.063170208625, 5757.165211044459, 5813.7674493021495, 5816.47651711348, 5820.912686309794, 5862.062070068939, 5775.826725198251, 5820.447057529528, 5823.388544202798, 5827.475527202402, 5829.0, 5538.889222215453, 5548.250986116823, 5665.49010589049, 5693.345265294544, 5749.8275051748515, 5852.502537284378, 5857.7949771757785, 5859.853503662443, 5867.882642347215, 5882.352941176553, 5571.025070612545, 5745.109508026263, 5746.827595172152, 5760.0, 5760.222369979999], "value": 5449.134660231288, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.597317850683, 607.8814631146926, 635.1267007864187, 662.542845436649, 663.2140913018077, 34433.82783086087, 44770.55229447704, 45581.0, 45599.31601025987, 45637.08725825482, 46445.30332045013, 47028.76485617576, 47078.52921470784, 47092.0, 47108.76445617767, 8453.915460845405, 8974.416662916921, 9076.8638470423, 9124.680636177734, 9143.588538515784, 8686.261667758248, 10836.0, 11086.667399977974, 11094.667159985172, 11386.259893106962, 11088.667339979813, 11126.6105686301, 11147.386893720843, 11147.498362573704, 11155.05182059526, 10993.505292261827, 11043.99999999996, 11048.723781905437, 11051.115910727203, 11064.778704425866, 10873.728156796064, 10907.18196135293, 10910.61812836547, 10925.508352124174, 10928.508217130247, 44492.332615010804, 44816.32775508337, 44848.103037939385, 44885.10229795386, 44892.0, 3692.2430901665093, 3781.9621803781884, 3811.561670407883, 3970.563238043813, 4238.385434112037, 34048.80829170967, 34085.31829363399, 34442.65557344419, 34461.0, 34608.307833843435, 4229.471316085489, 4345.283028300327, 4402.7578483183415, 4431.711938723973, 4500.191783687923, 346407.0, 346918.0, 348852.0, 349085.99999999744, 350045.0, 65688.34311656823, 66233.33766662369, 66368.33631663621, 66391.33608663948, 66452.66773666197, 40512.79743601263, 41271.0, 41628.58371416308, 43162.35256471155, 70372.64813675899, 18630.441086767147, 18865.90567047156, 18880.622387552172, 18884.43346699601, 18885.90557047206, 12930.67673308156, 13141.0, 14286.642833929234, 14467.059641123293, 14490.130592164503, 19708.21167153298, 20639.174433022512, 20666.07002684883, 20759.896200518902, 20767.065482053345, 7326.67029983652, 7396.926030739732, 7496.212897645669, 7552.811179720551, 7647.464677472635, 969.413504829582, 1033.261218228955, 1061.4639606998571, 1126.921115521922, 1169.351010189353, 33776.0, 34350.312993739986, 34361.82819085888, 34553.65446345555, 34869.825650871586, 1138.3362930742103, 1144.2733863996423, 1191.7259030423052, 1257.9308138052495, 1299.811527328551, 18005.549861253574, 18227.36204232872, 18258.726119108225, 18395.264189432273, 18420.447386578424, 535649.0, 545055.0, 546147.0, 546365.0, 551505.0, 62553.374466255664, 63420.36579634237, 63440.68279658572, 63534.364656352845, 63567.0, 1296.0, 1336.4587342126454, 1404.368034384531, 1435.131745294103, 1457.4898785425016, 30905.53641695421, 34529.654703452645, 35472.82263588665, 35486.46770298396, 35640.0, 53155.734221330196, 53760.0, 53785.46214537804, 53789.0, 53791.731041344545, 371386.0, 371729.0, 372616.0, 373646.0, 485013.0, 26007.73992260129, 27740.30649233785, 28674.283142921595, 29658.851705741334, 30608.84695576508, 48548.514514854396, 49157.75421122871, 49872.75318117076, 50071.499285006685, 50381.49618503915, 42580.36129457998, 43161.78419107884, 43227.78386108049, 43695.56304436915, 44338.0, 42129.157416852104, 42394.0, 43085.0, 44048.55951440573, 44097.0, 39036.609633903296, 39342.2131557373, 40047.19905601814, 40205.79897100496, 40473.1905361897, 35487.64512354947, 37873.431898522096, 38046.429303561024, 38643.0, 38984.0, 29610.407791844475, 29746.256343591584, 29952.550711738906, 30067.0, 30158.69841301559], "value": 21275.45681351474, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.98605289230994, 429.1010333351628, 431.58352190136515, 435.71678409034126, 451.3951305250963, 18393.63212735746, 18610.255589776425, 20047.498812529677, 20225.292114775984, 20361.592768144626, 19578.216871325167, 19998.90000549999, 20181.697274540893, 20259.49351266219, 20896.0, 5306.814261500858, 5513.61404701671, 5522.972385138089, 5528.087865502187, 5532.75102620383, 5408.91886621701, 5479.643823151502, 5500.119980803072, 5745.913811292813, 5951.285845698522, 6103.054026625858, 6105.725242364082, 6106.969465152668, 6107.083937409379, 6113.32753397126, 5890.116482527612, 6008.639481631116, 6038.516918646497, 6051.243594550681, 6101.840650276433, 5897.4102589741115, 5898.056310990264, 5902.291724993029, 5907.438793314628, 5908.4091590841, 15743.291551880193, 15921.044737315682, 23421.648675269884, 23971.28086157418, 24061.759382406126, 2329.8369114162015, 2505.3360859372283, 2560.8591527465983, 2624.7244039375973, 2998.025641666445, 10960.56157753689, 11008.504617292161, 11020.063294619968, 12982.0, 14919.254037298091, 2002.209127394671, 2073.3572592496375, 2084.791520847918, 2094.979050209494, 2126.5321629241544, 80401.59799201025, 86886.0, 87228.56385718031, 88094.5595272026, 88920.0, 11599.826002609967, 11748.0, 11779.469923853447, 11828.70428239301, 12001.519939202508, 16744.16279186036, 16755.162241887858, 16779.412720554967, 16781.328746850235, 16807.243674034697, 8462.153784621489, 8566.3146948244, 8578.356623253281, 8664.436811607351, 8709.433886797464, 8108.878366824502, 8262.8347433051, 8277.58612069406, 8341.24928756415, 8511.872321915176, 4898.21628539432, 5057.165567681292, 5091.338126043591, 5111.463296353903, 5226.137687281632, 2002.8998550072438, 2029.604227175716, 2064.958700825975, 2165.220520612578, 2169.0998235731995, 922.1838672774643, 1013.2603199664139, 1025.220832167558, 1034.8706411698538, 1044.4777611194402, 19849.900750496443, 20449.0, 20597.0, 20793.688094678593, 20828.89585552093, 997.8902320744712, 1004.8894621591619, 1005.8340373838381, 1029.583018877356, 1086.5327908999207, 10389.84415233772, 11458.770824583462, 11583.594574189863, 11609.0, 11611.374407582945, 468294.0, 506780.0, 512968.0, 513775.0, 517557.0, 90919.0, 97350.0, 100693.49653251833, 102089.0, 102748.0, 1026.471367245869, 1031.7214352124884, 1080.6974047266779, 1082.2370228988702, 1083.041508265191, 17777.20002599912, 17881.642367152843, 18251.178696958403, 18406.907965460086, 18410.447686569423, 42223.78888105663, 43192.0, 45379.092418150794, 45649.77175114103, 46246.0, 61831.38168618256, 62624.68687656533, 63571.68214158899, 64101.35898640954, 64477.0, 8678.609462574326, 8698.47809131454, 8804.955975220082, 8811.162939520735, 9012.86480702803, 12329.198602090835, 12796.360181990676, 13069.215847048827, 14120.0, 14621.92689036548, 11406.885931140583, 12017.81973270419, 12155.0, 12172.0, 12193.756124877274, 11262.7747445049, 11456.3698996556, 11907.702307442383, 12065.879341206826, 12563.120581559204, 11583.189176757884, 11711.121665874924, 11930.582429614922, 11961.64115076549, 11982.940085299517, 7876.212378762078, 8382.203690649378, 8434.536100514286, 8605.440646358216, 9011.098890110936, 12096.75806483883, 12385.876141238472, 12402.25586464815, 12489.625311240678, 12524.935380492396], "value": 9643.69007927834, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.4850253908598, 1513.4929798517492, 1537.0470308408787, 1694.2375930831129, 1820.0899550224879, 7457.627118644066, 8056.879146812795, 8349.123342049088, 8352.373571982096, 8501.192386723267, 8227.794305142374, 8318.83362332753, 8337.291330236922, 8348.791280217998, 8362.958185209065, 2361.9055237790512, 2385.4751954569965, 2388.4625959159225, 2393.162393162388, 2394.209910729464, 2366.5503554324623, 2382.761723827612, 2425.0784701813286, 2427.9923831609863, 2436.7319594844553, 2378.9643155352683, 2383.1658919378165, 2402.3753824005707, 2415.7946574541184, 2420.8426452280632, 2257.7403598586206, 2270.477790108268, 2294.919677811277, 2299.1033496936207, 2316.0851463671925, 2340.6840076589783, 2363.4800343924308, 2379.167291447997, 2385.797207237387, 2385.85684858909, 8153.5923203839575, 8313.542755148464, 8451.661933522651, 8509.74470765878, 8542.402031857773, 5137.280780690707, 5328.227407025998, 5329.920051199235, 5336.199570064521, 5337.946620533823, 3068.739157171643, 3072.9231769205726, 3123.937521249585, 3134.6238451385752, 3137.1529686984613, 1039.449091981251, 1045.0855501436242, 1059.2743970380236, 1082.5236895765916, 1086.6033897627387, 11490.253133546294, 11503.539858405653, 11534.077273818075, 11558.075353971662, 11578.594749183738, 4200.4959404871615, 4500.347449619787, 4535.365048893158, 4566.543345665407, 4574.817007319736, 9181.58682859273, 9186.540672966325, 9198.126178013077, 9207.125323094295, 9212.170904618617, 5092.541671249605, 5127.0, 5130.7947682093045, 5131.0, 5139.383274007068, 4252.192083504125, 4397.274449715761, 4641.419822522184, 4711.057788442256, 4789.281607758864, 3756.342640038037, 3836.290286297044, 3873.786941718176, 3923.195744872294, 3933.0, 1210.305572198911, 1212.4846940050443, 1213.7815193265296, 1219.939003049844, 1222.248317284881, 899.8020435504178, 955.0592666223903, 959.4483172176027, 1017.8320577104695, 1048.0933992096782, 5404.891902161935, 5626.690532020778, 5675.808080303183, 5809.912851307234, 6103.755849765959, 999.550202408919, 1027.9434631095362, 1032.1536340201112, 1060.7401186709305, 1077.9191560632985, 4038.2932986727205, 4188.036751547101, 4210.810513526899, 4260.275753121977, 4268.786560671954, 9581.425114493153, 9712.660056897974, 9854.162396196403, 9937.45344006072, 10332.173426125892, 9971.102600765966, 10039.04629060238, 10054.69835904924, 10060.899391006142, 10084.49577521121, 7590.544567325978, 7939.920600794034, 8044.316233120133, 8046.235607617267, 8048.5170889746805, 5810.82567522975, 5953.047512397996, 5963.582549221513, 6000.669963152069, 6032.336442991355, 9430.764230894283, 9484.905150948402, 9546.474943878153, 9572.617095316109, 9585.424874507551, 9502.04979502072, 9625.663101791404, 9704.078112579293, 9758.853617195606, 9782.364146330467, 6603.834904127243, 6797.5581587196675, 7428.665710043169, 7445.7766267012075, 7554.848903022019, 8016.1182269949095, 8344.624491898001, 8353.749387518385, 8369.707060252862, 8371.748847534584, 7246.782596522113, 7272.636368181676, 7342.045534080536, 7516.3611093055515, 7558.886616700864, 7111.573305601473, 7179.0, 7275.236100209613, 7327.670254838438, 7415.369693575891, 6693.2972037935315, 6783.3555812197765, 6789.083473730983, 6802.6258555779905, 6817.0, 4584.564466375689, 4705.55297246761, 4739.431268247695, 4749.121412538553, 4756.667033307774, 5154.407243166934, 5157.638965272395, 5182.870428239325, 5296.682199067915, 5299.046171688979], "value": 4506.8898887627265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.91500582357327, 356.4208161737177, 359.3441968407657, 360.51330703550195, 362.97822130672154, 5332.786688532459, 5386.703731294777, 5397.838064858056, 5406.67559946403, 5427.747484793816, 5007.874803129924, 5162.432132465426, 5162.845114646557, 5236.842894713155, 5320.308359913215, 4214.578542145791, 4224.598663126998, 4251.447311849463, 4252.0, 4258.765767882765, 4246.171996460676, 4253.0, 4264.872053838374, 4271.145770845827, 4280.229558679436, 4130.731502452346, 4182.749035057906, 4198.391233271173, 4227.87316380509, 4259.956310703867, 4225.154969006211, 4228.513720922103, 4234.407182994383, 4242.490901091858, 4245.8513952011845, 3773.5471743390694, 3783.9054023649355, 3788.7726736395903, 3791.829367678461, 3812.7521711088966, 5041.949580504184, 5227.26818245446, 5228.215767634885, 5238.554722848562, 5239.5546378557865, 4877.561019508261, 4878.487758785312, 4879.39007624047, 4895.6083513318845, 4896.706197628154, 5603.459048761623, 5605.411431799684, 5612.943870561283, 5631.493165615114, 5651.2481130849565, 4089.427480152781, 4129.504459464853, 4159.646430053449, 4195.0, 4198.223328684173, 5807.274090738658, 5811.854703632401, 5815.941840581582, 5820.650760954356, 5826.300843898717, 4225.366195070703, 4256.57434256578, 4257.212415703105, 4259.61663450291, 4272.722273052242, 4173.351526147216, 4283.20760659279, 4300.591443812833, 4316.093620339701, 4322.675799315064, 4816.627261230533, 4828.420589529279, 4836.927446088312, 4838.685485443435, 4842.0, 5620.522255608237, 5627.409122042127, 5637.590602349413, 5644.435556444323, 5649.548036157097, 1397.1826481508228, 1441.3369849868968, 1451.4339407631032, 1455.2432734977751, 1464.1507925403241, 1011.3426272922512, 1018.7367664096467, 1020.9897901021043, 1029.7591402360138, 1041.0, 5294.7617357219015, 5299.602529810202, 5300.390455097636, 5326.946730532645, 5329.523200511589, 5515.145152501369, 5571.857769157313, 5577.995960727027, 5604.85987850307, 5607.0, 5237.869053273623, 5255.947440525546, 5311.628186026941, 5320.483662156267, 5541.5289700375915, 2987.193457766391, 3003.219163017631, 3004.774641901822, 3006.6548092487897, 3007.5639032340187, 5796.362400135981, 5799.739011744482, 5827.708614569255, 5834.5624078194305, 5859.0, 5467.589930755209, 5671.943280567224, 5720.997650822263, 5724.484796368347, 5728.942710572925, 5773.278340207474, 5783.797567085132, 5791.5656325775735, 5815.534757219412, 5817.603775093947, 5344.278522399582, 5478.726063696719, 5546.528545073714, 5559.861003474945, 5572.275604171432, 5512.062949298549, 5534.335879694462, 5558.333000039859, 5565.916511252415, 5566.387697353207, 5754.56840736938, 5759.337676167127, 5770.740316685676, 5804.593678442468, 5835.44563266489, 3965.068208970947, 4085.3667681509414, 4099.487564054493, 4103.158852435304, 4136.565660605593, 5545.201536947204, 5585.273914391266, 5607.719614019365, 5785.82642520725, 5798.59409841307, 5625.268715067015, 5639.488409272648, 5641.182028605911, 5649.548036157015, 5672.7163641816915, 5538.750756215899, 5615.438456154352, 5623.268975033383, 5633.549316054624, 5640.464155905182, 5566.860828479321, 5576.525995290446, 5584.3857175711455, 5596.188552659923, 5599.972000139973, 5657.5473962082115, 5658.151277308437, 5659.745311460912, 5668.801591944262, 5670.886582268414, 5407.567394608501, 5448.447192550104, 5493.7802487900035, 5504.504594586347, 5559.388467268678], "value": 4297.375541170029, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.9523628582285, 795.0141824138069, 806.66523392792, 832.2842355574202, 914.1452741686528, 13922.651933701662, 14890.851091489096, 15397.461088861864, 15475.84524154761, 15659.13874736889, 16011.27949242284, 16240.83759162408, 16243.756343654824, 16416.425425110123, 16467.423640172565, 856.1053698884649, 870.4429165334191, 872.8341615093144, 875.0811647769848, 875.5928493250638, 721.2859269323359, 739.7632757517597, 840.7561807075971, 860.0582362313288, 868.097178933908, 892.1613683137862, 895.7357579514058, 896.4083704754863, 896.6144557840158, 896.8206358728248, 871.3247233394106, 872.3283072034498, 878.108719649553, 879.7932485865848, 879.8196369744219, 651.8663673946877, 654.0222367560527, 655.7639249870043, 658.4534836086085, 658.9967050164719, 14463.349149288308, 14630.926845365811, 14669.559913202622, 14670.04644698102, 14894.329755161043, 11843.289402635783, 14480.0, 14513.20177390243, 14969.649403419538, 15190.164540950243, 12369.69075773104, 12458.563950261698, 12530.74938501234, 12716.046296527797, 12868.0, 3852.3836186210074, 3858.575556688762, 3878.6897048236356, 3963.920721585581, 4029.315016447211, 52943.0, 64995.675021625066, 65806.01290980639, 66734.0, 67145.0, 11196.328220306808, 11448.0, 11531.596394126165, 11562.710932226593, 11700.824487632692, 21110.683339749918, 21416.357509274745, 21455.0, 22073.11707531713, 22142.88928555347, 8750.124987501198, 8892.555372231363, 9474.478903660227, 9509.286803489766, 9513.738923225827, 4344.761038142932, 4620.1914664934175, 4634.606058485067, 4670.8365207217585, 4718.7168769873915, 3581.426971684518, 3686.981565092211, 3691.8523259069875, 3702.777833330009, 3707.7775333480076, 648.1056142523288, 648.4099469482748, 656.0258016844981, 656.1306269193337, 667.559410788877, 650.3821369698805, 764.4152223548989, 766.9616519174019, 783.8158032862273, 791.2364568191723, 9298.67454639098, 9451.952740236255, 9452.763680907894, 9543.9045609543, 9835.164011058998, 671.7783131566571, 764.1670579068841, 778.9766307010685, 779.0806847919396, 781.1563511407666, 4492.752898590544, 4730.337752714623, 4758.833440829554, 4791.928121078186, 4802.951970480321, 51466.0, 84036.57981710053, 93141.5342923281, 95914.0, 95987.0, 46956.29565556519, 52909.7354513225, 71570.64214678998, 77638.61180694061, 77775.0, 43023.35464968028, 44747.0, 67414.66292668505, 71517.6424117876, 74186.0, 9752.414855108716, 10144.64493742745, 10193.23550733683, 10273.537690803782, 10406.323588966692, 46631.30053049139, 47062.76468617635, 47167.528324717685, 47922.5207747918, 48603.27095093647, 53143.0, 60050.39949600623, 60401.09398359116, 61112.0, 62059.0, 13051.394479944514, 13611.25138117413, 13735.519256826363, 13780.517681881087, 13905.582832515041, 15002.924985375439, 15085.849141508445, 15114.244287785787, 15121.319540620478, 15194.772078419053, 13794.448222071005, 14253.28733563297, 14402.063865848686, 14847.851521484647, 15370.84629153739, 12531.686707832378, 12743.980481561639, 14435.494757683431, 14437.06159099655, 14808.851911480748, 11954.820677689668, 12927.5475358362, 12977.935110324388, 13358.131721438076, 13566.525171619342, 11244.156688248251, 11485.942570287429, 11528.423578821194, 11582.0, 11662.94168529152, 11980.64058078259, 12030.518779248732, 12042.698932526406, 12250.754984900073, 12267.509299627915], "value": 7423.548766853232, "unit": "score"}], "name": "dromaeo_css", "value": 7373.916189617043, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 109.0, 111.0, 110.0, 110.0, 111.0, 111.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 119.0, 156.0, 118.0, 121.0, 123.0, 119.0, 146.0, 119.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 170.0, 159.0, 160.0, 161.0, 161.0, 161.0, 163.0, 160.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 123.0, 77.0, 75.0, 76.0, 75.0, 99.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 83.0, 81.0, 83.0, 100.0, 82.0, 82.0, 101.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.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, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 51.0, 53.0, 51.0, 52.0, 52.0, 50.0, 51.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 60.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 81.0, 76.0, 76.0, 74.0, 74.0, 74.0, 75.0, 76.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 121.0, 127.0, 124.0, 126.0, 129.0, 120.0, 121.0, 167.0, 121.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 159.0, 155.0, 162.0, 158.0, 162.0, 169.0, 161.0, 155.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 62.0, 61.0, 64.0, 62.0, 64.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1454.1999999999998, "alertThreshold": 2.0}]} 05:36:49 INFO - Return code: 0 05:36:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:36:49 INFO - # TBPL SUCCESS # 05:36:49 INFO - Running post-action listener: _resource_record_post_action 05:36:49 INFO - [mozharness: 2017-01-25 13:36:49.386452Z] Finished run-tests step (success) 05:36:49 INFO - Running post-run listener: _resource_record_post_run 05:36:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 320761856; Read time: 0; Write time: 217832 05:36:49 INFO - TinderboxPrint: CPU usage
13.0% 05:36:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:36:49 INFO - TinderboxPrint: I/O write bytes / time
320,761,856 / 217,832 05:36:49 INFO - TinderboxPrint: CPU idle
8,252.8 (87.0%) 05:36:49 INFO - TinderboxPrint: CPU user
1,187.4 (12.5%) 05:36:49 INFO - TinderboxPrint: Swap in / out
0 / 0 05:36:49 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 97271808; Read time: 0; Write time: 100604 05:36:49 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 219095040; Read time: 0; Write time: 116852 05:36:50 INFO - Running post-run listener: _upload_blobber_files 05:36:50 INFO - Blob upload gear active. 05:36:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:50 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 05:36:50 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'] 05:36:50 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 05:36:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:36:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:51 INFO - (blobuploader) - INFO - Done attempting. 05:36:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:36:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:36:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:51 INFO - (blobuploader) - INFO - Done attempting. 05:36:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:55 INFO - (blobuploader) - INFO - Done attempting. 05:36:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:55 INFO - Return code: 0 05:36:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffb63d32743050e790a3a7fd12b96ede87d83dc3fc0875c0cc0dc37338802da22594a1d4baead22f10c35202da4e19272ba3cfd6a22758d778877185e2a34b46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b212181ae316ea743c9669ccd83d356056f06d0dbc73f088845e4a89d751e4bedeb2ed5bb18b9f2be6f4cd33d8db85ef9adfd44df7f58129425bfb1773c0ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ddd9278cafa07fb67c28007b4ae811fb3fe6eada20c6cc07d852997a2e2d79771aa780b37789b24a6d43ff381446ff85b6b483c01b1e96fbbc74a2b377f10bde"} 05:36:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:55 INFO - Contents: 05:36:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffb63d32743050e790a3a7fd12b96ede87d83dc3fc0875c0cc0dc37338802da22594a1d4baead22f10c35202da4e19272ba3cfd6a22758d778877185e2a34b46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b212181ae316ea743c9669ccd83d356056f06d0dbc73f088845e4a89d751e4bedeb2ed5bb18b9f2be6f4cd33d8db85ef9adfd44df7f58129425bfb1773c0ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ddd9278cafa07fb67c28007b4ae811fb3fe6eada20c6cc07d852997a2e2d79771aa780b37789b24a6d43ff381446ff85b6b483c01b1e96fbbc74a2b377f10bde"} 05:36:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:55 INFO - Copying logs to upload dir... 05:36:55 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.512013 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-01-25 05:36:54.827975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 05:36:54.831765) ========= 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=db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030 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/ffb63d32743050e790a3a7fd12b96ede87d83dc3fc0875c0cc0dc37338802da22594a1d4baead22f10c35202da4e19272ba3cfd6a22758d778877185e2a34b46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b212181ae316ea743c9669ccd83d356056f06d0dbc73f088845e4a89d751e4bedeb2ed5bb18b9f2be6f4cd33d8db85ef9adfd44df7f58129425bfb1773c0ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ddd9278cafa07fb67c28007b4ae811fb3fe6eada20c6cc07d852997a2e2d79771aa780b37789b24a6d43ff381446ff85b6b483c01b1e96fbbc74a2b377f10bde"} build_url:https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/fPJJQiVrTFmeqZ8iP3xqvw/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/ffb63d32743050e790a3a7fd12b96ede87d83dc3fc0875c0cc0dc37338802da22594a1d4baead22f10c35202da4e19272ba3cfd6a22758d778877185e2a34b46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b212181ae316ea743c9669ccd83d356056f06d0dbc73f088845e4a89d751e4bedeb2ed5bb18b9f2be6f4cd33d8db85ef9adfd44df7f58129425bfb1773c0ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ddd9278cafa07fb67c28007b4ae811fb3fe6eada20c6cc07d852997a2e2d79771aa780b37789b24a6d43ff381446ff85b6b483c01b1e96fbbc74a2b377f10bde"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 05:36:54.856982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:36:54.857359) ========= 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=db7e7c15f3ca076d53731445000001ba-1485350181.139340-1489364030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:36:54.939649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 05:36:54.940029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 05:36:54.940335) ========= ========= Total master_lag: 0.16 =========