builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1486748788.53 results: success (0) buildid: 20170210075621 builduid: 5814bc1a1a79465485b9d1568ecf2286 revision: 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.531936) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.532446) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.532764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.547189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.547639) ========= 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=5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-10 09:46:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-02-10 09:46:29 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.699894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.700257) ========= 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=5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019369 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.751549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:28.752168) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 --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 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 --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=5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-10 09:46:29,210 truncating revision to first 12 chars 2017-02-10 09:46:29,210 Setting DEBUG logging. 2017-02-10 09:46:29,210 attempt 1/10 2017-02-10 09:46:29,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7d61a1453a97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 09:46:29,792 unpacking tar archive at: mozilla-beta-7d61a1453a97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:29.649179) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:29.649734) ========= script_repo_revision: 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:29.650131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:29.650397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 09:46:29.657601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-10 09:46:29.657904) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:46:30 INFO - MultiFileLogger online at 20170210 09:46:30 in /builds/slave/test 09:46:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:46:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:46:30 INFO - {'append_to_log': False, 09:46:30 INFO - 'base_work_dir': '/builds/slave/test', 09:46:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:46:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:46:30 INFO - 'branch': 'Mozilla-Beta', 09:46:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:46:30 INFO - 'config_files': ('talos/linux_config.py',), 09:46:30 INFO - 'default_actions': ('clobber', 09:46:30 INFO - 'read-buildbot-config', 09:46:30 INFO - 'download-and-extract', 09:46:30 INFO - 'populate-webroot', 09:46:30 INFO - 'create-virtualenv', 09:46:30 INFO - 'install', 09:46:30 INFO - 'run-tests'), 09:46:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:46:30 INFO - 'download_minidump_stackwalk': True, 09:46:30 INFO - 'download_symbols': 'ondemand', 09:46:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:46:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:46:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:46:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:46:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:46:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:46:30 INFO - 'installer_path': 'installer.exe', 09:46:30 INFO - 'log_level': 'info', 09:46:30 INFO - 'log_name': 'talos', 09:46:30 INFO - 'log_to_console': True, 09:46:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:46:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:46:30 INFO - 'opt_config_files': (), 09:46:30 INFO - 'pip_index': False, 09:46:30 INFO - 'sps_profile': False, 09:46:30 INFO - 'sps_profile_interval': 0, 09:46:30 INFO - 'suite': 'dromaeojs-e10s', 09:46:30 INFO - 'system_bits': '32', 09:46:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:46:30 INFO - 'title': 'talos-linux64-ix-039', 09:46:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:46:30 INFO - 'use_talos_json': True, 09:46:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:46:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:46:30 INFO - 'work_dir': 'build'} 09:46:30 INFO - [mozharness: 2017-02-10 17:46:30.211069Z] Running clobber step. 09:46:30 INFO - Running pre-action listener: _resource_record_pre_action 09:46:30 INFO - Running main action method: clobber 09:46:30 INFO - rmtree: /builds/slave/test/build 09:46:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:46:31 INFO - Running post-action listener: _resource_record_post_action 09:46:31 INFO - [mozharness: 2017-02-10 17:46:31.304712Z] Finished clobber step (success) 09:46:31 INFO - [mozharness: 2017-02-10 17:46:31.304809Z] Running read-buildbot-config step. 09:46:31 INFO - Running pre-action listener: _resource_record_pre_action 09:46:31 INFO - Running main action method: read_buildbot_config 09:46:31 INFO - Using buildbot properties: 09:46:31 INFO - { 09:46:31 INFO - "project": "", 09:46:31 INFO - "product": "firefox", 09:46:31 INFO - "script_repo_revision": "production", 09:46:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:46:31 INFO - "repository": "", 09:46:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:46:31 INFO - "buildid": "20170210075621", 09:46:31 INFO - "pgo_build": "True", 09:46:31 INFO - "basedir": "/builds/slave/test", 09:46:31 INFO - "buildnumber": 69, 09:46:31 INFO - "slavename": "talos-linux64-ix-039", 09:46:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:46:31 INFO - "platform": "ubuntu64_hw", 09:46:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:46:31 INFO - "branch": "mozilla-beta", 09:46:31 INFO - "repo_path": "releases/mozilla-beta", 09:46:31 INFO - "revision": "7d61a1453a97c1d74c5e702574fd5bf395e2bbf4", 09:46:31 INFO - "stage_platform": "linux64-pgo", 09:46:31 INFO - "builduid": "5814bc1a1a79465485b9d1568ecf2286", 09:46:31 INFO - "slavebuilddir": "test" 09:46:31 INFO - } 09:46:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 09:46:31 INFO - Running post-action listener: _resource_record_post_action 09:46:31 INFO - [mozharness: 2017-02-10 17:46:31.307216Z] Finished read-buildbot-config step (success) 09:46:31 INFO - [mozharness: 2017-02-10 17:46:31.307304Z] Running download-and-extract step. 09:46:31 INFO - Running pre-action listener: _resource_record_pre_action 09:46:31 INFO - Running main action method: download_and_extract 09:46:31 INFO - mkdir: /builds/slave/test/build/tests 09:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:31 INFO - trying https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:46:31 INFO - Downloading https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/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 09:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/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 09:46:31 INFO - Downloaded 1327 bytes. 09:46:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:46:31 INFO - Using the following test package requirements: 09:46:31 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:46:31 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:46:31 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 09:46:31 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'jsshell-linux-x86_64.zip'], 09:46:31 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:46:31 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:46:31 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 09:46:31 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 09:46:31 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:46:31 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:46:31 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:46:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:46:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:46:31 INFO - Fetch https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:46:32 INFO - Http code: 200 09:46:32 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 09:46:32 INFO - x-amz-cf-id: 5f6oWOcxJmjaNpUY7Z13MP_Ws5KPJqCyHH7izkLk9s-GA3At0sCc4g== 09:46:32 INFO - x-amz-version-id: 8CoHl4yDPJQ4Nv5xS1okXp7X4c8cnuXK 09:46:33 INFO - Expected file size: 21958969 09:46:33 INFO - Obtained file size: 21958969 09:46:37 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 09:46:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:46:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:46:37 INFO - Fetch https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:46:38 INFO - Http code: 200 09:46:38 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 09:46:38 INFO - x-amz-cf-id: wOcA_5oCvdik0_N5IsBZ0yOqqIXe60ytVuY_2dbwMQKAmZsMUuNxnA== 09:46:38 INFO - x-amz-version-id: 8CoHl4yDPJQ4Nv5xS1okXp7X4c8cnuXK 09:46:40 INFO - Expected file size: 21958969 09:46:40 INFO - Obtained file size: 21958969 09:46:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 09:46:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:46:44 INFO - Fetch https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 09:46:45 INFO - Http code: 200 09:46:45 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 09:46:45 INFO - x-amz-cf-id: xxHt-2MMgqBOydQ1gyCpbKMHpv5h3CwSzPrXx2O0iEedyDs3cR7qjg== 09:46:45 INFO - x-amz-version-id: OCsQ6LnIFgk4IxA9nTTXq4FVD18gg8cR 09:46:46 INFO - Expected file size: 14403005 09:46:46 INFO - Obtained file size: 14403005 09:46: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')]} 09:46:46 INFO - trying https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:46:46 INFO - Downloading https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/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 09:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/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 09:46:50 INFO - Downloaded 57706429 bytes. 09:46:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:46:50 INFO - mkdir: /builds/slave/test/properties 09:46:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:46:50 INFO - Writing to file /builds/slave/test/properties/build_url 09:46:50 INFO - Contents: 09:46:50 INFO - build_url:https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:46:51 INFO - Running post-action listener: _resource_record_post_action 09:46:51 INFO - Running post-action listener: set_extra_try_arguments 09:46:51 INFO - [mozharness: 2017-02-10 17:46:51.422538Z] Finished download-and-extract step (success) 09:46:51 INFO - [mozharness: 2017-02-10 17:46:51.422764Z] Running populate-webroot step. 09:46:51 INFO - Running pre-action listener: _resource_record_pre_action 09:46:51 INFO - Running main action method: populate_webroot 09:46:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:46:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:46:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:46:51 INFO - '--tppagecycles', 09:46:51 INFO - '7'], 09:46:51 INFO - 'tests': ['tsvgm']}}, 09:46:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:46:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:46:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:46:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:46:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:51 INFO - 'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:51 INFO - 'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['damp', 'tps']}, 09:46:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:51 INFO - 'tests': ['damp', 'tps']}, 09:46:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['dromaeo_dom']}, 09:46:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:46:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['basic_compositor_video']}, 09:46:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:46:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['a11yr', 09:46:51 INFO - 'ts_paint', 09:46:51 INFO - 'tpaint', 09:46:51 INFO - 'sessionrestore', 09:46:51 INFO - 'sessionrestore_no_auto_restore', 09:46:51 INFO - 'tabpaint']}, 09:46:51 INFO - 'other-e10s': {'tests': ['a11yr', 09:46:51 INFO - 'ts_paint', 09:46:51 INFO - 'tpaint', 09:46:51 INFO - 'sessionrestore', 09:46:51 INFO - 'sessionrestore_no_auto_restore', 09:46:51 INFO - 'tabpaint']}, 09:46:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:46:51 INFO - 'ts_paint', 09:46:51 INFO - 'tpaint', 09:46:51 INFO - 'sessionrestore', 09:46:51 INFO - 'sessionrestore_no_auto_restore', 09:46:51 INFO - 'tabpaint']}, 09:46:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:46:51 INFO - 'ts_paint', 09:46:51 INFO - 'tpaint', 09:46:51 INFO - 'sessionrestore', 09:46:51 INFO - 'sessionrestore_no_auto_restore', 09:46:51 INFO - 'tabpaint']}, 09:46:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['a11yr', 09:46:51 INFO - 'ts_paint', 09:46:51 INFO - 'tpaint', 09:46:51 INFO - 'sessionrestore', 09:46:51 INFO - 'sessionrestore_no_auto_restore', 09:46:51 INFO - 'tabpaint']}, 09:46:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['a11yr', 09:46:51 INFO - 'ts_paint', 09:46:51 INFO - 'tpaint', 09:46:51 INFO - 'sessionrestore', 09:46:51 INFO - 'sessionrestore_no_auto_restore', 09:46:51 INFO - 'tabpaint']}, 09:46:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['tsvgx', 09:46:51 INFO - 'tsvgr_opacity', 09:46:51 INFO - 'tart', 09:46:51 INFO - 'tscrollx', 09:46:51 INFO - 'cart']}, 09:46:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:46:51 INFO - 'tsvgr_opacity', 09:46:51 INFO - 'tart', 09:46:51 INFO - 'tscrollx', 09:46:51 INFO - 'cart']}, 09:46:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:51 INFO - 'talos_options': ['--disable-e10s'], 09:46:51 INFO - 'tests': ['tp5o']}, 09:46:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:51 INFO - 'tests': ['tp5o']}, 09:46:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:51 INFO - 'talos_options': ['--disable-e10s', 09:46:51 INFO - '--xperf_path', 09:46:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:51 INFO - 'tests': ['tp5n']}, 09:46:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:51 INFO - 'talos_options': ['--xperf_path', 09:46:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:51 INFO - 'tests': ['tp5n']}}, 09:46:51 INFO - 'talos.zip': {'path': '', 09:46:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:46:51 INFO - Running post-action listener: _resource_record_post_action 09:46:51 INFO - [mozharness: 2017-02-10 17:46:51.443668Z] Finished populate-webroot step (success) 09:46:51 INFO - [mozharness: 2017-02-10 17:46:51.443755Z] Running create-virtualenv step. 09:46:51 INFO - Running pre-action listener: _resource_record_pre_action 09:46:51 INFO - Running main action method: create_virtualenv 09:46:51 INFO - Creating virtualenv /builds/slave/test/build/venv 09:46:51 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 09:46:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:46:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:46:51 INFO - Using real prefix '/usr' 09:46:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:46:52 INFO - Installing distribute.............................................................................................................................................................................................done. 09:46:54 INFO - Installing pip.................done. 09:46:54 INFO - Return code: 0 09:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:46:54 INFO - Reading from file tmpfile_stdout 09:46:54 INFO - Output received: 09:46:54 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) 09:46:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:46:54 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')]} 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 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')]} 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:46:54 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 09:46:54 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 09:46:54 INFO - Using env: {'DISPLAY': ':0', 09:46:54 INFO - 'HOME': '/home/cltbld', 09:46:54 INFO - 'LANG': 'en_US.UTF-8', 09:46:54 INFO - 'LANGUAGE': 'en_US:en', 09:46:54 INFO - 'LOGNAME': 'cltbld', 09:46:54 INFO - 'MAIL': '/var/mail/cltbld', 09:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:54 INFO - 'MOZ_NO_REMOTE': '1', 09:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:54 INFO - 'NO_EM_RESTART': '1', 09:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:54 INFO - 'PWD': '/builds/slave/test', 09:46:54 INFO - 'SHELL': '/bin/bash', 09:46:54 INFO - 'SHLVL': '1', 09:46:54 INFO - 'TERM': 'linux', 09:46:54 INFO - 'TMOUT': '86400', 09:46:54 INFO - 'USER': 'cltbld', 09:46:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:54 INFO - '_': '/tools/buildbot/bin/python'} 09:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:54 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 09:46:54 INFO - Cleaning up... 09:46:54 INFO - Return code: 0 09:46:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:46:54 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')]} 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 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')]} 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:46:54 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 09:46:54 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 09:46:54 INFO - Using env: {'DISPLAY': ':0', 09:46:54 INFO - 'HOME': '/home/cltbld', 09:46:54 INFO - 'LANG': 'en_US.UTF-8', 09:46:54 INFO - 'LANGUAGE': 'en_US:en', 09:46:54 INFO - 'LOGNAME': 'cltbld', 09:46:54 INFO - 'MAIL': '/var/mail/cltbld', 09:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:54 INFO - 'MOZ_NO_REMOTE': '1', 09:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:54 INFO - 'NO_EM_RESTART': '1', 09:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:54 INFO - 'PWD': '/builds/slave/test', 09:46:54 INFO - 'SHELL': '/bin/bash', 09:46:54 INFO - 'SHLVL': '1', 09:46:54 INFO - 'TERM': 'linux', 09:46:54 INFO - 'TMOUT': '86400', 09:46:54 INFO - 'USER': 'cltbld', 09:46:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:54 INFO - '_': '/tools/buildbot/bin/python'} 09:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:54 INFO - Downloading/unpacking psutil>=3.1.1 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:54 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 09:46:54 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 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:46:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:56 INFO - Installing collected packages: psutil 09:46:56 INFO - Running setup.py install for psutil 09:46:56 INFO - building 'psutil._psutil_linux' extension 09:46:56 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 09:46:57 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 09:46:57 INFO - building 'psutil._psutil_posix' extension 09:46:57 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 09:46:57 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 09:46:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:57 INFO - Successfully installed psutil 09:46:57 INFO - Cleaning up... 09:46:57 INFO - Return code: 0 09:46:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:57 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:46:57 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 09:46:57 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 09:46:57 INFO - Using env: {'DISPLAY': ':0', 09:46:57 INFO - 'HOME': '/home/cltbld', 09:46:57 INFO - 'LANG': 'en_US.UTF-8', 09:46:57 INFO - 'LANGUAGE': 'en_US:en', 09:46:57 INFO - 'LOGNAME': 'cltbld', 09:46:57 INFO - 'MAIL': '/var/mail/cltbld', 09:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:57 INFO - 'MOZ_NO_REMOTE': '1', 09:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:57 INFO - 'NO_EM_RESTART': '1', 09:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:57 INFO - 'PWD': '/builds/slave/test', 09:46:57 INFO - 'SHELL': '/bin/bash', 09:46:57 INFO - 'SHLVL': '1', 09:46:57 INFO - 'TERM': 'linux', 09:46:57 INFO - 'TMOUT': '86400', 09:46:57 INFO - 'USER': 'cltbld', 09:46:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:57 INFO - '_': '/tools/buildbot/bin/python'} 09:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:46:59 INFO - Installing collected packages: mozsystemmonitor 09:46:59 INFO - Running setup.py install for mozsystemmonitor 09:46:59 INFO - Successfully installed mozsystemmonitor 09:46:59 INFO - Cleaning up... 09:46:59 INFO - Return code: 0 09:46:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:46:59 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')]} 09:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:59 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')]} 09:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:59 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:46:59 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 09:46:59 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 09:46:59 INFO - Using env: {'DISPLAY': ':0', 09:46:59 INFO - 'HOME': '/home/cltbld', 09:46:59 INFO - 'LANG': 'en_US.UTF-8', 09:46:59 INFO - 'LANGUAGE': 'en_US:en', 09:46:59 INFO - 'LOGNAME': 'cltbld', 09:46:59 INFO - 'MAIL': '/var/mail/cltbld', 09:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:59 INFO - 'MOZ_NO_REMOTE': '1', 09:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:59 INFO - 'NO_EM_RESTART': '1', 09:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:59 INFO - 'PWD': '/builds/slave/test', 09:46:59 INFO - 'SHELL': '/bin/bash', 09:46:59 INFO - 'SHLVL': '1', 09:46:59 INFO - 'TERM': 'linux', 09:46:59 INFO - 'TMOUT': '86400', 09:46:59 INFO - 'USER': 'cltbld', 09:46:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:59 INFO - '_': '/tools/buildbot/bin/python'} 09:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:59 INFO - Downloading/unpacking jsonschema==2.5.1 09:46:59 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 09:46:59 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 09:46:59 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 09:46:59 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 09:46:59 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 09:46:59 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 09:47:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:47:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:47:01 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 09:47:01 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 09:47:01 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 09:47:01 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 09:47:01 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 09:47:01 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 09:47:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:47:02 INFO - warning: no files found matching '*.txt' 09:47:02 INFO - no previously-included directories found matching 'build' 09:47:02 INFO - no previously-included directories found matching 'dist' 09:47:02 INFO - no previously-included directories found matching '.git*' 09:47:02 INFO - Installing collected packages: jsonschema, functools32 09:47:02 INFO - Running setup.py install for functools32 09:47:02 INFO - warning: no files found matching '*.txt' 09:47:02 INFO - no previously-included directories found matching 'build' 09:47:02 INFO - no previously-included directories found matching 'dist' 09:47:02 INFO - no previously-included directories found matching '.git*' 09:47:02 INFO - Successfully installed jsonschema functools32 09:47:02 INFO - Cleaning up... 09:47:02 INFO - Return code: 0 09:47:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:47:02 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')]} 09:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:02 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')]} 09:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:02 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:47:02 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 09:47:02 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 09:47:02 INFO - Using env: {'DISPLAY': ':0', 09:47:02 INFO - 'HOME': '/home/cltbld', 09:47:02 INFO - 'LANG': 'en_US.UTF-8', 09:47:02 INFO - 'LANGUAGE': 'en_US:en', 09:47:02 INFO - 'LOGNAME': 'cltbld', 09:47:02 INFO - 'MAIL': '/var/mail/cltbld', 09:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:02 INFO - 'MOZ_NO_REMOTE': '1', 09:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:02 INFO - 'NO_EM_RESTART': '1', 09:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:02 INFO - 'PWD': '/builds/slave/test', 09:47:02 INFO - 'SHELL': '/bin/bash', 09:47:02 INFO - 'SHLVL': '1', 09:47:02 INFO - 'TERM': 'linux', 09:47:02 INFO - 'TMOUT': '86400', 09:47:02 INFO - 'USER': 'cltbld', 09:47:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:02 INFO - '_': '/tools/buildbot/bin/python'} 09:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:47:02 INFO - Cleaning up... 09:47:02 INFO - Return code: 0 09:47:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:47:02 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')]} 09:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:02 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')]} 09:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:02 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:47:02 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 09:47:02 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 09:47:02 INFO - Using env: {'DISPLAY': ':0', 09:47:02 INFO - 'HOME': '/home/cltbld', 09:47:02 INFO - 'LANG': 'en_US.UTF-8', 09:47:02 INFO - 'LANGUAGE': 'en_US:en', 09:47:02 INFO - 'LOGNAME': 'cltbld', 09:47:02 INFO - 'MAIL': '/var/mail/cltbld', 09:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:02 INFO - 'MOZ_NO_REMOTE': '1', 09:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:02 INFO - 'NO_EM_RESTART': '1', 09:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:02 INFO - 'PWD': '/builds/slave/test', 09:47:02 INFO - 'SHELL': '/bin/bash', 09:47:02 INFO - 'SHLVL': '1', 09:47:02 INFO - 'TERM': 'linux', 09:47:02 INFO - 'TMOUT': '86400', 09:47:02 INFO - 'USER': 'cltbld', 09:47:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:02 INFO - '_': '/tools/buildbot/bin/python'} 09:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:02 INFO - Downloading/unpacking blobuploader==1.2.4 09:47:02 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 09:47:02 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 09:47:02 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 09:47:02 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 09:47:02 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 09:47:02 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 09:47:04 INFO - Downloading blobuploader-1.2.4.tar.gz 09:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:47:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:47:05 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 09:47:05 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 09:47:05 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 09:47:05 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 09:47:05 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 09:47:05 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 09:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:47:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:47:05 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 09:47:05 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 09:47:05 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 09:47:05 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 09:47:05 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 09:47:05 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 09:47:05 INFO - Downloading docopt-0.6.1.tar.gz 09:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:47:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:47:05 INFO - Running setup.py install for blobuploader 09:47:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:47:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:47:05 INFO - Running setup.py install for requests 09:47:06 INFO - Running setup.py install for docopt 09:47:06 INFO - Successfully installed blobuploader requests docopt 09:47:06 INFO - Cleaning up... 09:47:06 INFO - Return code: 0 09:47:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:06 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:47:06 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 09:47:06 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 09:47:06 INFO - Using env: {'DISPLAY': ':0', 09:47:06 INFO - 'HOME': '/home/cltbld', 09:47:06 INFO - 'LANG': 'en_US.UTF-8', 09:47:06 INFO - 'LANGUAGE': 'en_US:en', 09:47:06 INFO - 'LOGNAME': 'cltbld', 09:47:06 INFO - 'MAIL': '/var/mail/cltbld', 09:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:06 INFO - 'MOZ_NO_REMOTE': '1', 09:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:06 INFO - 'NO_EM_RESTART': '1', 09:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:06 INFO - 'PWD': '/builds/slave/test', 09:47:06 INFO - 'SHELL': '/bin/bash', 09:47:06 INFO - 'SHLVL': '1', 09:47:06 INFO - 'TERM': 'linux', 09:47:06 INFO - 'TMOUT': '86400', 09:47:06 INFO - 'USER': 'cltbld', 09:47:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:06 INFO - '_': '/tools/buildbot/bin/python'} 09:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:06 INFO - Running setup.py (path:/tmp/pip-exIqwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:06 INFO - Running setup.py (path:/tmp/pip-zHpgr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:06 INFO - Running setup.py (path:/tmp/pip-haAKEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:06 INFO - Running setup.py (path:/tmp/pip-bEsjkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:06 INFO - Running setup.py (path:/tmp/pip-637esz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:06 INFO - Running setup.py (path:/tmp/pip-BrJ9e0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:06 INFO - Running setup.py (path:/tmp/pip-p5vvXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:07 INFO - Running setup.py (path:/tmp/pip-28Bwq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:07 INFO - Running setup.py (path:/tmp/pip-SxI8ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:07 INFO - Running setup.py (path:/tmp/pip-LvxilH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:07 INFO - Running setup.py (path:/tmp/pip-XovkEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:07 INFO - Running setup.py (path:/tmp/pip-YhwX5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:07 INFO - Running setup.py (path:/tmp/pip-AkA1Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:07 INFO - Running setup.py (path:/tmp/pip-j3nU2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:07 INFO - Running setup.py (path:/tmp/pip-XlE9Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:07 INFO - Running setup.py (path:/tmp/pip-OHeLzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:07 INFO - Running setup.py (path:/tmp/pip-nQPwgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:47:07 INFO - Running setup.py install for manifestparser 09:47:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:47:07 INFO - Running setup.py install for mozcrash 09:47:07 INFO - Running setup.py install for mozdebug 09:47:08 INFO - Running setup.py install for mozdevice 09:47:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Running setup.py install for mozfile 09:47:08 INFO - Running setup.py install for mozhttpd 09:47:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Running setup.py install for mozinfo 09:47:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Running setup.py install for mozInstall 09:47:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Running setup.py install for mozleak 09:47:08 INFO - Running setup.py install for mozlog 09:47:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Running setup.py install for moznetwork 09:47:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:47:08 INFO - Running setup.py install for mozprocess 09:47:09 INFO - Running setup.py install for mozprofile 09:47:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:47:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:47:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:47:09 INFO - Running setup.py install for mozrunner 09:47:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:47:09 INFO - Running setup.py install for mozscreenshot 09:47:09 INFO - Running setup.py install for moztest 09:47:09 INFO - Running setup.py install for mozversion 09:47:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:47:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:47:09 INFO - Cleaning up... 09:47:09 INFO - Return code: 0 09:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:09 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')]} 09:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:09 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')]} 09:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:09 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:47:09 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 09:47:09 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 09:47:09 INFO - Using env: {'DISPLAY': ':0', 09:47:09 INFO - 'HOME': '/home/cltbld', 09:47:09 INFO - 'LANG': 'en_US.UTF-8', 09:47:09 INFO - 'LANGUAGE': 'en_US:en', 09:47:09 INFO - 'LOGNAME': 'cltbld', 09:47:09 INFO - 'MAIL': '/var/mail/cltbld', 09:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:09 INFO - 'MOZ_NO_REMOTE': '1', 09:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:09 INFO - 'NO_EM_RESTART': '1', 09:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:09 INFO - 'PWD': '/builds/slave/test', 09:47:09 INFO - 'SHELL': '/bin/bash', 09:47:09 INFO - 'SHLVL': '1', 09:47:09 INFO - 'TERM': 'linux', 09:47:09 INFO - 'TMOUT': '86400', 09:47:09 INFO - 'USER': 'cltbld', 09:47:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:09 INFO - '_': '/tools/buildbot/bin/python'} 09:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:09 INFO - Running setup.py (path:/tmp/pip-CSVgwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:09 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)) 09:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:09 INFO - Running setup.py (path:/tmp/pip-mNgonu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:09 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)) 09:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:09 INFO - Running setup.py (path:/tmp/pip-atYXoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:10 INFO - Running setup.py (path:/tmp/pip-kFF93P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:10 INFO - Running setup.py (path:/tmp/pip-mcq3q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:10 INFO - Running setup.py (path:/tmp/pip-6dZOb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:10 INFO - Running setup.py (path:/tmp/pip-EC8Caf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:10 INFO - Running setup.py (path:/tmp/pip-i0tDZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:10 INFO - Running setup.py (path:/tmp/pip-Rhmbyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:10 INFO - Running setup.py (path:/tmp/pip-pdHPSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:10 INFO - Running setup.py (path:/tmp/pip-rdgPAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:10 INFO - Running setup.py (path:/tmp/pip-Br9G2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:10 INFO - Running setup.py (path:/tmp/pip-G4Xbqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:10 INFO - Running setup.py (path:/tmp/pip-pGikIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:10 INFO - Running setup.py (path:/tmp/pip-AKi4BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:10 INFO - Running setup.py (path:/tmp/pip-iQaxN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:10 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)) 09:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:10 INFO - Running setup.py (path:/tmp/pip-aHAfwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:11 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)) 09:47:11 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)) 09:47:11 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)) 09:47:11 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)) 09:47:11 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)) 09:47:11 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)) 09:47:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:11 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 09:47:11 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 09:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:13 INFO - Downloading blessings-1.6.tar.gz 09:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:47:13 INFO - Installing collected packages: blessings 09:47:13 INFO - Running setup.py install for blessings 09:47:13 INFO - Successfully installed blessings 09:47:13 INFO - Cleaning up... 09:47:13 INFO - Return code: 0 09:47:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:13 INFO - Reading from file tmpfile_stdout 09:47:13 INFO - Current package versions: 09:47:13 INFO - argparse == 1.2.1 09:47:13 INFO - blessings == 1.6 09:47:13 INFO - blobuploader == 1.2.4 09:47:13 INFO - docopt == 0.6.1 09:47:13 INFO - functools32 == 3.2.3-2 09:47:13 INFO - jsonschema == 2.5.1 09:47:13 INFO - manifestparser == 1.1 09:47:13 INFO - mozInstall == 1.12 09:47:13 INFO - mozcrash == 1.0 09:47:13 INFO - mozdebug == 0.1 09:47:13 INFO - mozdevice == 0.48 09:47:13 INFO - mozfile == 1.2 09:47:13 INFO - mozhttpd == 0.7 09:47:13 INFO - mozinfo == 0.9 09:47:13 INFO - mozleak == 0.1 09:47:13 INFO - mozlog == 3.4 09:47:13 INFO - moznetwork == 0.27 09:47:13 INFO - mozprocess == 0.23 09:47:13 INFO - mozprofile == 0.28 09:47:13 INFO - mozrunner == 6.13 09:47:13 INFO - mozscreenshot == 0.1 09:47:13 INFO - mozsystemmonitor == 0.3 09:47:13 INFO - moztest == 0.8 09:47:13 INFO - mozversion == 1.4 09:47:13 INFO - psutil == 3.1.1 09:47:13 INFO - requests == 1.2.3 09:47:13 INFO - wsgiref == 0.1.2 09:47:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:13 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')]} 09:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:13 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')]} 09:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:13 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:47:13 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 09:47:13 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 09:47:13 INFO - Using env: {'DISPLAY': ':0', 09:47:13 INFO - 'HOME': '/home/cltbld', 09:47:13 INFO - 'LANG': 'en_US.UTF-8', 09:47:13 INFO - 'LANGUAGE': 'en_US:en', 09:47:13 INFO - 'LOGNAME': 'cltbld', 09:47:13 INFO - 'MAIL': '/var/mail/cltbld', 09:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:13 INFO - 'MOZ_NO_REMOTE': '1', 09:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:13 INFO - 'NO_EM_RESTART': '1', 09:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:13 INFO - 'PWD': '/builds/slave/test', 09:47:13 INFO - 'SHELL': '/bin/bash', 09:47:13 INFO - 'SHLVL': '1', 09:47:13 INFO - 'TERM': 'linux', 09:47:13 INFO - 'TMOUT': '86400', 09:47:13 INFO - 'USER': 'cltbld', 09:47:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:13 INFO - '_': '/tools/buildbot/bin/python'} 09:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 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)) 09:47:13 INFO - Cleaning up... 09:47:13 INFO - Return code: 0 09:47:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:47:13 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')]} 09:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:13 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')]} 09:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:13 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 0x7f6db140df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', '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 09:47:13 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 09:47:13 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 09:47:13 INFO - Using env: {'DISPLAY': ':0', 09:47:13 INFO - 'HOME': '/home/cltbld', 09:47:13 INFO - 'LANG': 'en_US.UTF-8', 09:47:13 INFO - 'LANGUAGE': 'en_US:en', 09:47:13 INFO - 'LOGNAME': 'cltbld', 09:47:13 INFO - 'MAIL': '/var/mail/cltbld', 09:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:13 INFO - 'MOZ_NO_REMOTE': '1', 09:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:13 INFO - 'NO_EM_RESTART': '1', 09:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:13 INFO - 'PWD': '/builds/slave/test', 09:47:13 INFO - 'SHELL': '/bin/bash', 09:47:13 INFO - 'SHLVL': '1', 09:47:13 INFO - 'TERM': 'linux', 09:47:13 INFO - 'TMOUT': '86400', 09:47:13 INFO - 'USER': 'cltbld', 09:47:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:13 INFO - '_': '/tools/buildbot/bin/python'} 09:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:47:13 INFO - Cleaning up... 09:47:14 INFO - Return code: 0 09:47:14 INFO - Running post-action listener: _resource_record_post_action 09:47:14 INFO - Running post-action listener: _start_resource_monitoring 09:47:14 INFO - Starting resource monitoring. 09:47:14 INFO - [mozharness: 2017-02-10 17:47:14.034609Z] Finished create-virtualenv step (success) 09:47:14 INFO - [mozharness: 2017-02-10 17:47:14.035177Z] Running install step. 09:47:14 INFO - Running pre-action listener: _resource_record_pre_action 09:47:14 INFO - Running main action method: install 09:47:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:14 INFO - Reading from file tmpfile_stdout 09:47:14 INFO - Detecting whether we're running mozinstall >=1.0... 09:47:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:47:14 INFO - Reading from file tmpfile_stdout 09:47:14 INFO - Output received: 09:47:14 INFO - Usage: mozinstall [options] installer 09:47:14 INFO - Options: 09:47:14 INFO - -h, --help show this help message and exit 09:47:14 INFO - -d DEST, --destination=DEST 09:47:14 INFO - Directory to install application into. [default: 09:47:14 INFO - "/builds/slave/test"] 09:47:14 INFO - --app=APP Application being installed. [default: firefox] 09:47:14 INFO - mkdir: /builds/slave/test/build/application 09:47:14 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'] 09:47:14 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 09:47:27 INFO - Reading from file tmpfile_stdout 09:47:27 INFO - Output received: 09:47:27 INFO - /builds/slave/test/build/application/firefox/firefox 09:47:27 INFO - Running post-action listener: _resource_record_post_action 09:47:27 INFO - [mozharness: 2017-02-10 17:47:27.968396Z] Finished install step (success) 09:47:27 INFO - [mozharness: 2017-02-10 17:47:27.968637Z] Running run-tests step. 09:47:27 INFO - Running pre-action listener: _resource_record_pre_action 09:47:27 INFO - Running main action method: run_tests 09:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:47:27 INFO - Python 2.7.3 09:47:27 INFO - Return code: 0 09:47:27 INFO - grabbing minidump binary from tooltool 09:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:27 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 0x1ed9f60>, '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 0x1edad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:47:27 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 09:47:27 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 09:47:27 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 09:47:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:47:28 INFO - Return code: 0 09:47:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:47:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:47:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:47:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:47:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:47:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:47:28 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:47:28 INFO - Using env: {'DISPLAY': ':0', 09:47:28 INFO - 'HOME': '/home/cltbld', 09:47:28 INFO - 'LANG': 'en_US.UTF-8', 09:47:28 INFO - 'LANGUAGE': 'en_US:en', 09:47:28 INFO - 'LOGNAME': 'cltbld', 09:47:28 INFO - 'MAIL': '/var/mail/cltbld', 09:47:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:47:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:28 INFO - 'MOZ_NO_REMOTE': '1', 09:47:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:28 INFO - 'NO_EM_RESTART': '1', 09:47:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:28 INFO - 'PWD': '/builds/slave/test', 09:47:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:47:28 INFO - 'SHELL': '/bin/bash', 09:47:28 INFO - 'SHLVL': '1', 09:47:28 INFO - 'TERM': 'linux', 09:47:28 INFO - 'TMOUT': '86400', 09:47:28 INFO - 'USER': 'cltbld', 09:47:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426', 09:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:28 INFO - '_': '/tools/buildbot/bin/python'} 09:47:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:47:28 INFO - mozversion application_buildid: 20170210075621 09:47:28 INFO - mozversion application_changeset: 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 09:47:28 INFO - mozversion application_display_name: Firefox 09:47:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:47:28 INFO - mozversion application_name: Firefox 09:47:28 INFO - mozversion application_remotingname: firefox 09:47:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:47:28 INFO - mozversion application_vendor: Mozilla 09:47:28 INFO - mozversion application_version: 52.0 09:47:28 INFO - mozversion platform_buildid: 20170210075621 09:47:28 INFO - mozversion platform_changeset: 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 09:47:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:47:28 INFO - mozversion platform_version: 52.0 09:47:28 INFO - using testdate: 1486748848 09:47:28 INFO - actual date: 1486748848 09:47:28 INFO - starting webserver on 'localhost:54164' 09:47:28 INFO - SUITE-START | Running 2 tests 09:47:28 INFO - TEST-START | dromaeo_css 09:47:28 INFO - operating with platform_type : linux_ 09:47:28 INFO - Initialising browser for dromaeo_css test... 09:47:28 INFO - TEST-INFO | started process 21126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyrguWQ/profile http://localhost:54164/getInfo.html) 09:47:32 INFO - PROCESS | 21126 | __metrics Screen width/height:1600/1200 09:47:32 INFO - PROCESS | 21126 | colorDepth:24 09:47:32 INFO - PROCESS | 21126 | Browser inner width/height: 1024/697 09:47:32 INFO - PROCESS | 21126 | __metrics 09:47:33 ERROR - PROCESS | 21126 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 09:47:34 INFO - TEST-INFO | 21126: exit 0 09:47:34 INFO - Browser initialized. 09:47:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:47:34 INFO - TEST-INFO | started process 21259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyrguWQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:46 INFO - PROCESS | 21259 | RSS: Main: 147509248 09:47:46 INFO - PROCESS | 21259 | 09:50:45 INFO - PROCESS | 21259 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54164/tests/dromaeo/cssquery-ext.html) 09:50:47 INFO - PROCESS | 21259 | RSS: Main: 153804800 09:50:47 INFO - PROCESS | 21259 | 09:53:49 INFO - PROCESS | 21259 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-ext.html (next: http://localhost:54164/tests/dromaeo/cssquery-jquery.html) 09:53:49 INFO - PROCESS | 21259 | RSS: Main: 152256512 09:53:49 INFO - PROCESS | 21259 | 09:56:51 INFO - PROCESS | 21259 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54164/tests/dromaeo/cssquery-mootools.html) 09:56:52 INFO - PROCESS | 21259 | RSS: Main: 151498752 09:56:52 INFO - PROCESS | 21259 | 09:59:54 INFO - PROCESS | 21259 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54164/tests/dromaeo/cssquery-prototype.html) 09:59:54 INFO - PROCESS | 21259 | RSS: Main: 153317376 09:59:54 INFO - PROCESS | 21259 | 10:02:57 INFO - PROCESS | 21259 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54164/tests/dromaeo/cssquery-yui.html) 10:02:57 INFO - PROCESS | 21259 | RSS: Main: 154742784 10:02:57 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-yui.html (next: http://localhost:54164/tests/dromaeo/cssquery-dojo.html) 10:06:00 INFO - PROCESS | 21259 | RSS: Main: 154554368 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | __start_tp_report 10:06:00 INFO - PROCESS | 21259 | _x_x_mozilla_page_load 10:06:00 INFO - PROCESS | 21259 | _x_x_mozilla_page_load_details 10:06:00 INFO - PROCESS | 21259 | |i|pagename|runs| 10:06:00 INFO - PROCESS | 21259 | |0;dojo.html;3293.176705823544;3315.336932613477;3331.8000919944807;3351.882684106057;3352.6647335266475;5680.920625081231;5687.488126068653;5730.283714535683;5751.539876809856;5751.971240143798;5743.856403589913;5746.1668058131545;5776;5795.942040579593;5835.124731290298;5188.143956247215;5245.134552798783;5270.894582108355;5306.893862122755;5310.415854256029;5313.73431328434;5328.680279183242;5332.253484512172;5334.03987282289;5341.866453338678;5129.435762066169;5147.588192944556;5307.761150748225;5318.813841515548;5326.6005049621235;5165.3026841376495;5171.3535808024;5228.2941802856885;5234.555062819646;5293.04725149473;5163.741812909339;5224.52979231871;5226.425093239741;5242.6330156889035;5254.894902101936;5686.402927692616;5713.285839270091;5774;5787.479126878559;5800.7679692812235;6033.064874944391;6088.786892458787;6104.4505994460715;6111.379037751134;6114.205153330038;6096.573239873211;6139.4001448443105;6182.96908515459;6187.87624247517;6189.659568723719;5837.47462728348;5838.591298609099;5852.6488410695065;5858.677772722456;5868.530517558585;6185.474234690012;6203.875922481525;6216.4405203531;6324.71538780756;6386.552941294065;6060.787872424444;6079.939200607937;6091.695415229309;6111.724972376253;6124.295705993868;5942.732577034044;6118.724657390339;6133.539984501181;6134.478569321657;6140.17107690456;5941.346451890288;6013.398660133952;6116.3577824328695;6142.01727723571;6201.875962480815;6117;6174.969125154345;6177.073438984098;6193.163922870445;6197.845053873599;4620.168369693488;4747.121782470185;4756.096341695067;4756.096341695067;4775.5463230993;4131.690123240709;4144.937825932613;4155.979220103941;4183.895402614898;4253.48958125027;5855.590108692436;5868.706564671749;5905.498032667271;5929.37741537141;5934.37689042653;6205.565610407228;6207.968960155261;6211.565190436717;6234.37656234382;6236.844078898064;5692.430756924357;5858.912116318259;5862.237909071879;5880.558958078162;5965.194698715704;5297.867553311121;5324.227986941872;5339.733013349317;5342.171963345688;5345.091334473149;6525.151730274939;6527.640979746065;6533.18335208099;6537.869242615121;6551.246606640202;5904.822855314347;6016.007358785926;6061.1514387984835;6076.605020673642;6136.754529818757;6364.236291645032;6388.872222555616;6416;6416.807495775134;6420.357964203542;6037.78867739627;6043.244594425697;6054.424829641177;6058.485028772604;6068.575199735976;5825.747464295197;5836.328822185503;5973.342932277359;6012.819615411545;6137.140800288053;5906.675132867734;5954.970225148846;5968.164456976114;5984.611000284967;6007.579469437097;5898.144769008555;5904.3210030847;5913.586048976703;5914.674692891932;5921.822345329647;5790.4209579043445;5876.94123058781;5935.7032148391545;5950.31571369298;5960.374160713236;6038.7282572283475;6095.847603809941;6105.694715264308;6106.358832322542;6117.12715980571;5920.585559010828;5925.348211696623;5932.822015339547;5937.435943585352;5947.167396564571 10:06:00 INFO - PROCESS | 21259 | |1;ext.html;597.6294697287682;627.7520379450119;641.0576452614657;650.265200323634;678.8913773796194;39545.2090958181;42568.787156064216;42609.360859587134;42874.78562607186;43013;43762.34356484647;43878.561214387846;44049;44384.55615443845;44387;8984.236339911115;9089.727308180733;9116.042815504376;9125.04187060359;9151.95424022879;9062.456252624863;9123.635054597808;9126.269898408145;9140.680076197334;9142.177204051633;9110.407823491485;9162.679306224283;9166.175044246016;9172.587233574504;9176.036516165806;9081.636734530612;9101.77245568866;9138.862917056249;9140.6800761973;9171.770705732377;9087.545622718904;9103.13520215585;9163;9169;9175.908240917572;40486.797566012276;40718.38922416166;40777.38833917493;40786.79606601978;41802.37296440556;3385.3737058643983;3579.480975258599;3622.1850083731215;3699.7595156314756;4203.4115223868685;29442;29553.408931821457;30675.233119171975;30694.232644184074;30971.380572388425;4311.771145223596;4396.20868243716;4400.185965596375;4488.865334039984;4494.1461122386645;312362;313282;313461;313853;315013;58431.70784146052;58518;58925.41074589199;59060.40939590549;59069.11396329058;64755;64861;64931.67534162394;65438.67280663661;65502;13772.10481318731;13780.724385512434;13814.309284535733;13832;13872.930635346758;12062.819057714141;12096.516139354328;12124.575639852563;12127.09046821492;12172.878271217174;17875.987859489294;18028.557715382736;18616;18796.248150074116;18819.153138108817;5718.370979192286;5733.48062763368;5745.971270143623;5933.58464907461;5953.523718102541;995.6863587969766;1055.5935964653663;1103.586155191803;1125.9042981346677;1165.3474054529322;31577.526337104962;31626.683733162834;31628.36743265122;31692.366152676816;32141.35717285688;1077.4774234496263;1085.316250762015;1108.933463992163;1128.537299707116;1200.9039276858005;14896.70206595862;15032.323545440482;15143.772843407358;15420;15536.223188840513;461647;461947;463467;465225;466277;57045.714771425875;57115.71442142763;57208;57464.42535574591;57714;1327.8672132786837;1372.3344178073626;1372.7803551431723;1409.1826740490492;1434.9426022959174;27060.864695676395;27421.31446713848;27730.445391092468;27811;28065.579016314365;51681;51995.48004519907;52079;52315.47684523106;52503.474965251386;298458;300421;301426;301874;302390;28740.137795866158;28928.276793080342;28928.42143157167;29961.850190748908;30370;46959.53040469688;47069.764651177895;47224;47324.526754733386;47665.52334476611;39596.406053908635;39932.80033599814;40055.79972100121;41726;42365.78817105895;38089.4286585707;39690.60309396869;39954.40068398918;40122.59877401189;40238;38483.230335392574;38837.2232555353;39867.40198896961;41218.58781412267;42156.367654484595;34054.65945340515;36289.818550907075;36570.8171459141;36903;37326;27640;28125.296867578476;28574.85712571424;28584.42831143324;28771.136865894056 10:06:00 INFO - PROCESS | 21259 | |2;jquery.html;413.8592878421336;417.53027843675886;426.0414068346221;431.29698591296193;443.0585006860422;18726.719099213522;19194.99999999998;19946.202151913923;20171.19315227393;20295.797042029575;18396.35612753554;18512.352067677635;19220;19386.612267754637;19648.312309069184;5748.482636562719;5933.7033148342625;5962.910556341637;5965.075413310944;5978.880422391571;4114.753114813121;4215.473065866767;5806.129080637896;5878.294604647448;5881.441263080001;6509.381608747161;6515.381038801306;6621.933780662204;6640.900386494206;6654.567453115556;6588.736450541973;6600.900986485207;6627;6668.599884006975;6689.5986240825705;5964.821055368346;6003.369646187131;6014.699265036775;6019.036954087369;6020.909686354708;22333;23195.53608927829;23539.29382118539;23923.521529569483;23960.400989975216;2440.3289095498703;2447.21689059501;2478.7567251637297;2579.651747014148;2614.7777438917715;9891.851622225673;10345.741356466073;10780.838287425695;11978.041756659446;15590.22048897562;1970.4581240158927;2009.8995050247574;2024.068928292987;2049.0164720934035;2121.9151233950624;80427;84686.15313846845;85396;86472;86632;11373.772524549462;11461;11630.6510804676;11642.825357619642;11913.344766037777;16336.836631633769;16417;16525;16546.338146474005;16550.50348489547;8053.677852885936;8186.754397368089;8362.958185209034;8378.455400398954;8607.268382187583;7973.641186146638;8029.518228906284;8041.276285134366;8134.349252059821;8247.381446391544;4628.97685511577;4707.81168753246;4899.216125419915;4965.553100220997;4991.650584459126;1922.9326973555858;1950.4928718533283;1968.5767559974674;1978.9901050494655;2003.3188715836686;814.9388795840335;895.136193573205;924.58393722825;936.6581197862731;941.1811723800338;16782.455386797657;17220.536254418515;17636.294548218186;18122.45632631023;18210.36263730763;885.2740752582949;910.5811326789751;916.4328997414495;934.3412893909777;980.0894431219383;9543.904560954441;9945.30382873192;10071.597136114473;10784.622538211124;11377.886221137682;490710;496463;496692;502197;503588;83739.5813020931;89269.55365223263;98756.50621746846;100558;102282.48858755808;1040.9791804164026;1073.3613499967507;1076.6608518316548;1080.438172150493;1088.9782204355868;17892.28430862751;18062.277508900024;18180.545486362946;18377;18405.723914141032;36165.27669446649;40322.19355612813;42323.365149522164;42977.355339670554;43670;58568.12147817701;60960.69519652373;61882.0717689226;62332.06501902566;63575.682121589096;8252.422330436812;8406.789830254293;8509.617067231866;8570.142985701379;8694.17405346491;12566.748665026831;13349.532766353132;13349.599512014654;13353.866461335263;13455.327233638474;11394.544218231178;11433.179517046648;11520.366379849189;11863.228890122115;12238.265704057785;5768.567357448124;10550.947245263724;11524.711882202677;11532.308061516336;12252.632421027383;12038.699032524257;12072.637820865388;12083.275003499819;12099.33453660022;12377.690557736129;8711;8833.514156721441;8878.156575125353;8917.464952102895;9063.365564410427;8865.955670221865;10681.82499924992;11268.323900565993;11774.470148843495;11774.705632359259 10:06:00 INFO - PROCESS | 21259 | |3;mootools.html;1485.056988812104;1485.331600779649;1624.7644091606717;1749.6325771587965;1754.701700710879;7718.266764657348;7924.6830126795;8319.500829950199;8796.032436431995;8820.735377938656;8120.959395203015;8336.666533338674;8355.415120941536;8579.91420085799;8635.481871087739;2414.4929564791373;2458.323960910746;2458.5943319352286;2459.2007597530783;2463.1502131764514;2428.6721292625534;2483.627455881623;2527.633493143493;2531.0382054819142;2533.9113131040417;2440.5240978009297;2448.2165706973774;2455.472073504196;2460.5570997220493;2467.037855236459;2356.36378177891;2368.5854975379325;2382.463945612241;2408.662787209792;2408.8193385495983;2388.4028992751814;2388.474535602165;2408.4580969281947;2411.180198732422;2417.274817554744;8439.113893041203;8486.108958559324;8537.274331681814;8549.743507694779;8617.526036068013;5438.428964958662;5574.470425309589;5576.442355764431;5597.076482380402;5598.580106491989;3398.7960722356493;3450.102973226979;3473.4616134498942;3493.825308734553;3539.132912436444;1167.2762887010024;1186.2467333243367;1195.2649120790738;1196.7008247938015;1258.9055820813385;12088.33514156721;12093.697657558543;12119.575814846527;12137.878621213764;12166.5741699041;4744.881377965578;4934.975325123423;5043.747812609355;5048.29323894655;5053.67151135175;10383.480825958672;10426.27016108865;10428.061474467335;10453.84319235197;10457.058864702214;5593.188987596775;5619.775208991677;5624;5624.100143976944;5631.2397826293745;4413.845515406945;4749.9050019000115;5047.899042019139;5101.974490127525;5165.1219292720325;4129.740786527486;4152.563980781974;4218.282891908383;4244.236037513216;4252.914941701149;1372.1698372484702;1397.9091359061629;1412.4209074279497;1420.978685319721;1421.459845258795;815.5269943432795;826.2935190412231;839.47532792005;843.7932706486828;854.0903937306748;5494.972525137348;5624.859378515488;5678.772849086073;5684.744186511617;5703.7433315500075;917.0874979395544;917.9449233045905;923.1645360948353;924.4591913730543;968.4625033106553;3754.305453491113;3768.171002379472;3793.6585707285926;3796.962030379661;3804.353259945816;10615;10847.457627118612;10936.890631093587;10945.343279403101;10951.397673128055;10873.782524349626;10908.61819836302;10919.181061420426;10927.836082458769;10963.890361096446;7590;7936.444448888637;8098.31164351025;8108;8118.634661440131;5616.943830561642;5679.772809087755;5727.914081288867;5744.310682717934;5922.763089476372;9896.455694936847;9962.402255864672;10020.599176033169;10200.897991020292;10224.693259202237;10003.199744020607;10103.595856165672;10338.914413986424;10389.740256493647;10397.740056498647;7221.31397517235;7350.816229594303;7505.437092217996;7615.619219039137;7633.122190948112;8153.6330865112395;8333.333333333198;8333.708320209005;8334.708285209988;8349.081601024003;7283.672234749555;7304.96347518259;7324.780256592097;7339.302766237199;7347.632618368953;6768.289329620319;7037.929620703728;7059.964700176466;7066.717331306896;7081.221065682874;6700.497462690415;6805.829854253683;6820.04519367279;6825.863482730417;6849.589024658537;4964.826231081895;5105.988855858043;5131.666441681279;5233.502817232509;5235.110031294766;5141.511556402136;5157.277981082727;5237.476252374732;5269.367675878919;5279.102552565996 10:06:00 INFO - PROCESS | 21259 | |4;prototype.html;339.8936461816786;348.372928728289;353.57924070356273;359.23662217787205;359.7337969902273;5548.611597188194;5566.276384070075;5573.749181286842;5603.3836278009385;5611.523020543248;5525.834224973257;5526.861828454291;5544.77820887164;5551.417101204376;5574.526165275956;4174.853880114204;4258.850940217093;4321.956780432202;4325.82696692132;4336.891577710551;4304.784760761965;4308.82764689412;4310;4321.524632290461;4325.00524879278;4233.428487154241;4245.787710614472;4255.893602659928;4264.381664658623;4292.463442069741;4155.6883233757435;4300.6774491913075;4302.118065796504;4322.222000039991;4335.913281734379;3828.578856325802;3832.735197384884;3834.7123965702685;3836.846526138951;3838.865639702597;5394.244805727201;5411.215373770781;5416.58961762016;5424.403315635277;5438.782448702047;4837.8306759263605;4953.479884612136;4978.327925730053;4978.452370239271;5029.522195391469;5715.685637289947;5772.595918285721;5836.474717275466;5847.736851841677;5854.6194497357965;4356.23572453157;4360.21516127097;4361.3457981302745;4367.45406824147;4367.803448844777;5870.501007414375;6029.879402411971;6034.577579569432;6058.273007239115;6072.696365181723;4418.5802348776815;4424.159409712144;4428.247197976351;4430.800613972379;4436.290193569013;4500.527444618333;4531.932021019687;4535.206338890681;4543.65922555803;4546.727196368229;4882.316475693406;5019.222020586815;5061.190209566452;5063.392392912874;5104.69371837691;5813.895359881609;5851.180834683148;5857;5873.916193998185;5885.529157667376;1488.3823213366331;1494.2379386512957;1495.3719437836135;1509.4037855047413;1513.8183417989912;962.9855552166723;991.4002028772633;995.5370752599931;997.850322451638;1051.9158467322595;5405.21624364465;5450.291462109901;5450.88256907333;5452.509274165265;5468.562514998791;5840.240768700127;5846.239988801429;5857.4435428634215;5859.212940053239;5863;5416.404195538487;5439.809606663748;5452.754626041838;5621.4659607337235;5666.348369937427;3096;3099.612548431446;3111.6266048074376;3112.2219445138717;3138.6704396038544;5996.580239383288;6045;6058.4244496772735;6099.573029887954;6111.174991376108;6087.656252342791;6155.599886007395;6160.845978850564;6168.691565421801;6185.8144255672405;6270.278917924497;6287.811365659038;6302.644931339784;6310.779122730591;6389.776357827547;6009.429104235091;6045.335013148638;6062.909056364247;6072.210612620331;6079.848003799941;6005;6013.609115407485;6025.8192254232445;6033.276006879202;6034.366391529002;6051.848703782441;6205.131281620667;6232.407921247474;6350.523710721622;6365.8726825464155;4355.564443555619;4376.6717496187275;4403.3174857897075;4429.247028005311;4432.911341773211;6086.69566521681;6096.451319381277;6102.755889764359;6118;6143.569950103629;5840.532757379485;5848;5849.61977471463;5863.208466857091;5863.677497737494;5846.6784326862435;5874.265716785402;5889.676067816311;5900.173975643327;5926.140709597171;5676.744546495335;5823.272090988627;5896.380880007538;5911.793087241926;5955.434233747787;5876.059830427112;5889.5582831286965;5906.173135761082;5911.793087241926;5923.851903702442;5736;5761.308642962871;5765;5772.39389864075;5823.854403639943 10:06:00 INFO - PROCESS | 21259 | |5;yui.html;717.1251073690099;735.9816004599887;745.9813504662385;788.8974433323671;811.6753298680524;13754.381052852621;14600.12399256044;14684;14713.632159196026;14742.115473071597;12740.681482962931;12873.549425770076;12898.80651790224;12904.74190516189;12952.870471295284;791.8891355210275;798.9520628762264;808.9878651820227;826.6610689617258;855.9572021398936;620.8447888027993;627.1846599420735;629.2574761781119;634.1122428599974;642.5341627320203;848.1942154952819;855.7646647172046;856.1866227084264;858.7767180533044;867.301822033263;826.0459169659053;828.0684230240948;849.7365816596874;853.8676505141651;859.2782063067023;621.2203684376125;626.937306269374;629.5844742469993;629.9779507717253;630.5460068750492;13489.988250881222;13560.796588051187;13656.24890631015;13784.517541886085;13784.862151378458;13264;13623.795643065361;13985.230812305319;14278.714425711427;14387.424503019867;11689.240199387013;11837.230580012272;11883.168178227528;11891.345975971319;12218.816717749241;3752.3620984432714;3756.6806821420214;3845.403962385835;3861.555921069085;3925.2934471795065;65556.67221663908;65830;66073;66609;66694.66652666754;10374.740631484274;10447.84328235077;10583.57665693379;10642.946785266024;10677.466126693635;19833.404997850088;19853.404397868086;19858;19897.403077907686;19947.102380392917;7723.111842138226;7782.221777822172;7833.451658383972;8116.6347514362;8279.875801862976;4500.684952053325;4526.999895896825;4622.6301895848255;4644.210484217691;4725.881852953635;3275.0993476793597;3380.8478618462227;3389.4576867701544;3391.1861153323025;3430.073880052372;593.5902232198529;601.0923505506717;601.7683191971123;604.241676695744;605.9666718330534;626.2172284644195;628.3025841316136;698.2249702829855;705.9435245180373;714.2464699741719;8538.53038082899;8784.121587841164;9200.769980750534;9322.347435679572;9791.510424478747;591.9315635278278;602.3976023976024;661.0414898397343;662.0797092042066;664.1366223908899;4288.8284468620905;4486.439195100613;4611.100835337144;4623.583877451046;4648;56675;70755;82529.17470825335;92859.0714092864;96530;68064.3193568068;70051;82114.58942705249;83971.5801420989;86479;66310;67973.66013170002;68186.65906670435;68919.65540172368;68955.31044689489;8880;9085.001299714053;9412.67055653049;9829.901700982899;9848.310618256939;47118.76440617775;47350;47478.52521474741;47580.2862957049;48504.272435914194;56403.02589409351;64763.35236647573;66102.33897661154;66732.666336668;67607.66196168988;11905.761884762429;12064.095192860746;12140.453679584616;12282.07884408655;12419.93790031044;13004.8049279259;13559.322033898068;13680.794788078387;13733.793993090312;13822.032457727862;12651.240925544496;12765.297908614744;12827.679308017374;13081.803772943604;13116.606501804961;10964;11868.169228153947;12316.568920087753;12529.561465348668;12909.806352904901;11935.462904169159;12336.136470446983;12409.689757756129;12612.87387126117;12822.615321540368;11650.708732281422;11672.883271167519;11946.104042196695;12225.144239903477;12251.816222756845;10345.586176552853;10545.31455455393;11052.723681908017;11307.886921130683;11387.089032877515 10:06:00 INFO - PROCESS | 21259 | __end_tp_report 10:06:00 INFO - PROCESS | 21259 | __start_cc_report 10:06:00 INFO - PROCESS | 21259 | _x_x_mozilla_cycle_collect,307 10:06:00 INFO - PROCESS | 21259 | __end_cc_report 10:06:00 INFO - PROCESS | 21259 | __startTimestamp1486749960260__endTimestamp 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | ------- Summary: start ------- 10:06:00 INFO - PROCESS | 21259 | Number of tests: 6 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | [#0] dojo.html Cycles:165 Average:5717.04 Median:5920.59 stddev:645.70 (10.9%) stddev-sans-first:619.05 10:06:00 INFO - PROCESS | 21259 | Values: 3293.2 3315.3 3331.8 3351.9 3352.7 5680.9 5687.5 5730.3 5751.5 5752.0 5743.9 5746.2 5776.0 5795.9 5835.1 5188.1 5245.1 5270.9 5306.9 5310.4 5313.7 5328.7 5332.3 5334.0 5341.9 5129.4 5147.6 5307.8 5318.8 5326.6 5165.3 5171.4 5228.3 5234.6 5293.0 5163.7 5224.5 5226.4 5242.6 5254.9 5686.4 5713.3 5774.0 5787.5 5800.8 6033.1 6088.8 6104.5 6111.4 6114.2 6096.6 6139.4 6183.0 6187.9 6189.7 5837.5 5838.6 5852.6 5858.7 5868.5 6185.5 6203.9 6216.4 6324.7 6386.6 6060.8 6079.9 6091.7 6111.7 6124.3 5942.7 6118.7 6133.5 6134.5 6140.2 5941.3 6013.4 6116.4 6142.0 6201.9 6117.0 6175.0 6177.1 6193.2 6197.8 4620.2 4747.1 4756.1 4756.1 4775.5 4131.7 4144.9 4156.0 4183.9 4253.5 5855.6 5868.7 5905.5 5929.4 5934.4 6205.6 6208.0 6211.6 6234.4 6236.8 5692.4 5858.9 5862.2 5880.6 5965.2 5297.9 5324.2 5339.7 5342.2 5345.1 6525.2 6527.6 6533.2 6537.9 6551.2 5904.8 6016.0 6061.2 6076.6 6136.8 6364.2 6388.9 6416.0 6416.8 6420.4 6037.8 6043.2 6054.4 6058.5 6068.6 5825.7 5836.3 5973.3 6012.8 6137.1 5906.7 5955.0 5968.2 5984.6 6007.6 5898.1 5904.3 5913.6 5914.7 5921.8 5790.4 5876.9 5935.7 5950.3 5960.4 6038.7 6095.8 6105.7 6106.4 6117.1 5920.6 5925.3 5932.8 5937.4 5947.2 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | [#1] ext.html Cycles:180 Average:53147.95 Median:40602.59 stddev:96801.58 (238.4%) stddev-sans-first:96992.72 10:06:00 INFO - PROCESS | 21259 | Values: 597.6 627.8 641.1 650.3 678.9 39545.2 42568.8 42609.4 42874.8 43013.0 43762.3 43878.6 44049.0 44384.6 44387.0 8984.2 9089.7 9116.0 9125.0 9152.0 9062.5 9123.6 9126.3 9140.7 9142.2 9110.4 9162.7 9166.2 9172.6 9176.0 9081.6 9101.8 9138.9 9140.7 9171.8 9087.5 9103.1 9163.0 9169.0 9175.9 40486.8 40718.4 40777.4 40786.8 41802.4 3385.4 3579.5 3622.2 3699.8 4203.4 29442.0 29553.4 30675.2 30694.2 30971.4 4311.8 4396.2 4400.2 4488.9 4494.1 312362.0 313282.0 313461.0 313853.0 315013.0 58431.7 58518.0 58925.4 59060.4 59069.1 64755.0 64861.0 64931.7 65438.7 65502.0 13772.1 13780.7 13814.3 13832.0 13872.9 12062.8 12096.5 12124.6 12127.1 12172.9 17876.0 18028.6 18616.0 18796.2 18819.2 5718.4 5733.5 5746.0 5933.6 5953.5 995.7 1055.6 1103.6 1125.9 1165.3 31577.5 31626.7 31628.4 31692.4 32141.4 1077.5 1085.3 1108.9 1128.5 1200.9 14896.7 15032.3 15143.8 15420.0 15536.2 461647.0 461947.0 463467.0 465225.0 466277.0 57045.7 57115.7 57208.0 57464.4 57714.0 1327.9 1372.3 1372.8 1409.2 1434.9 27060.9 27421.3 27730.4 27811.0 28065.6 51681.0 51995.5 52079.0 52315.5 52503.5 298458.0 300421.0 301426.0 301874.0 302390.0 28740.1 28928.3 28928.4 29961.9 30370.0 46959.5 47069.8 47224.0 47324.5 47665.5 39596.4 39932.8 40055.8 41726.0 42365.8 38089.4 39690.6 39954.4 40122.6 40238.0 38483.2 38837.2 39867.4 41218.6 42156.4 34054.7 36289.8 36570.8 36903.0 37326.0 27640.0 28125.3 28574.9 28584.4 28771.1 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | [#2] jquery.html Cycles:180 Average:29587.48 Median:415.69 stddev:82210.52 (19776.7%) stddev-sans-first:82411.96 10:06:00 INFO - PROCESS | 21259 | Values: 413.9 417.5 426.0 431.3 443.1 18726.7 19195.0 19946.2 20171.2 20295.8 18396.4 18512.4 19220.0 19386.6 19648.3 5748.5 5933.7 5962.9 5965.1 5978.9 4114.8 4215.5 5806.1 5878.3 5881.4 6509.4 6515.4 6621.9 6640.9 6654.6 6588.7 6600.9 6627.0 6668.6 6689.6 5964.8 6003.4 6014.7 6019.0 6020.9 22333.0 23195.5 23539.3 23923.5 23960.4 2440.3 2447.2 2478.8 2579.7 2614.8 9891.9 10345.7 10780.8 11978.0 15590.2 1970.5 2009.9 2024.1 2049.0 2121.9 80427.0 84686.2 85396.0 86472.0 86632.0 11373.8 11461.0 11630.7 11642.8 11913.3 16336.8 16417.0 16525.0 16546.3 16550.5 8053.7 8186.8 8363.0 8378.5 8607.3 7973.6 8029.5 8041.3 8134.3 8247.4 4629.0 4707.8 4899.2 4965.6 4991.7 1922.9 1950.5 1968.6 1979.0 2003.3 814.9 895.1 924.6 936.7 941.2 16782.5 17220.5 17636.3 18122.5 18210.4 885.3 910.6 916.4 934.3 980.1 9543.9 9945.3 10071.6 10784.6 11377.9 490710.0 496463.0 496692.0 502197.0 503588.0 83739.6 89269.6 98756.5 100558.0 102282.5 1041.0 1073.4 1076.7 1080.4 1089.0 17892.3 18062.3 18180.5 18377.0 18405.7 36165.3 40322.2 42323.4 42977.4 43670.0 58568.1 60960.7 61882.1 62332.1 63575.7 8252.4 8406.8 8509.6 8570.1 8694.2 12566.7 13349.5 13349.6 13353.9 13455.3 11394.5 11433.2 11520.4 11863.2 12238.3 5768.6 10550.9 11524.7 11532.3 12252.6 12038.7 12072.6 12083.3 12099.3 12377.7 8711.0 8833.5 8878.2 8917.5 9063.4 8866.0 10681.8 11268.3 11774.5 11774.7 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | [#3] mootools.html Cycles:180 Average:5754.07 Median:5050.98 stddev:3205.67 (63.5%) stddev-sans-first:3198.61 10:06:00 INFO - PROCESS | 21259 | Values: 1485.1 1485.3 1624.8 1749.6 1754.7 7718.3 7924.7 8319.5 8796.0 8820.7 8121.0 8336.7 8355.4 8579.9 8635.5 2414.5 2458.3 2458.6 2459.2 2463.2 2428.7 2483.6 2527.6 2531.0 2533.9 2440.5 2448.2 2455.5 2460.6 2467.0 2356.4 2368.6 2382.5 2408.7 2408.8 2388.4 2388.5 2408.5 2411.2 2417.3 8439.1 8486.1 8537.3 8549.7 8617.5 5438.4 5574.5 5576.4 5597.1 5598.6 3398.8 3450.1 3473.5 3493.8 3539.1 1167.3 1186.2 1195.3 1196.7 1258.9 12088.3 12093.7 12119.6 12137.9 12166.6 4744.9 4935.0 5043.7 5048.3 5053.7 10383.5 10426.3 10428.1 10453.8 10457.1 5593.2 5619.8 5624.0 5624.1 5631.2 4413.8 4749.9 5047.9 5102.0 5165.1 4129.7 4152.6 4218.3 4244.2 4252.9 1372.2 1397.9 1412.4 1421.0 1421.5 815.5 826.3 839.5 843.8 854.1 5495.0 5624.9 5678.8 5684.7 5703.7 917.1 917.9 923.2 924.5 968.5 3754.3 3768.2 3793.7 3797.0 3804.4 10615.0 10847.5 10936.9 10945.3 10951.4 10873.8 10908.6 10919.2 10927.8 10963.9 7590.0 7936.4 8098.3 8108.0 8118.6 5616.9 5679.8 5727.9 5744.3 5922.8 9896.5 9962.4 10020.6 10200.9 10224.7 10003.2 10103.6 10338.9 10389.7 10397.7 7221.3 7350.8 7505.4 7615.6 7633.1 8153.6 8333.3 8333.7 8334.7 8349.1 7283.7 7305.0 7324.8 7339.3 7347.6 6768.3 7037.9 7060.0 7066.7 7081.2 6700.5 6805.8 6820.0 6825.9 6849.6 4964.8 5106.0 5131.7 5233.5 5235.1 5141.5 5157.3 5237.5 5269.4 5279.1 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | [#4] prototype.html Cycles:180 Average:4941.55 Median:5574.14 stddev:1449.87 (26.0%) stddev-sans-first:1412.20 10:06:00 INFO - PROCESS | 21259 | Values: 339.9 348.4 353.6 359.2 359.7 5548.6 5566.3 5573.7 5603.4 5611.5 5525.8 5526.9 5544.8 5551.4 5574.5 4174.9 4258.9 4322.0 4325.8 4336.9 4304.8 4308.8 4310.0 4321.5 4325.0 4233.4 4245.8 4255.9 4264.4 4292.5 4155.7 4300.7 4302.1 4322.2 4335.9 3828.6 3832.7 3834.7 3836.8 3838.9 5394.2 5411.2 5416.6 5424.4 5438.8 4837.8 4953.5 4978.3 4978.5 5029.5 5715.7 5772.6 5836.5 5847.7 5854.6 4356.2 4360.2 4361.3 4367.5 4367.8 5870.5 6029.9 6034.6 6058.3 6072.7 4418.6 4424.2 4428.2 4430.8 4436.3 4500.5 4531.9 4535.2 4543.7 4546.7 4882.3 5019.2 5061.2 5063.4 5104.7 5813.9 5851.2 5857.0 5873.9 5885.5 1488.4 1494.2 1495.4 1509.4 1513.8 963.0 991.4 995.5 997.9 1051.9 5405.2 5450.3 5450.9 5452.5 5468.6 5840.2 5846.2 5857.4 5859.2 5863.0 5416.4 5439.8 5452.8 5621.5 5666.3 3096.0 3099.6 3111.6 3112.2 3138.7 5996.6 6045.0 6058.4 6099.6 6111.2 6087.7 6155.6 6160.8 6168.7 6185.8 6270.3 6287.8 6302.6 6310.8 6389.8 6009.4 6045.3 6062.9 6072.2 6079.8 6005.0 6013.6 6025.8 6033.3 6034.4 6051.8 6205.1 6232.4 6350.5 6365.9 4355.6 4376.7 4403.3 4429.2 4432.9 6086.7 6096.5 6102.8 6118.0 6143.6 5840.5 5848.0 5849.6 5863.2 5863.7 5846.7 5874.3 5889.7 5900.2 5926.1 5676.7 5823.3 5896.4 5911.8 5955.4 5876.1 5889.6 5906.2 5911.8 5923.9 5736.0 5761.3 5765.0 5772.4 5823.9 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - PROCESS | 21259 | [#5] yui.html Cycles:180 Average:17686.63 Median:26037.94 stddev:23458.44 (90.1%) stddev-sans-first:23489.64 10:06:00 INFO - PROCESS | 21259 | Values: 717.1 736.0 746.0 788.9 811.7 13754.4 14600.1 14684.0 14713.6 14742.1 12740.7 12873.5 12898.8 12904.7 12952.9 791.9 799.0 809.0 826.7 856.0 620.8 627.2 629.3 634.1 642.5 848.2 855.8 856.2 858.8 867.3 826.0 828.1 849.7 853.9 859.3 621.2 626.9 629.6 630.0 630.5 13490.0 13560.8 13656.2 13784.5 13784.9 13264.0 13623.8 13985.2 14278.7 14387.4 11689.2 11837.2 11883.2 11891.3 12218.8 3752.4 3756.7 3845.4 3861.6 3925.3 65556.7 65830.0 66073.0 66609.0 66694.7 10374.7 10447.8 10583.6 10642.9 10677.5 19833.4 19853.4 19858.0 19897.4 19947.1 7723.1 7782.2 7833.5 8116.6 8279.9 4500.7 4527.0 4622.6 4644.2 4725.9 3275.1 3380.8 3389.5 3391.2 3430.1 593.6 601.1 601.8 604.2 606.0 626.2 628.3 698.2 705.9 714.2 8538.5 8784.1 9200.8 9322.3 9791.5 591.9 602.4 661.0 662.1 664.1 4288.8 4486.4 4611.1 4623.6 4648.0 56675.0 70755.0 82529.2 92859.1 96530.0 68064.3 70051.0 82114.6 83971.6 86479.0 66310.0 67973.7 68186.7 68919.7 68955.3 8880.0 9085.0 9412.7 9829.9 9848.3 47118.8 47350.0 47478.5 47580.3 48504.3 56403.0 64763.4 66102.3 66732.7 67607.7 11905.8 12064.1 12140.5 12282.1 12419.9 13004.8 13559.3 13680.8 13733.8 13822.0 12651.2 12765.3 12827.7 13081.8 13116.6 10964.0 11868.2 12316.6 12529.6 12909.8 11935.5 12336.1 12409.7 12612.9 12822.6 11650.7 11672.9 11946.1 12225.1 12251.8 10345.6 10545.3 11052.7 11307.9 11387.1 10:06:00 INFO - PROCESS | 21259 | -------- Summary: end -------- 10:06:00 INFO - PROCESS | 21259 | 10:06:00 INFO - TEST-INFO | 21259: exit 0 10:06:00 INFO - TEST-OK | dromaeo_css | took 1112733ms 10:06:00 INFO - TEST-START | kraken 10:06:00 INFO - operating with platform_type : linux_ 10:06:00 INFO - Initialising browser for kraken test... 10:06:00 INFO - TEST-INFO | started process 21621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqE9W3D/profile http://localhost:54164/getInfo.html) 10:06:05 INFO - PROCESS | 21621 | __metrics Screen width/height:1600/1200 10:06:05 INFO - PROCESS | 21621 | colorDepth:24 10:06:05 INFO - PROCESS | 21621 | Browser inner width/height: 1024/697 10:06:05 INFO - PROCESS | 21621 | __metrics 10:06:06 ERROR - PROCESS | 21621 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:06:06 INFO - TEST-INFO | 21621: exit 0 10:06:06 INFO - Browser initialized. 10:06:06 INFO - Running cycle 1/1 for kraken test... 10:06:06 INFO - TEST-INFO | started process 21749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqE9W3D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:18 INFO - PROCESS | 21749 | RSS: Main: 147992576 10:06:18 INFO - PROCESS | 21749 | 10:06:21 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54164/tests/kraken/driver.html?testName=audio-beat-detection) 10:06:22 INFO - PROCESS | 21749 | RSS: Main: 153755648 10:06:22 INFO - PROCESS | 21749 | 10:06:24 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54164/tests/kraken/driver.html?testName=audio-dft) 10:06:25 INFO - PROCESS | 21749 | RSS: Main: 152784896 10:06:25 INFO - PROCESS | 21749 | 10:06:28 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54164/tests/kraken/driver.html?testName=audio-fft) 10:06:28 INFO - PROCESS | 21749 | RSS: Main: 152907776 10:06:28 INFO - PROCESS | 21749 | 10:06:30 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54164/tests/kraken/driver.html?testName=audio-oscillator) 10:06:31 INFO - PROCESS | 21749 | RSS: Main: 152285184 10:06:31 INFO - PROCESS | 21749 | 10:06:33 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54164/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:33 INFO - PROCESS | 21749 | RSS: Main: 152375296 10:06:33 INFO - PROCESS | 21749 | 10:06:36 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54164/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:37 INFO - PROCESS | 21749 | RSS: Main: 155521024 10:06:37 INFO - PROCESS | 21749 | 10:06:40 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54164/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:41 INFO - PROCESS | 21749 | RSS: Main: 155209728 10:06:41 INFO - PROCESS | 21749 | 10:06:44 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54164/tests/kraken/driver.html?testName=json-parse-financial) 10:06:44 INFO - PROCESS | 21749 | RSS: Main: 155049984 10:06:44 INFO - PROCESS | 21749 | 10:06:46 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54164/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:06:46 INFO - PROCESS | 21749 | RSS: Main: 154525696 10:06:46 INFO - PROCESS | 21749 | 10:06:48 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:49 INFO - PROCESS | 21749 | RSS: Main: 153874432 10:06:49 INFO - PROCESS | 21749 | 10:06:51 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:51 INFO - PROCESS | 21749 | RSS: Main: 154488832 10:06:51 INFO - PROCESS | 21749 | 10:06:54 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:55 INFO - PROCESS | 21749 | RSS: Main: 155201536 10:06:55 INFO - PROCESS | 21749 | 10:06:57 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:58 INFO - PROCESS | 21749 | RSS: Main: 155316224 10:06:58 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54164/tests/kraken/driver.html?testName=ai-astar) 10:07:00 INFO - PROCESS | 21749 | RSS: Main: 156250112 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | __start_tp_report 10:07:00 INFO - PROCESS | 21749 | _x_x_mozilla_page_load 10:07:00 INFO - PROCESS | 21749 | _x_x_mozilla_page_load_details 10:07:00 INFO - PROCESS | 21749 | |i|pagename|runs| 10:07:00 INFO - PROCESS | 21749 | |0;ai-astar;101;111;112;111;112;111;112;112;110;111 10:07:00 INFO - PROCESS | 21749 | |1;audio-beat-detection;148;119;118;146;121;119;117;123;148;117 10:07:00 INFO - PROCESS | 21749 | |2;audio-dft;162;161;162;162;162;162;162;164;162;163 10:07:00 INFO - PROCESS | 21749 | |3;audio-fft;74;78;79;111;75;76;75;81;96;75 10:07:00 INFO - PROCESS | 21749 | |4;audio-oscillator;80;80;114;81;81;80;91;80;82;103 10:07:00 INFO - PROCESS | 21749 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;117;118;118 10:07:00 INFO - PROCESS | 21749 | |6;imaging-darkroom;147;147;147;147;148;147;148;146;147;148 10:07:00 INFO - PROCESS | 21749 | |7;imaging-desaturate;86;85;86;85;85;86;85;84;85;84 10:07:00 INFO - PROCESS | 21749 | |8;json-parse-financial;57;55;59;54;54;54;56;54;59;54 10:07:00 INFO - PROCESS | 21749 | |9;json-stringify-tinderbox;60;60;59;61;60;60;58;59;60;61 10:07:00 INFO - PROCESS | 21749 | |10;stanford-crypto-aes;76;81;78;75;81;75;75;76;75;75 10:07:00 INFO - PROCESS | 21749 | |11;stanford-crypto-ccm;124;123;126;122;132;121;124;120;165;133 10:07:00 INFO - PROCESS | 21749 | |12;stanford-crypto-pbkdf2;156;153;158;163;159;155;159;154;153;156 10:07:00 INFO - PROCESS | 21749 | |13;stanford-crypto-sha256-iterative;67;62;63;61;61;62;62;62;60;67 10:07:00 INFO - PROCESS | 21749 | __end_tp_report 10:07:00 INFO - PROCESS | 21749 | __start_cc_report 10:07:00 INFO - PROCESS | 21749 | _x_x_mozilla_cycle_collect,747 10:07:00 INFO - PROCESS | 21749 | __end_cc_report 10:07:00 INFO - PROCESS | 21749 | __startTimestamp1486750020451__endTimestamp 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | ------- Summary: start ------- 10:07:00 INFO - PROCESS | 21749 | Number of tests: 14 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.33 (3.0%) stddev-sans-first:0.71 10:07:00 INFO - PROCESS | 21749 | Values: 101.0 111.0 112.0 111.0 112.0 111.0 112.0 112.0 110.0 111.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:122.00 stddev:13.75 (11.3%) stddev-sans-first:12.44 10:07:00 INFO - PROCESS | 21749 | Values: 148.0 119.0 118.0 146.0 121.0 119.0 117.0 123.0 148.0 117.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:07:00 INFO - PROCESS | 21749 | Values: 162.0 161.0 162.0 162.0 162.0 162.0 162.0 164.0 162.0 163.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:12.06 (15.7%) stddev-sans-first:12.44 10:07:00 INFO - PROCESS | 21749 | Values: 74.0 78.0 79.0 111.0 75.0 76.0 75.0 81.0 96.0 75.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:80.50 stddev:11.99 (14.9%) stddev-sans-first:12.43 10:07:00 INFO - PROCESS | 21749 | Values: 80.0 80.0 114.0 81.0 81.0 80.0 91.0 80.0 82.0 103.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:07:00 INFO - PROCESS | 21749 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:07:00 INFO - PROCESS | 21749 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 148.0 146.0 147.0 148.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 10:07:00 INFO - PROCESS | 21749 | Values: 86.0 85.0 86.0 85.0 85.0 86.0 85.0 84.0 85.0 84.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:2.07 (3.7%) stddev-sans-first:2.13 10:07:00 INFO - PROCESS | 21749 | Values: 57.0 55.0 59.0 54.0 54.0 54.0 56.0 54.0 59.0 54.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 10:07:00 INFO - PROCESS | 21749 | Values: 60.0 60.0 59.0 61.0 60.0 60.0 58.0 59.0 60.0 61.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:2.45 (3.2%) stddev-sans-first:2.59 10:07:00 INFO - PROCESS | 21749 | Values: 76.0 81.0 78.0 75.0 81.0 75.0 75.0 76.0 75.0 75.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:125.00 stddev:13.37 (10.7%) stddev-sans-first:14.06 10:07:00 INFO - PROCESS | 21749 | Values: 124.0 123.0 126.0 122.0 132.0 121.0 124.0 120.0 165.0 133.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:157.00 stddev:3.17 (2.0%) stddev-sans-first:3.35 10:07:00 INFO - PROCESS | 21749 | Values: 156.0 153.0 158.0 163.0 159.0 155.0 159.0 154.0 153.0 156.0 10:07:00 INFO - PROCESS | 21749 | 10:07:00 INFO - PROCESS | 21749 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:2.41 (3.9%) stddev-sans-first:1.99 10:07:00 INFO - PROCESS | 21749 | Values: 67.0 62.0 63.0 61.0 61.0 62.0 62.0 62.0 60.0 67.0 10:07:00 INFO - PROCESS | 21749 | -------- Summary: end -------- 10:07:00 INFO - PROCESS | 21749 | 10:07:01 INFO - TEST-INFO | 21749: exit 0 10:07:01 INFO - TEST-OK | kraken | took 60474ms 10:07:01 INFO - SUITE-END | took 1173s 10:07:01 INFO - Completed test suite (00:19:33) 10:07:01 INFO - javascript benchmark 10:07:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7302.9271534210475, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.176705823544, 3315.336932613477, 3331.8000919944807, 3351.882684106057, 3352.6647335266475, 5680.920625081231, 5687.488126068653, 5730.283714535683, 5751.539876809856, 5751.971240143798, 5743.856403589913, 5746.1668058131545, 5776.0, 5795.942040579593, 5835.124731290298, 5188.143956247215, 5245.134552798783, 5270.894582108355, 5306.893862122755, 5310.415854256029, 5313.73431328434, 5328.680279183242, 5332.253484512172, 5334.03987282289, 5341.866453338678, 5129.435762066169, 5147.588192944556, 5307.761150748225, 5318.813841515548, 5326.6005049621235, 5165.3026841376495, 5171.3535808024, 5228.2941802856885, 5234.555062819646, 5293.04725149473, 5163.741812909339, 5224.52979231871, 5226.425093239741, 5242.6330156889035, 5254.894902101936, 5686.402927692616, 5713.285839270091, 5774.0, 5787.479126878559, 5800.7679692812235, 6033.064874944391, 6088.786892458787, 6104.4505994460715, 6111.379037751134, 6114.205153330038, 6096.573239873211, 6139.4001448443105, 6182.96908515459, 6187.87624247517, 6189.659568723719, 5837.47462728348, 5838.591298609099, 5852.6488410695065, 5858.677772722456, 5868.530517558585, 6185.474234690012, 6203.875922481525, 6216.4405203531, 6324.71538780756, 6386.552941294065, 6060.787872424444, 6079.939200607937, 6091.695415229309, 6111.724972376253, 6124.295705993868, 5942.732577034044, 6118.724657390339, 6133.539984501181, 6134.478569321657, 6140.17107690456, 5941.346451890288, 6013.398660133952, 6116.3577824328695, 6142.01727723571, 6201.875962480815, 6117.0, 6174.969125154345, 6177.073438984098, 6193.163922870445, 6197.845053873599, 4620.168369693488, 4747.121782470185, 4756.096341695067, 4756.096341695067, 4775.5463230993, 4131.690123240709, 4144.937825932613, 4155.979220103941, 4183.895402614898, 4253.48958125027, 5855.590108692436, 5868.706564671749, 5905.498032667271, 5929.37741537141, 5934.37689042653, 6205.565610407228, 6207.968960155261, 6211.565190436717, 6234.37656234382, 6236.844078898064, 5692.430756924357, 5858.912116318259, 5862.237909071879, 5880.558958078162, 5965.194698715704, 5297.867553311121, 5324.227986941872, 5339.733013349317, 5342.171963345688, 5345.091334473149, 6525.151730274939, 6527.640979746065, 6533.18335208099, 6537.869242615121, 6551.246606640202, 5904.822855314347, 6016.007358785926, 6061.1514387984835, 6076.605020673642, 6136.754529818757, 6364.236291645032, 6388.872222555616, 6416.0, 6416.807495775134, 6420.357964203542, 6037.78867739627, 6043.244594425697, 6054.424829641177, 6058.485028772604, 6068.575199735976, 5825.747464295197, 5836.328822185503, 5973.342932277359, 6012.819615411545, 6137.140800288053, 5906.675132867734, 5954.970225148846, 5968.164456976114, 5984.611000284967, 6007.579469437097, 5898.144769008555, 5904.3210030847, 5913.586048976703, 5914.674692891932, 5921.822345329647, 5790.4209579043445, 5876.94123058781, 5935.7032148391545, 5950.31571369298, 5960.374160713236, 6038.7282572283475, 6095.847603809941, 6105.694715264308, 6106.358832322542, 6117.12715980571, 5920.585559010828, 5925.348211696623, 5932.822015339547, 5937.435943585352, 5947.167396564571], "value": 5673.52399078706, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6294697287682, 627.7520379450119, 641.0576452614657, 650.265200323634, 678.8913773796194, 39545.2090958181, 42568.787156064216, 42609.360859587134, 42874.78562607186, 43013.0, 43762.34356484647, 43878.561214387846, 44049.0, 44384.55615443845, 44387.0, 8984.236339911115, 9089.727308180733, 9116.042815504376, 9125.04187060359, 9151.95424022879, 9062.456252624863, 9123.635054597808, 9126.269898408145, 9140.680076197334, 9142.177204051633, 9110.407823491485, 9162.679306224283, 9166.175044246016, 9172.587233574504, 9176.036516165806, 9081.636734530612, 9101.77245568866, 9138.862917056249, 9140.6800761973, 9171.770705732377, 9087.545622718904, 9103.13520215585, 9163.0, 9169.0, 9175.908240917572, 40486.797566012276, 40718.38922416166, 40777.38833917493, 40786.79606601978, 41802.37296440556, 3385.3737058643983, 3579.480975258599, 3622.1850083731215, 3699.7595156314756, 4203.4115223868685, 29442.0, 29553.408931821457, 30675.233119171975, 30694.232644184074, 30971.380572388425, 4311.771145223596, 4396.20868243716, 4400.185965596375, 4488.865334039984, 4494.1461122386645, 312362.0, 313282.0, 313461.0, 313853.0, 315013.0, 58431.70784146052, 58518.0, 58925.41074589199, 59060.40939590549, 59069.11396329058, 64755.0, 64861.0, 64931.67534162394, 65438.67280663661, 65502.0, 13772.10481318731, 13780.724385512434, 13814.309284535733, 13832.0, 13872.930635346758, 12062.819057714141, 12096.516139354328, 12124.575639852563, 12127.09046821492, 12172.878271217174, 17875.987859489294, 18028.557715382736, 18616.0, 18796.248150074116, 18819.153138108817, 5718.370979192286, 5733.48062763368, 5745.971270143623, 5933.58464907461, 5953.523718102541, 995.6863587969766, 1055.5935964653663, 1103.586155191803, 1125.9042981346677, 1165.3474054529322, 31577.526337104962, 31626.683733162834, 31628.36743265122, 31692.366152676816, 32141.35717285688, 1077.4774234496263, 1085.316250762015, 1108.933463992163, 1128.537299707116, 1200.9039276858005, 14896.70206595862, 15032.323545440482, 15143.772843407358, 15420.0, 15536.223188840513, 461647.0, 461947.0, 463467.0, 465225.0, 466277.0, 57045.714771425875, 57115.71442142763, 57208.0, 57464.42535574591, 57714.0, 1327.8672132786837, 1372.3344178073626, 1372.7803551431723, 1409.1826740490492, 1434.9426022959174, 27060.864695676395, 27421.31446713848, 27730.445391092468, 27811.0, 28065.579016314365, 51681.0, 51995.48004519907, 52079.0, 52315.47684523106, 52503.474965251386, 298458.0, 300421.0, 301426.0, 301874.0, 302390.0, 28740.137795866158, 28928.276793080342, 28928.42143157167, 29961.850190748908, 30370.0, 46959.53040469688, 47069.764651177895, 47224.0, 47324.526754733386, 47665.52334476611, 39596.406053908635, 39932.80033599814, 40055.79972100121, 41726.0, 42365.78817105895, 38089.4286585707, 39690.60309396869, 39954.40068398918, 40122.59877401189, 40238.0, 38483.230335392574, 38837.2232555353, 39867.40198896961, 41218.58781412267, 42156.367654484595, 34054.65945340515, 36289.818550907075, 36570.8171459141, 36903.0, 37326.0, 27640.0, 28125.296867578476, 28574.85712571424, 28584.42831143324, 28771.136865894056], "value": 19516.348510954605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.8592878421336, 417.53027843675886, 426.0414068346221, 431.29698591296193, 443.0585006860422, 18726.719099213522, 19194.99999999998, 19946.202151913923, 20171.19315227393, 20295.797042029575, 18396.35612753554, 18512.352067677635, 19220.0, 19386.612267754637, 19648.312309069184, 5748.482636562719, 5933.7033148342625, 5962.910556341637, 5965.075413310944, 5978.880422391571, 4114.753114813121, 4215.473065866767, 5806.129080637896, 5878.294604647448, 5881.441263080001, 6509.381608747161, 6515.381038801306, 6621.933780662204, 6640.900386494206, 6654.567453115556, 6588.736450541973, 6600.900986485207, 6627.0, 6668.599884006975, 6689.5986240825705, 5964.821055368346, 6003.369646187131, 6014.699265036775, 6019.036954087369, 6020.909686354708, 22333.0, 23195.53608927829, 23539.29382118539, 23923.521529569483, 23960.400989975216, 2440.3289095498703, 2447.21689059501, 2478.7567251637297, 2579.651747014148, 2614.7777438917715, 9891.851622225673, 10345.741356466073, 10780.838287425695, 11978.041756659446, 15590.22048897562, 1970.4581240158927, 2009.8995050247574, 2024.068928292987, 2049.0164720934035, 2121.9151233950624, 80427.0, 84686.15313846845, 85396.0, 86472.0, 86632.0, 11373.772524549462, 11461.0, 11630.6510804676, 11642.825357619642, 11913.344766037777, 16336.836631633769, 16417.0, 16525.0, 16546.338146474005, 16550.50348489547, 8053.677852885936, 8186.754397368089, 8362.958185209034, 8378.455400398954, 8607.268382187583, 7973.641186146638, 8029.518228906284, 8041.276285134366, 8134.349252059821, 8247.381446391544, 4628.97685511577, 4707.81168753246, 4899.216125419915, 4965.553100220997, 4991.650584459126, 1922.9326973555858, 1950.4928718533283, 1968.5767559974674, 1978.9901050494655, 2003.3188715836686, 814.9388795840335, 895.136193573205, 924.58393722825, 936.6581197862731, 941.1811723800338, 16782.455386797657, 17220.536254418515, 17636.294548218186, 18122.45632631023, 18210.36263730763, 885.2740752582949, 910.5811326789751, 916.4328997414495, 934.3412893909777, 980.0894431219383, 9543.904560954441, 9945.30382873192, 10071.597136114473, 10784.622538211124, 11377.886221137682, 490710.0, 496463.0, 496692.0, 502197.0, 503588.0, 83739.5813020931, 89269.55365223263, 98756.50621746846, 100558.0, 102282.48858755808, 1040.9791804164026, 1073.3613499967507, 1076.6608518316548, 1080.438172150493, 1088.9782204355868, 17892.28430862751, 18062.277508900024, 18180.545486362946, 18377.0, 18405.723914141032, 36165.27669446649, 40322.19355612813, 42323.365149522164, 42977.355339670554, 43670.0, 58568.12147817701, 60960.69519652373, 61882.0717689226, 62332.06501902566, 63575.682121589096, 8252.422330436812, 8406.789830254293, 8509.617067231866, 8570.142985701379, 8694.17405346491, 12566.748665026831, 13349.532766353132, 13349.599512014654, 13353.866461335263, 13455.327233638474, 11394.544218231178, 11433.179517046648, 11520.366379849189, 11863.228890122115, 12238.265704057785, 5768.567357448124, 10550.947245263724, 11524.711882202677, 11532.308061516336, 12252.632421027383, 12038.699032524257, 12072.637820865388, 12083.275003499819, 12099.33453660022, 12377.690557736129, 8711.0, 8833.514156721441, 8878.156575125353, 8917.464952102895, 9063.365564410427, 8865.955670221865, 10681.82499924992, 11268.323900565993, 11774.470148843495, 11774.705632359259], "value": 9393.439049723675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.056988812104, 1485.331600779649, 1624.7644091606717, 1749.6325771587965, 1754.701700710879, 7718.266764657348, 7924.6830126795, 8319.500829950199, 8796.032436431995, 8820.735377938656, 8120.959395203015, 8336.666533338674, 8355.415120941536, 8579.91420085799, 8635.481871087739, 2414.4929564791373, 2458.323960910746, 2458.5943319352286, 2459.2007597530783, 2463.1502131764514, 2428.6721292625534, 2483.627455881623, 2527.633493143493, 2531.0382054819142, 2533.9113131040417, 2440.5240978009297, 2448.2165706973774, 2455.472073504196, 2460.5570997220493, 2467.037855236459, 2356.36378177891, 2368.5854975379325, 2382.463945612241, 2408.662787209792, 2408.8193385495983, 2388.4028992751814, 2388.474535602165, 2408.4580969281947, 2411.180198732422, 2417.274817554744, 8439.113893041203, 8486.108958559324, 8537.274331681814, 8549.743507694779, 8617.526036068013, 5438.428964958662, 5574.470425309589, 5576.442355764431, 5597.076482380402, 5598.580106491989, 3398.7960722356493, 3450.102973226979, 3473.4616134498942, 3493.825308734553, 3539.132912436444, 1167.2762887010024, 1186.2467333243367, 1195.2649120790738, 1196.7008247938015, 1258.9055820813385, 12088.33514156721, 12093.697657558543, 12119.575814846527, 12137.878621213764, 12166.5741699041, 4744.881377965578, 4934.975325123423, 5043.747812609355, 5048.29323894655, 5053.67151135175, 10383.480825958672, 10426.27016108865, 10428.061474467335, 10453.84319235197, 10457.058864702214, 5593.188987596775, 5619.775208991677, 5624.0, 5624.100143976944, 5631.2397826293745, 4413.845515406945, 4749.9050019000115, 5047.899042019139, 5101.974490127525, 5165.1219292720325, 4129.740786527486, 4152.563980781974, 4218.282891908383, 4244.236037513216, 4252.914941701149, 1372.1698372484702, 1397.9091359061629, 1412.4209074279497, 1420.978685319721, 1421.459845258795, 815.5269943432795, 826.2935190412231, 839.47532792005, 843.7932706486828, 854.0903937306748, 5494.972525137348, 5624.859378515488, 5678.772849086073, 5684.744186511617, 5703.7433315500075, 917.0874979395544, 917.9449233045905, 923.1645360948353, 924.4591913730543, 968.4625033106553, 3754.305453491113, 3768.171002379472, 3793.6585707285926, 3796.962030379661, 3804.353259945816, 10615.0, 10847.457627118612, 10936.890631093587, 10945.343279403101, 10951.397673128055, 10873.782524349626, 10908.61819836302, 10919.181061420426, 10927.836082458769, 10963.890361096446, 7590.0, 7936.444448888637, 8098.31164351025, 8108.0, 8118.634661440131, 5616.943830561642, 5679.772809087755, 5727.914081288867, 5744.310682717934, 5922.763089476372, 9896.455694936847, 9962.402255864672, 10020.599176033169, 10200.897991020292, 10224.693259202237, 10003.199744020607, 10103.595856165672, 10338.914413986424, 10389.740256493647, 10397.740056498647, 7221.31397517235, 7350.816229594303, 7505.437092217996, 7615.619219039137, 7633.122190948112, 8153.6330865112395, 8333.333333333198, 8333.708320209005, 8334.708285209988, 8349.081601024003, 7283.672234749555, 7304.96347518259, 7324.780256592097, 7339.302766237199, 7347.632618368953, 6768.289329620319, 7037.929620703728, 7059.964700176466, 7066.717331306896, 7081.221065682874, 6700.497462690415, 6805.829854253683, 6820.04519367279, 6825.863482730417, 6849.589024658537, 4964.826231081895, 5105.988855858043, 5131.666441681279, 5233.502817232509, 5235.110031294766, 5141.511556402136, 5157.277981082727, 5237.476252374732, 5269.367675878919, 5279.102552565996], "value": 4648.66690877627, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.8936461816786, 348.372928728289, 353.57924070356273, 359.23662217787205, 359.7337969902273, 5548.611597188194, 5566.276384070075, 5573.749181286842, 5603.3836278009385, 5611.523020543248, 5525.834224973257, 5526.861828454291, 5544.77820887164, 5551.417101204376, 5574.526165275956, 4174.853880114204, 4258.850940217093, 4321.956780432202, 4325.82696692132, 4336.891577710551, 4304.784760761965, 4308.82764689412, 4310.0, 4321.524632290461, 4325.00524879278, 4233.428487154241, 4245.787710614472, 4255.893602659928, 4264.381664658623, 4292.463442069741, 4155.6883233757435, 4300.6774491913075, 4302.118065796504, 4322.222000039991, 4335.913281734379, 3828.578856325802, 3832.735197384884, 3834.7123965702685, 3836.846526138951, 3838.865639702597, 5394.244805727201, 5411.215373770781, 5416.58961762016, 5424.403315635277, 5438.782448702047, 4837.8306759263605, 4953.479884612136, 4978.327925730053, 4978.452370239271, 5029.522195391469, 5715.685637289947, 5772.595918285721, 5836.474717275466, 5847.736851841677, 5854.6194497357965, 4356.23572453157, 4360.21516127097, 4361.3457981302745, 4367.45406824147, 4367.803448844777, 5870.501007414375, 6029.879402411971, 6034.577579569432, 6058.273007239115, 6072.696365181723, 4418.5802348776815, 4424.159409712144, 4428.247197976351, 4430.800613972379, 4436.290193569013, 4500.527444618333, 4531.932021019687, 4535.206338890681, 4543.65922555803, 4546.727196368229, 4882.316475693406, 5019.222020586815, 5061.190209566452, 5063.392392912874, 5104.69371837691, 5813.895359881609, 5851.180834683148, 5857.0, 5873.916193998185, 5885.529157667376, 1488.3823213366331, 1494.2379386512957, 1495.3719437836135, 1509.4037855047413, 1513.8183417989912, 962.9855552166723, 991.4002028772633, 995.5370752599931, 997.850322451638, 1051.9158467322595, 5405.21624364465, 5450.291462109901, 5450.88256907333, 5452.509274165265, 5468.562514998791, 5840.240768700127, 5846.239988801429, 5857.4435428634215, 5859.212940053239, 5863.0, 5416.404195538487, 5439.809606663748, 5452.754626041838, 5621.4659607337235, 5666.348369937427, 3096.0, 3099.612548431446, 3111.6266048074376, 3112.2219445138717, 3138.6704396038544, 5996.580239383288, 6045.0, 6058.4244496772735, 6099.573029887954, 6111.174991376108, 6087.656252342791, 6155.599886007395, 6160.845978850564, 6168.691565421801, 6185.8144255672405, 6270.278917924497, 6287.811365659038, 6302.644931339784, 6310.779122730591, 6389.776357827547, 6009.429104235091, 6045.335013148638, 6062.909056364247, 6072.210612620331, 6079.848003799941, 6005.0, 6013.609115407485, 6025.8192254232445, 6033.276006879202, 6034.366391529002, 6051.848703782441, 6205.131281620667, 6232.407921247474, 6350.523710721622, 6365.8726825464155, 4355.564443555619, 4376.6717496187275, 4403.3174857897075, 4429.247028005311, 4432.911341773211, 6086.69566521681, 6096.451319381277, 6102.755889764359, 6118.0, 6143.569950103629, 5840.532757379485, 5848.0, 5849.61977471463, 5863.208466857091, 5863.677497737494, 5846.6784326862435, 5874.265716785402, 5889.676067816311, 5900.173975643327, 5926.140709597171, 5676.744546495335, 5823.272090988627, 5896.380880007538, 5911.793087241926, 5955.434233747787, 5876.059830427112, 5889.5582831286965, 5906.173135761082, 5911.793087241926, 5923.851903702442, 5736.0, 5761.308642962871, 5765.0, 5772.39389864075, 5823.854403639943], "value": 4478.982477152036, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.1251073690099, 735.9816004599887, 745.9813504662385, 788.8974433323671, 811.6753298680524, 13754.381052852621, 14600.12399256044, 14684.0, 14713.632159196026, 14742.115473071597, 12740.681482962931, 12873.549425770076, 12898.80651790224, 12904.74190516189, 12952.870471295284, 791.8891355210275, 798.9520628762264, 808.9878651820227, 826.6610689617258, 855.9572021398936, 620.8447888027993, 627.1846599420735, 629.2574761781119, 634.1122428599974, 642.5341627320203, 848.1942154952819, 855.7646647172046, 856.1866227084264, 858.7767180533044, 867.301822033263, 826.0459169659053, 828.0684230240948, 849.7365816596874, 853.8676505141651, 859.2782063067023, 621.2203684376125, 626.937306269374, 629.5844742469993, 629.9779507717253, 630.5460068750492, 13489.988250881222, 13560.796588051187, 13656.24890631015, 13784.517541886085, 13784.862151378458, 13264.0, 13623.795643065361, 13985.230812305319, 14278.714425711427, 14387.424503019867, 11689.240199387013, 11837.230580012272, 11883.168178227528, 11891.345975971319, 12218.816717749241, 3752.3620984432714, 3756.6806821420214, 3845.403962385835, 3861.555921069085, 3925.2934471795065, 65556.67221663908, 65830.0, 66073.0, 66609.0, 66694.66652666754, 10374.740631484274, 10447.84328235077, 10583.57665693379, 10642.946785266024, 10677.466126693635, 19833.404997850088, 19853.404397868086, 19858.0, 19897.403077907686, 19947.102380392917, 7723.111842138226, 7782.221777822172, 7833.451658383972, 8116.6347514362, 8279.875801862976, 4500.684952053325, 4526.999895896825, 4622.6301895848255, 4644.210484217691, 4725.881852953635, 3275.0993476793597, 3380.8478618462227, 3389.4576867701544, 3391.1861153323025, 3430.073880052372, 593.5902232198529, 601.0923505506717, 601.7683191971123, 604.241676695744, 605.9666718330534, 626.2172284644195, 628.3025841316136, 698.2249702829855, 705.9435245180373, 714.2464699741719, 8538.53038082899, 8784.121587841164, 9200.769980750534, 9322.347435679572, 9791.510424478747, 591.9315635278278, 602.3976023976024, 661.0414898397343, 662.0797092042066, 664.1366223908899, 4288.8284468620905, 4486.439195100613, 4611.100835337144, 4623.583877451046, 4648.0, 56675.0, 70755.0, 82529.17470825335, 92859.0714092864, 96530.0, 68064.3193568068, 70051.0, 82114.58942705249, 83971.5801420989, 86479.0, 66310.0, 67973.66013170002, 68186.65906670435, 68919.65540172368, 68955.31044689489, 8880.0, 9085.001299714053, 9412.67055653049, 9829.901700982899, 9848.310618256939, 47118.76440617775, 47350.0, 47478.52521474741, 47580.2862957049, 48504.272435914194, 56403.02589409351, 64763.35236647573, 66102.33897661154, 66732.666336668, 67607.66196168988, 11905.761884762429, 12064.095192860746, 12140.453679584616, 12282.07884408655, 12419.93790031044, 13004.8049279259, 13559.322033898068, 13680.794788078387, 13733.793993090312, 13822.032457727862, 12651.240925544496, 12765.297908614744, 12827.679308017374, 13081.803772943604, 13116.606501804961, 10964.0, 11868.169228153947, 12316.568920087753, 12529.561465348668, 12909.806352904901, 11935.462904169159, 12336.136470446983, 12409.689757756129, 12612.87387126117, 12822.615321540368, 11650.708732281422, 11672.883271167519, 11946.104042196695, 12225.144239903477, 12251.816222756845, 10345.586176552853, 10545.31455455393, 11052.723681908017, 11307.886921130683, 11387.089032877515], "value": 7004.180565735673, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 111.0, 112.0, 111.0, 112.0, 112.0, 110.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 118.0, 146.0, 121.0, 119.0, 117.0, 123.0, 148.0, 117.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 164.0, 162.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 79.0, 111.0, 75.0, 76.0, 75.0, 81.0, 96.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 114.0, 81.0, 81.0, 80.0, 91.0, 80.0, 82.0, 103.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 85.0, 86.0, 85.0, 84.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 59.0, 54.0, 54.0, 54.0, 56.0, 54.0, 59.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 61.0, 60.0, 60.0, 58.0, 59.0, 60.0, 61.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 78.0, 75.0, 81.0, 75.0, 75.0, 76.0, 75.0, 75.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 126.0, 122.0, 132.0, 121.0, 124.0, 120.0, 165.0, 133.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 158.0, 163.0, 159.0, 155.0, 159.0, 154.0, 153.0, 156.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 63.0, 61.0, 61.0, 62.0, 62.0, 62.0, 60.0, 67.0], "value": 62.7, "unit": "score"}]}]} 10:07:01 INFO - Return code: 0 10:07:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:07:01 ERROR - # TBPL SUCCESS # 10:07:01 INFO - Running post-action listener: _resource_record_post_action 10:07:01 INFO - [mozharness: 2017-02-10 18:07:01.764757Z] Finished run-tests step (success) 10:07:01 INFO - Running post-run listener: _resource_record_post_run 10:07:01 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321478656; Read time: 28; Write time: 329836 10:07:01 INFO - TinderboxPrint: CPU usage
13.2% 10:07:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 10:07:01 INFO - TinderboxPrint: I/O write bytes / time
321,478,656 / 329,836 10:07:01 INFO - TinderboxPrint: CPU idle
8,219.0 (86.8%) 10:07:01 INFO - TinderboxPrint: CPU user
1,199.2 (12.7%) 10:07:01 INFO - TinderboxPrint: Swap in / out
0 / 0 10:07:01 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 99078144; Read time: 0; Write time: 148328 10:07:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222400512; Read time: 28; Write time: 181508 10:07:02 INFO - Running post-run listener: _upload_blobber_files 10:07:02 INFO - Blob upload gear active. 10:07:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:07:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:07:02 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'] 10:07:02 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 10:07:02 INFO - (blobuploader) - INFO - Open directory for files ... 10:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:06 INFO - (blobuploader) - INFO - Done attempting. 10:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:07 INFO - (blobuploader) - INFO - Done attempting. 10:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:07 INFO - (blobuploader) - INFO - Done attempting. 10:07:07 INFO - (blobuploader) - INFO - Iteration through files over. 10:07:07 INFO - Return code: 0 10:07:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:07:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:07:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/472a4090f70609de4034eec062acddbb2e4d0bc063ea0ddae55f884283b7729af81681a60a1e613363d18801d0c6c11118685503443ed56c9d446b709c36b362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0216ce37e058ce14d971d4e628645bbba3960798c3842c5c57c71b774980185b4b07ebbd8abc8ed737736a6ddd923a8b580056e7634d8f6ffee035a1f41b08fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba229d0d34752ab1ecdc3f67db295afe5b274e886eaa574b312ca870e38a00fbd647cfbb2953b0c450fb8dc050be6fb4ac8750f2bff1fcd5e14b9a569723a421"} 10:07:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:07:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:07:07 INFO - Contents: 10:07:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/472a4090f70609de4034eec062acddbb2e4d0bc063ea0ddae55f884283b7729af81681a60a1e613363d18801d0c6c11118685503443ed56c9d446b709c36b362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0216ce37e058ce14d971d4e628645bbba3960798c3842c5c57c71b774980185b4b07ebbd8abc8ed737736a6ddd923a8b580056e7634d8f6ffee035a1f41b08fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba229d0d34752ab1ecdc3f67db295afe5b274e886eaa574b312ca870e38a00fbd647cfbb2953b0c450fb8dc050be6fb4ac8750f2bff1fcd5e14b9a569723a421"} 10:07:07 INFO - Running post-run listener: copy_logs_to_upload_dir 10:07:07 INFO - Copying logs to upload dir... 10:07:07 INFO - mkdir: /builds/slave/test/build/upload/logs 10:07:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.863869 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-10 10:07:07.545150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 10:07:07.548506) ========= 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=5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/472a4090f70609de4034eec062acddbb2e4d0bc063ea0ddae55f884283b7729af81681a60a1e613363d18801d0c6c11118685503443ed56c9d446b709c36b362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0216ce37e058ce14d971d4e628645bbba3960798c3842c5c57c71b774980185b4b07ebbd8abc8ed737736a6ddd923a8b580056e7634d8f6ffee035a1f41b08fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba229d0d34752ab1ecdc3f67db295afe5b274e886eaa574b312ca870e38a00fbd647cfbb2953b0c450fb8dc050be6fb4ac8750f2bff1fcd5e14b9a569723a421"} build_url:https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/bEDfe_CdTdqE-ucyr3cV4g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/472a4090f70609de4034eec062acddbb2e4d0bc063ea0ddae55f884283b7729af81681a60a1e613363d18801d0c6c11118685503443ed56c9d446b709c36b362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0216ce37e058ce14d971d4e628645bbba3960798c3842c5c57c71b774980185b4b07ebbd8abc8ed737736a6ddd923a8b580056e7634d8f6ffee035a1f41b08fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba229d0d34752ab1ecdc3f67db295afe5b274e886eaa574b312ca870e38a00fbd647cfbb2953b0c450fb8dc050be6fb4ac8750f2bff1fcd5e14b9a569723a421"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 10:07:07.574202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:07:07.574579) ========= 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=5bd038846534b2fdfa68eeae000001e2-1486748788.46337-1513039426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:07:07.661880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 10:07:07.662267) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 10:07:07.662668) ========= ========= Total master_lag: 0.18 =========