builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1479460210.72 results: success (0) buildid: 20161117223003 builduid: 12d95591269b480cbdd74c3a2fd1f04c revision: 28e2a6dde76ab6ad4464a3662df1bd57af04398a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:10.717239) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:10.717767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:10.718082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:10.735440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:10.735741) ========= 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=32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 01:10:10-- 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% 222M=0s 2016-11-18 01:10:11 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134117 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:10.890647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:10.890936) ========= 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=32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014062 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:10.949649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 01:10:10.949957) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 28e2a6dde76ab6ad4464a3662df1bd57af04398a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 28e2a6dde76ab6ad4464a3662df1bd57af04398a --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=32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 01:10:11,197 truncating revision to first 12 chars 2016-11-18 01:10:11,197 Setting DEBUG logging. 2016-11-18 01:10:11,197 attempt 1/10 2016-11-18 01:10:11,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/28e2a6dde76a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 01:10:12,501 unpacking tar archive at: mozilla-central-28e2a6dde76a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.645171 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 01:10:12.608165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:12.608501) ========= script_repo_revision: 28e2a6dde76ab6ad4464a3662df1bd57af04398a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:12.608943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:12.609237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 01:10:12.616943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-18 01:10:12.617238) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:10:12 INFO - MultiFileLogger online at 20161118 01:10:12 in /builds/slave/test 01:10:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:10:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:10:12 INFO - {'append_to_log': False, 01:10:12 INFO - 'base_work_dir': '/builds/slave/test', 01:10:12 INFO - 'blob_upload_branch': 'Firefox', 01:10:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:10:12 INFO - 'branch': 'Firefox', 01:10:12 INFO - 'buildbot_json_path': 'buildprops.json', 01:10:12 INFO - 'config_files': ('talos/linux_config.py',), 01:10:12 INFO - 'default_actions': ('clobber', 01:10:12 INFO - 'read-buildbot-config', 01:10:12 INFO - 'download-and-extract', 01:10:12 INFO - 'populate-webroot', 01:10:12 INFO - 'create-virtualenv', 01:10:12 INFO - 'install', 01:10:12 INFO - 'run-tests'), 01:10:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:10:12 INFO - 'download_minidump_stackwalk': True, 01:10:12 INFO - 'download_symbols': 'ondemand', 01:10:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:10:12 INFO - 'tooltool.py': '/tools/tooltool.py', 01:10:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:10:12 INFO - '/tools/misc-python/virtualenv.py')}, 01:10:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:10:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:10:12 INFO - 'installer_path': 'installer.exe', 01:10:12 INFO - 'log_level': 'info', 01:10:12 INFO - 'log_name': 'talos', 01:10:12 INFO - 'log_to_console': True, 01:10:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:10:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:10:12 INFO - 'opt_config_files': (), 01:10:12 INFO - 'pip_index': False, 01:10:12 INFO - 'sps_profile': False, 01:10:12 INFO - 'sps_profile_interval': 0, 01:10:12 INFO - 'suite': 'dromaeojs', 01:10:12 INFO - 'system_bits': '32', 01:10:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:10:12 INFO - 'title': 'talos-linux64-ix-008', 01:10:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:10:12 INFO - 'use_talos_json': True, 01:10:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:10:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:10:12 INFO - 'work_dir': 'build'} 01:10:12 INFO - [mozharness: 2016-11-18 09:10:12.957152Z] Running clobber step. 01:10:12 INFO - Running pre-action listener: _resource_record_pre_action 01:10:12 INFO - Running main action method: clobber 01:10:12 INFO - rmtree: /builds/slave/test/build 01:10:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:10:13 INFO - Running post-action listener: _resource_record_post_action 01:10:13 INFO - [mozharness: 2016-11-18 09:10:13.941608Z] Finished clobber step (success) 01:10:13 INFO - [mozharness: 2016-11-18 09:10:13.941705Z] Running read-buildbot-config step. 01:10:13 INFO - Running pre-action listener: _resource_record_pre_action 01:10:13 INFO - Running main action method: read_buildbot_config 01:10:13 INFO - Using buildbot properties: 01:10:13 INFO - { 01:10:13 INFO - "project": "", 01:10:13 INFO - "product": "firefox", 01:10:13 INFO - "script_repo_revision": "production", 01:10:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:10:13 INFO - "repository": "", 01:10:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:10:13 INFO - "buildid": "20161117223003", 01:10:13 INFO - "pgo_build": "True", 01:10:13 INFO - "basedir": "/builds/slave/test", 01:10:13 INFO - "buildnumber": 90, 01:10:13 INFO - "slavename": "talos-linux64-ix-008", 01:10:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:10:13 INFO - "platform": "ubuntu64_hw", 01:10:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:10:13 INFO - "branch": "mozilla-central", 01:10:13 INFO - "repo_path": "mozilla-central", 01:10:13 INFO - "revision": "28e2a6dde76ab6ad4464a3662df1bd57af04398a", 01:10:13 INFO - "stage_platform": "linux64-pgo", 01:10:13 INFO - "builduid": "12d95591269b480cbdd74c3a2fd1f04c", 01:10:13 INFO - "slavebuilddir": "test" 01:10:13 INFO - } 01:10:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 01:10:13 INFO - Running post-action listener: _resource_record_post_action 01:10:13 INFO - [mozharness: 2016-11-18 09:10:13.944115Z] Finished read-buildbot-config step (success) 01:10:13 INFO - [mozharness: 2016-11-18 09:10:13.944204Z] Running download-and-extract step. 01:10:13 INFO - Running pre-action listener: _resource_record_pre_action 01:10:13 INFO - Running main action method: download_and_extract 01:10:13 INFO - mkdir: /builds/slave/test/build/tests 01:10: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')]} 01:10:13 INFO - trying https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:10:13 INFO - Downloading https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:10:14 INFO - Downloaded 1361 bytes. 01:10:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:10:14 INFO - Using the following test package requirements: 01:10:14 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:10:14 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:10:14 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:10:14 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:14 INFO - u'jsshell-linux-x86_64.zip'], 01:10:14 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:10:14 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:10:14 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:10:14 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:10:14 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:10:14 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:10:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:10:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:10:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:10:14 INFO - Fetch https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:10:15 INFO - Http code: 200 01:10:15 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 01:10:15 INFO - x-amz-cf-id: HIWrHmaZebMubDQ0f7Ja7aMW0aSOnbnYz1wdUOWoYCjNKWa4owXQlw== 01:10:15 INFO - x-amz-version-id: Z0FnjrG5fOxHn.05s4zxjti4XITQZo9N 01:10:15 INFO - Expected file size: 21864792 01:10:15 INFO - Obtained file size: 21864792 01:10:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:10:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:10:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:10:19 INFO - Fetch https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:10:20 INFO - Http code: 200 01:10:20 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 01:10:20 INFO - x-amz-cf-id: pFX9dO3WNgYwq7vqiyQQk47PCJvWJHGXlWmQu2wFqlY8-bSSQWRCJA== 01:10:20 INFO - x-amz-version-id: Z0FnjrG5fOxHn.05s4zxjti4XITQZo9N 01:10:20 INFO - Expected file size: 21864792 01:10:20 INFO - Obtained file size: 21864792 01:10:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 01:10:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:10:24 INFO - Fetch https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:10:25 INFO - Http code: 200 01:10:25 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 01:10:25 INFO - x-amz-cf-id: g8neNsY04kyQcG-556xGGF7D4wXDGxGW5RNdp5EgZFMCoofrrEJ5zA== 01:10:25 INFO - x-amz-version-id: jxvMe9TQmQlo3Yh3q1OF.0ANP7oOxrXD 01:10:25 INFO - Expected file size: 14409392 01:10:25 INFO - Obtained file size: 14409392 01:10:25 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')]} 01:10:25 INFO - trying https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:10:25 INFO - Downloading https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:10:27 INFO - Downloaded 59583067 bytes. 01:10:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:10:27 INFO - mkdir: /builds/slave/test/properties 01:10:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:10:27 INFO - Writing to file /builds/slave/test/properties/build_url 01:10:27 INFO - Contents: 01:10:27 INFO - build_url:https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:10:27 INFO - Running post-action listener: _resource_record_post_action 01:10:27 INFO - Running post-action listener: set_extra_try_arguments 01:10:27 INFO - [mozharness: 2016-11-18 09:10:27.717820Z] Finished download-and-extract step (success) 01:10:27 INFO - [mozharness: 2016-11-18 09:10:27.718047Z] Running populate-webroot step. 01:10:27 INFO - Running pre-action listener: _resource_record_pre_action 01:10:27 INFO - Running main action method: populate_webroot 01:10:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:10:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:10:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:10:27 INFO - '--tppagecycles', 01:10:27 INFO - '7'], 01:10:27 INFO - 'tests': ['tsvgm']}}, 01:10:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:10:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:10:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:10:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:10:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:10:27 INFO - 'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:10:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:10:27 INFO - 'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['damp', 'tps']}, 01:10:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:10:27 INFO - 'tests': ['damp', 'tps']}, 01:10:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['dromaeo_dom']}, 01:10:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:10:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['basic_compositor_video']}, 01:10:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:10:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['a11yr', 01:10:27 INFO - 'ts_paint', 01:10:27 INFO - 'tpaint', 01:10:27 INFO - 'sessionrestore', 01:10:27 INFO - 'sessionrestore_no_auto_restore', 01:10:27 INFO - 'tabpaint']}, 01:10:27 INFO - 'other-e10s': {'tests': ['a11yr', 01:10:27 INFO - 'ts_paint', 01:10:27 INFO - 'tpaint', 01:10:27 INFO - 'sessionrestore', 01:10:27 INFO - 'sessionrestore_no_auto_restore', 01:10:27 INFO - 'tabpaint']}, 01:10:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:10:27 INFO - 'ts_paint', 01:10:27 INFO - 'tpaint', 01:10:27 INFO - 'sessionrestore', 01:10:27 INFO - 'sessionrestore_no_auto_restore', 01:10:27 INFO - 'tabpaint']}, 01:10:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:10:27 INFO - 'ts_paint', 01:10:27 INFO - 'tpaint', 01:10:27 INFO - 'sessionrestore', 01:10:27 INFO - 'sessionrestore_no_auto_restore', 01:10:27 INFO - 'tabpaint']}, 01:10:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['a11yr', 01:10:27 INFO - 'ts_paint', 01:10:27 INFO - 'tpaint', 01:10:27 INFO - 'sessionrestore', 01:10:27 INFO - 'sessionrestore_no_auto_restore', 01:10:27 INFO - 'tabpaint']}, 01:10:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['a11yr', 01:10:27 INFO - 'ts_paint', 01:10:27 INFO - 'tpaint', 01:10:27 INFO - 'sessionrestore', 01:10:27 INFO - 'sessionrestore_no_auto_restore', 01:10:27 INFO - 'tabpaint']}, 01:10:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['tsvgx', 01:10:27 INFO - 'tsvgr_opacity', 01:10:27 INFO - 'tart', 01:10:27 INFO - 'tscrollx', 01:10:27 INFO - 'cart']}, 01:10:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:10:27 INFO - 'tsvgr_opacity', 01:10:27 INFO - 'tart', 01:10:27 INFO - 'tscrollx', 01:10:27 INFO - 'cart']}, 01:10:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:10:27 INFO - 'talos_options': ['--disable-e10s'], 01:10:27 INFO - 'tests': ['tp5o']}, 01:10:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:10:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:10:27 INFO - 'talos_options': ['--disable-e10s', 01:10:27 INFO - '--xperf_path', 01:10:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:27 INFO - 'tests': ['tp5n']}, 01:10:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:10:27 INFO - 'talos_options': ['--xperf_path', 01:10:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:27 INFO - 'tests': ['tp5n']}}, 01:10:27 INFO - 'talos.zip': {'path': '', 01:10:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:10:27 INFO - Running post-action listener: _resource_record_post_action 01:10:27 INFO - [mozharness: 2016-11-18 09:10:27.735210Z] Finished populate-webroot step (success) 01:10:27 INFO - [mozharness: 2016-11-18 09:10:27.735297Z] Running create-virtualenv step. 01:10:27 INFO - Running pre-action listener: _resource_record_pre_action 01:10:27 INFO - Running main action method: create_virtualenv 01:10:27 INFO - Creating virtualenv /builds/slave/test/build/venv 01:10:27 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 01:10:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:10:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:10:27 INFO - Using real prefix '/usr' 01:10:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:10:28 INFO - Installing distribute.............................................................................................................................................................................................done. 01:10:30 INFO - Installing pip.................done. 01:10:30 INFO - Return code: 0 01:10:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:10:30 INFO - Reading from file tmpfile_stdout 01:10:30 INFO - Output received: 01:10:30 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) 01:10:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:10:30 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')]} 01:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:30 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')]} 01:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:30 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:30 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 01:10:30 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 01:10:30 INFO - Using env: {'DISPLAY': ':0', 01:10:30 INFO - 'HOME': '/home/cltbld', 01:10:30 INFO - 'LANG': 'en_US.UTF-8', 01:10:30 INFO - 'LANGUAGE': 'en_US:en', 01:10:30 INFO - 'LOGNAME': 'cltbld', 01:10:30 INFO - 'MAIL': '/var/mail/cltbld', 01:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:30 INFO - 'MOZ_NO_REMOTE': '1', 01:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:30 INFO - 'NO_EM_RESTART': '1', 01:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:30 INFO - 'PWD': '/builds/slave/test', 01:10:30 INFO - 'SHELL': '/bin/bash', 01:10:30 INFO - 'SHLVL': '1', 01:10:30 INFO - 'TERM': 'linux', 01:10:30 INFO - 'TMOUT': '86400', 01:10:30 INFO - 'USER': 'cltbld', 01:10:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:30 INFO - '_': '/tools/buildbot/bin/python'} 01:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:30 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 01:10:30 INFO - Cleaning up... 01:10:30 INFO - Return code: 0 01:10:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:10:30 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')]} 01:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:30 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')]} 01:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:30 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:30 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 01:10:30 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 01:10:30 INFO - Using env: {'DISPLAY': ':0', 01:10:30 INFO - 'HOME': '/home/cltbld', 01:10:30 INFO - 'LANG': 'en_US.UTF-8', 01:10:30 INFO - 'LANGUAGE': 'en_US:en', 01:10:30 INFO - 'LOGNAME': 'cltbld', 01:10:30 INFO - 'MAIL': '/var/mail/cltbld', 01:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:30 INFO - 'MOZ_NO_REMOTE': '1', 01:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:30 INFO - 'NO_EM_RESTART': '1', 01:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:30 INFO - 'PWD': '/builds/slave/test', 01:10:30 INFO - 'SHELL': '/bin/bash', 01:10:30 INFO - 'SHLVL': '1', 01:10:30 INFO - 'TERM': 'linux', 01:10:30 INFO - 'TMOUT': '86400', 01:10:30 INFO - 'USER': 'cltbld', 01:10:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:30 INFO - '_': '/tools/buildbot/bin/python'} 01:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:30 INFO - Downloading/unpacking psutil>=3.1.1 01:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:10:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:33 INFO - Installing collected packages: psutil 01:10:33 INFO - Running setup.py install for psutil 01:10:33 INFO - building 'psutil._psutil_linux' extension 01:10:33 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 01:10:33 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 01:10:33 INFO - building 'psutil._psutil_posix' extension 01:10:33 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 01:10:33 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 01:10:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:33 INFO - Successfully installed psutil 01:10:33 INFO - Cleaning up... 01:10:33 INFO - Return code: 0 01:10:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:10:33 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')]} 01:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:33 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')]} 01:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:33 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:33 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 01:10:33 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 01:10:33 INFO - Using env: {'DISPLAY': ':0', 01:10:33 INFO - 'HOME': '/home/cltbld', 01:10:33 INFO - 'LANG': 'en_US.UTF-8', 01:10:33 INFO - 'LANGUAGE': 'en_US:en', 01:10:33 INFO - 'LOGNAME': 'cltbld', 01:10:33 INFO - 'MAIL': '/var/mail/cltbld', 01:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:33 INFO - 'MOZ_NO_REMOTE': '1', 01:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:33 INFO - 'NO_EM_RESTART': '1', 01:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:33 INFO - 'PWD': '/builds/slave/test', 01:10:33 INFO - 'SHELL': '/bin/bash', 01:10:33 INFO - 'SHLVL': '1', 01:10:33 INFO - 'TERM': 'linux', 01:10:33 INFO - 'TMOUT': '86400', 01:10:33 INFO - 'USER': 'cltbld', 01:10:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:33 INFO - '_': '/tools/buildbot/bin/python'} 01:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:10:35 INFO - Installing collected packages: mozsystemmonitor 01:10:35 INFO - Running setup.py install for mozsystemmonitor 01:10:35 INFO - Successfully installed mozsystemmonitor 01:10:35 INFO - Cleaning up... 01:10:35 INFO - Return code: 0 01:10:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:35 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:35 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 01:10:35 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 01:10:35 INFO - Using env: {'DISPLAY': ':0', 01:10:35 INFO - 'HOME': '/home/cltbld', 01:10:35 INFO - 'LANG': 'en_US.UTF-8', 01:10:35 INFO - 'LANGUAGE': 'en_US:en', 01:10:35 INFO - 'LOGNAME': 'cltbld', 01:10:35 INFO - 'MAIL': '/var/mail/cltbld', 01:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:35 INFO - 'MOZ_NO_REMOTE': '1', 01:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:35 INFO - 'NO_EM_RESTART': '1', 01:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:35 INFO - 'PWD': '/builds/slave/test', 01:10:35 INFO - 'SHELL': '/bin/bash', 01:10:35 INFO - 'SHLVL': '1', 01:10:35 INFO - 'TERM': 'linux', 01:10:35 INFO - 'TMOUT': '86400', 01:10:35 INFO - 'USER': 'cltbld', 01:10:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:35 INFO - '_': '/tools/buildbot/bin/python'} 01:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:36 INFO - Downloading/unpacking jsonschema==2.5.1 01:10:36 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 01:10:36 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 01:10:36 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 01:10:36 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 01:10:36 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 01:10:36 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 01:10:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:10:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 INFO - Downloading functools32-3.2.3-2.tar.gz 01:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:10:38 INFO - warning: no files found matching '*.txt' 01:10:38 INFO - no previously-included directories found matching 'build' 01:10:38 INFO - no previously-included directories found matching 'dist' 01:10:38 INFO - no previously-included directories found matching '.git*' 01:10:38 INFO - Installing collected packages: jsonschema, functools32 01:10:38 INFO - Running setup.py install for functools32 01:10:38 INFO - warning: no files found matching '*.txt' 01:10:38 INFO - no previously-included directories found matching 'build' 01:10:38 INFO - no previously-included directories found matching 'dist' 01:10:38 INFO - no previously-included directories found matching '.git*' 01:10:38 INFO - Successfully installed jsonschema functools32 01:10:38 INFO - Cleaning up... 01:10:38 INFO - Return code: 0 01:10:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:38 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:38 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 01:10:38 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 01:10:38 INFO - Using env: {'DISPLAY': ':0', 01:10:38 INFO - 'HOME': '/home/cltbld', 01:10:38 INFO - 'LANG': 'en_US.UTF-8', 01:10:38 INFO - 'LANGUAGE': 'en_US:en', 01:10:38 INFO - 'LOGNAME': 'cltbld', 01:10:38 INFO - 'MAIL': '/var/mail/cltbld', 01:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:38 INFO - 'MOZ_NO_REMOTE': '1', 01:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:38 INFO - 'NO_EM_RESTART': '1', 01:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:38 INFO - 'PWD': '/builds/slave/test', 01:10:38 INFO - 'SHELL': '/bin/bash', 01:10:38 INFO - 'SHLVL': '1', 01:10:38 INFO - 'TERM': 'linux', 01:10:38 INFO - 'TMOUT': '86400', 01:10:38 INFO - 'USER': 'cltbld', 01:10:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:38 INFO - '_': '/tools/buildbot/bin/python'} 01:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:10:38 INFO - Cleaning up... 01:10:38 INFO - Return code: 0 01:10:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:38 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:38 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 01:10:38 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 01:10:38 INFO - Using env: {'DISPLAY': ':0', 01:10:38 INFO - 'HOME': '/home/cltbld', 01:10:38 INFO - 'LANG': 'en_US.UTF-8', 01:10:38 INFO - 'LANGUAGE': 'en_US:en', 01:10:38 INFO - 'LOGNAME': 'cltbld', 01:10:38 INFO - 'MAIL': '/var/mail/cltbld', 01:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:38 INFO - 'MOZ_NO_REMOTE': '1', 01:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:38 INFO - 'NO_EM_RESTART': '1', 01:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:38 INFO - 'PWD': '/builds/slave/test', 01:10:38 INFO - 'SHELL': '/bin/bash', 01:10:38 INFO - 'SHLVL': '1', 01:10:38 INFO - 'TERM': 'linux', 01:10:38 INFO - 'TMOUT': '86400', 01:10:38 INFO - 'USER': 'cltbld', 01:10:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:38 INFO - '_': '/tools/buildbot/bin/python'} 01:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:40 INFO - Downloading blobuploader-1.2.4.tar.gz 01:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:10:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:10:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:10:41 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 01:10:41 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 01:10:41 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 01:10:41 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 01:10:41 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 01:10:41 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 01:10:41 INFO - Downloading docopt-0.6.1.tar.gz 01:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:10:41 INFO - Installing collected packages: blobuploader, requests, docopt 01:10:41 INFO - Running setup.py install for blobuploader 01:10:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:10:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:10:41 INFO - Running setup.py install for requests 01:10:42 INFO - Running setup.py install for docopt 01:10:42 INFO - Successfully installed blobuploader requests docopt 01:10:42 INFO - Cleaning up... 01:10:42 INFO - Return code: 0 01:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:42 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:42 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 01:10:42 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 01:10:42 INFO - Using env: {'DISPLAY': ':0', 01:10:42 INFO - 'HOME': '/home/cltbld', 01:10:42 INFO - 'LANG': 'en_US.UTF-8', 01:10:42 INFO - 'LANGUAGE': 'en_US:en', 01:10:42 INFO - 'LOGNAME': 'cltbld', 01:10:42 INFO - 'MAIL': '/var/mail/cltbld', 01:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:42 INFO - 'MOZ_NO_REMOTE': '1', 01:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:42 INFO - 'NO_EM_RESTART': '1', 01:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:42 INFO - 'PWD': '/builds/slave/test', 01:10:42 INFO - 'SHELL': '/bin/bash', 01:10:42 INFO - 'SHLVL': '1', 01:10:42 INFO - 'TERM': 'linux', 01:10:42 INFO - 'TMOUT': '86400', 01:10:42 INFO - 'USER': 'cltbld', 01:10:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:42 INFO - '_': '/tools/buildbot/bin/python'} 01:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:42 INFO - Running setup.py (path:/tmp/pip-6hTEIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:42 INFO - Running setup.py (path:/tmp/pip-PeA44r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:42 INFO - Running setup.py (path:/tmp/pip-WmyfnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:42 INFO - Running setup.py (path:/tmp/pip-eR4Io5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:42 INFO - Running setup.py (path:/tmp/pip-dpkF1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:42 INFO - Running setup.py (path:/tmp/pip-o_eS2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:42 INFO - Running setup.py (path:/tmp/pip-34F1ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:43 INFO - Running setup.py (path:/tmp/pip-KTpoBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:43 INFO - Running setup.py (path:/tmp/pip-JFyq_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:43 INFO - Running setup.py (path:/tmp/pip-tVWgHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:43 INFO - Running setup.py (path:/tmp/pip-_IBEL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:43 INFO - Running setup.py (path:/tmp/pip-pUMC1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:43 INFO - Running setup.py (path:/tmp/pip-vXulZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:43 INFO - Running setup.py (path:/tmp/pip-ftaTaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:43 INFO - Running setup.py (path:/tmp/pip-TVHaAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:43 INFO - Running setup.py (path:/tmp/pip-N8JLgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:43 INFO - Running setup.py (path:/tmp/pip-I3pO0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:10:43 INFO - Running setup.py install for manifestparser 01:10:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:10:43 INFO - Running setup.py install for mozcrash 01:10:43 INFO - Running setup.py install for mozdebug 01:10:44 INFO - Running setup.py install for mozdevice 01:10:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozfile 01:10:44 INFO - Running setup.py install for mozhttpd 01:10:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozinfo 01:10:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozInstall 01:10:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozleak 01:10:44 INFO - Running setup.py install for mozlog 01:10:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for moznetwork 01:10:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozprocess 01:10:44 INFO - Running setup.py install for mozprofile 01:10:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:10:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:10:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:10:45 INFO - Running setup.py install for mozrunner 01:10:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:10:45 INFO - Running setup.py install for mozscreenshot 01:10:45 INFO - Running setup.py install for moztest 01:10:45 INFO - Running setup.py install for mozversion 01:10:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:10:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:10:45 INFO - Cleaning up... 01:10:45 INFO - Return code: 0 01:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:45 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')]} 01:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:45 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')]} 01:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:45 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:45 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 01:10:45 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 01:10:45 INFO - Using env: {'DISPLAY': ':0', 01:10:45 INFO - 'HOME': '/home/cltbld', 01:10:45 INFO - 'LANG': 'en_US.UTF-8', 01:10:45 INFO - 'LANGUAGE': 'en_US:en', 01:10:45 INFO - 'LOGNAME': 'cltbld', 01:10:45 INFO - 'MAIL': '/var/mail/cltbld', 01:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:45 INFO - 'MOZ_NO_REMOTE': '1', 01:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:45 INFO - 'NO_EM_RESTART': '1', 01:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:45 INFO - 'PWD': '/builds/slave/test', 01:10:45 INFO - 'SHELL': '/bin/bash', 01:10:45 INFO - 'SHLVL': '1', 01:10:45 INFO - 'TERM': 'linux', 01:10:45 INFO - 'TMOUT': '86400', 01:10:45 INFO - 'USER': 'cltbld', 01:10:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:45 INFO - '_': '/tools/buildbot/bin/python'} 01:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:45 INFO - Running setup.py (path:/tmp/pip-RTcgSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:45 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)) 01:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:45 INFO - Running setup.py (path:/tmp/pip-n8VlLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:45 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)) 01:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:45 INFO - Running setup.py (path:/tmp/pip-depJ4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:45 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)) 01:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:45 INFO - Running setup.py (path:/tmp/pip-opiw14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:46 INFO - Running setup.py (path:/tmp/pip-wuuNZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:46 INFO - Running setup.py (path:/tmp/pip-M17qpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:46 INFO - Running setup.py (path:/tmp/pip-0TdHaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:46 INFO - Running setup.py (path:/tmp/pip-CmxImW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:46 INFO - Running setup.py (path:/tmp/pip-f6YA3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:46 INFO - Running setup.py (path:/tmp/pip-8yb3zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:46 INFO - Running setup.py (path:/tmp/pip-pOP6YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:46 INFO - Running setup.py (path:/tmp/pip-Dn4Qaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:46 INFO - Running setup.py (path:/tmp/pip-QozSF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:46 INFO - Running setup.py (path:/tmp/pip-OtFvHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:46 INFO - Running setup.py (path:/tmp/pip-zni1SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:46 INFO - Running setup.py (path:/tmp/pip-Q4kijC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:46 INFO - Running setup.py (path:/tmp/pip-ADFBg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:46 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)) 01:10:46 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)) 01:10:46 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)) 01:10:46 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)) 01:10:46 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)) 01:10:46 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)) 01:10:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:10:47 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 01:10:47 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 01:10:47 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 01:10:47 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 01:10:47 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 01:10:47 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 01:10:48 INFO - Downloading blessings-1.6.tar.gz 01:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:10:49 INFO - Installing collected packages: blessings 01:10:49 INFO - Running setup.py install for blessings 01:10:49 INFO - Successfully installed blessings 01:10:49 INFO - Cleaning up... 01:10:49 INFO - Return code: 0 01:10:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:49 INFO - Reading from file tmpfile_stdout 01:10:49 INFO - Current package versions: 01:10:49 INFO - argparse == 1.2.1 01:10:49 INFO - blessings == 1.6 01:10:49 INFO - blobuploader == 1.2.4 01:10:49 INFO - docopt == 0.6.1 01:10:49 INFO - functools32 == 3.2.3-2 01:10:49 INFO - jsonschema == 2.5.1 01:10:49 INFO - manifestparser == 1.1 01:10:49 INFO - mozInstall == 1.12 01:10:49 INFO - mozcrash == 1.0 01:10:49 INFO - mozdebug == 0.1 01:10:49 INFO - mozdevice == 0.48 01:10:49 INFO - mozfile == 1.2 01:10:49 INFO - mozhttpd == 0.7 01:10:49 INFO - mozinfo == 0.9 01:10:49 INFO - mozleak == 0.1 01:10:49 INFO - mozlog == 3.4 01:10:49 INFO - moznetwork == 0.27 01:10:49 INFO - mozprocess == 0.23 01:10:49 INFO - mozprofile == 0.28 01:10:49 INFO - mozrunner == 6.13 01:10:49 INFO - mozscreenshot == 0.1 01:10:49 INFO - mozsystemmonitor == 0.3 01:10:49 INFO - moztest == 0.7 01:10:49 INFO - mozversion == 1.4 01:10:49 INFO - psutil == 3.1.1 01:10:49 INFO - requests == 1.2.3 01:10:49 INFO - wsgiref == 0.1.2 01:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:49 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:49 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 01:10:49 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 01:10:49 INFO - Using env: {'DISPLAY': ':0', 01:10:49 INFO - 'HOME': '/home/cltbld', 01:10:49 INFO - 'LANG': 'en_US.UTF-8', 01:10:49 INFO - 'LANGUAGE': 'en_US:en', 01:10:49 INFO - 'LOGNAME': 'cltbld', 01:10:49 INFO - 'MAIL': '/var/mail/cltbld', 01:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:49 INFO - 'MOZ_NO_REMOTE': '1', 01:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:49 INFO - 'NO_EM_RESTART': '1', 01:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:49 INFO - 'PWD': '/builds/slave/test', 01:10:49 INFO - 'SHELL': '/bin/bash', 01:10:49 INFO - 'SHLVL': '1', 01:10:49 INFO - 'TERM': 'linux', 01:10:49 INFO - 'TMOUT': '86400', 01:10:49 INFO - 'USER': 'cltbld', 01:10:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:49 INFO - '_': '/tools/buildbot/bin/python'} 01:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 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)) 01:10:49 INFO - Cleaning up... 01:10:49 INFO - Return code: 0 01:10:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:49 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 0x7fb8a2a5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, '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': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', '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 01:10:49 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 01:10:49 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 01:10:49 INFO - Using env: {'DISPLAY': ':0', 01:10:49 INFO - 'HOME': '/home/cltbld', 01:10:49 INFO - 'LANG': 'en_US.UTF-8', 01:10:49 INFO - 'LANGUAGE': 'en_US:en', 01:10:49 INFO - 'LOGNAME': 'cltbld', 01:10:49 INFO - 'MAIL': '/var/mail/cltbld', 01:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:49 INFO - 'MOZ_NO_REMOTE': '1', 01:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:49 INFO - 'NO_EM_RESTART': '1', 01:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:49 INFO - 'PWD': '/builds/slave/test', 01:10:49 INFO - 'SHELL': '/bin/bash', 01:10:49 INFO - 'SHLVL': '1', 01:10:49 INFO - 'TERM': 'linux', 01:10:49 INFO - 'TMOUT': '86400', 01:10:49 INFO - 'USER': 'cltbld', 01:10:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:49 INFO - '_': '/tools/buildbot/bin/python'} 01:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:10:49 INFO - Cleaning up... 01:10:49 INFO - Return code: 0 01:10:49 INFO - Running post-action listener: _resource_record_post_action 01:10:49 INFO - Running post-action listener: _start_resource_monitoring 01:10:49 INFO - Starting resource monitoring. 01:10:49 INFO - [mozharness: 2016-11-18 09:10:49.893358Z] Finished create-virtualenv step (success) 01:10:49 INFO - [mozharness: 2016-11-18 09:10:49.893824Z] Running install step. 01:10:49 INFO - Running pre-action listener: _resource_record_pre_action 01:10:49 INFO - Running main action method: install 01:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:50 INFO - Reading from file tmpfile_stdout 01:10:50 INFO - Detecting whether we're running mozinstall >=1.0... 01:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:10:50 INFO - Reading from file tmpfile_stdout 01:10:50 INFO - Output received: 01:10:50 INFO - Usage: mozinstall [options] installer 01:10:50 INFO - Options: 01:10:50 INFO - -h, --help show this help message and exit 01:10:50 INFO - -d DEST, --destination=DEST 01:10:50 INFO - Directory to install application into. [default: 01:10:50 INFO - "/builds/slave/test"] 01:10:50 INFO - --app=APP Application being installed. [default: firefox] 01:10:50 INFO - mkdir: /builds/slave/test/build/application 01:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:11:07 INFO - Reading from file tmpfile_stdout 01:11:07 INFO - Output received: 01:11:07 INFO - /builds/slave/test/build/application/firefox/firefox 01:11:07 INFO - Running post-action listener: _resource_record_post_action 01:11:07 INFO - [mozharness: 2016-11-18 09:11:07.091583Z] Finished install step (success) 01:11:07 INFO - [mozharness: 2016-11-18 09:11:07.091823Z] Running run-tests step. 01:11:07 INFO - Running pre-action listener: _resource_record_pre_action 01:11:07 INFO - Running main action method: run_tests 01:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:11:07 INFO - Python 2.7.3 01:11:07 INFO - Return code: 0 01:11:07 INFO - grabbing minidump binary from tooltool 01:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:11:07 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 0x1256fc0>, '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 0x1257ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:11:07 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 01:11:07 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 01:11:07 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 01:11:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:11:07 INFO - Return code: 0 01:11:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:11:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:11:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:11:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:11:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:11:07 INFO - Using env: {'DISPLAY': ':0', 01:11:07 INFO - 'HOME': '/home/cltbld', 01:11:07 INFO - 'LANG': 'en_US.UTF-8', 01:11:07 INFO - 'LANGUAGE': 'en_US:en', 01:11:07 INFO - 'LOGNAME': 'cltbld', 01:11:07 INFO - 'MAIL': '/var/mail/cltbld', 01:11:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:11:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:07 INFO - 'MOZ_NO_REMOTE': '1', 01:11:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:07 INFO - 'NO_EM_RESTART': '1', 01:11:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:07 INFO - 'PWD': '/builds/slave/test', 01:11:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:11:07 INFO - 'SHELL': '/bin/bash', 01:11:07 INFO - 'SHLVL': '1', 01:11:07 INFO - 'TERM': 'linux', 01:11:07 INFO - 'TMOUT': '86400', 01:11:07 INFO - 'USER': 'cltbld', 01:11:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758', 01:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:07 INFO - '_': '/tools/buildbot/bin/python'} 01:11:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:11:07 INFO - mozversion application_buildid: 20161117223003 01:11:07 INFO - mozversion application_changeset: 28e2a6dde76ab6ad4464a3662df1bd57af04398a 01:11:07 INFO - mozversion application_display_name: Nightly 01:11:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:11:07 INFO - mozversion application_name: Firefox 01:11:07 INFO - mozversion application_remotingname: firefox 01:11:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:11:07 INFO - mozversion application_vendor: Mozilla 01:11:07 INFO - mozversion application_version: 53.0a1 01:11:07 INFO - mozversion platform_buildid: 20161117223003 01:11:07 INFO - mozversion platform_changeset: 28e2a6dde76ab6ad4464a3662df1bd57af04398a 01:11:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:11:07 INFO - mozversion platform_version: 53.0a1 01:11:07 INFO - using testdate: 1479460267 01:11:07 INFO - actual date: 1479460267 01:11:07 INFO - starting webserver on 'localhost:50273' 01:11:07 INFO - SUITE-START | Running 2 tests 01:11:07 INFO - TEST-START | dromaeo_css 01:11:07 INFO - operating with platform_type : linux_ 01:11:07 INFO - Initialising browser for dromaeo_css test... 01:11:07 INFO - TEST-INFO | started process 16746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPIPLLh/profile http://localhost:50273/getInfo.html) 01:11:11 INFO - PROCESS | 16746 | __metrics Screen width/height:1600/1200 01:11:11 INFO - PROCESS | 16746 | colorDepth:24 01:11:11 INFO - PROCESS | 16746 | Browser inner width/height: 1024/697 01:11:11 INFO - PROCESS | 16746 | __metrics 01:11:11 INFO - PROCESS | 16746 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:11:11 INFO - PROCESS | 16746 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:11:12 INFO - PROCESS | 16746 | console.error: PushService: 01:11:12 INFO - PROCESS | 16746 | stateChangeProcessEnqueue: Error transitioning state 01:11:12 INFO - PROCESS | 16746 | UnknownError 01:11:13 INFO - TEST-INFO | 16746: exit 0 01:11:13 INFO - Browser initialized. 01:11:13 INFO - Running cycle 1/1 for dromaeo_css test... 01:11:13 INFO - TEST-INFO | started process 16828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPIPLLh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:11:25 INFO - PROCESS | 16828 | RSS: Main: 173543424 01:11:25 INFO - PROCESS | 16828 | 01:12:16 INFO - PROCESS | 16828 | 1479460336797 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:14:26 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:50273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50273/tests/dromaeo/cssquery-ext.html) 01:14:29 INFO - PROCESS | 16828 | RSS: Main: 416333824 01:14:29 INFO - PROCESS | 16828 | 01:17:31 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:50273/tests/dromaeo/cssquery-ext.html (next: http://localhost:50273/tests/dromaeo/cssquery-jquery.html) 01:17:32 INFO - PROCESS | 16828 | RSS: Main: 281579520 01:17:32 INFO - PROCESS | 16828 | 01:20:34 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:50273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50273/tests/dromaeo/cssquery-mootools.html) 01:20:34 INFO - PROCESS | 16828 | RSS: Main: 224993280 01:20:34 INFO - PROCESS | 16828 | 01:23:36 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:50273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50273/tests/dromaeo/cssquery-prototype.html) 01:23:37 INFO - PROCESS | 16828 | RSS: Main: 254648320 01:23:37 INFO - PROCESS | 16828 | 01:26:40 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:50273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50273/tests/dromaeo/cssquery-yui.html) 01:26:40 INFO - PROCESS | 16828 | RSS: Main: 221073408 01:26:40 INFO - PROCESS | 16828 | 01:29:43 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:50273/tests/dromaeo/cssquery-yui.html (next: http://localhost:50273/tests/dromaeo/cssquery-dojo.html) 01:29:44 INFO - PROCESS | 16828 | RSS: Main: 312836096 01:29:44 INFO - PROCESS | 16828 | 01:29:44 INFO - PROCESS | 16828 | __start_tp_report 01:29:44 INFO - PROCESS | 16828 | _x_x_mozilla_page_load 01:29:44 INFO - PROCESS | 16828 | _x_x_mozilla_page_load_details 01:29:44 INFO - PROCESS | 16828 | |i|pagename|runs| 01:29:44 INFO - PROCESS | 16828 | |0;dojo.html;2944.8822047118115;2975.4049190161973;3003.0240171944124;3017.034548944339;3017.471942410079;5132.076226279269;5208.218767184915;5250.291210686561;5333.893322133555;5380.515753582182;5274.05067087924;5284.973575132129;5329.280547126146;5365.141577347626;5438.864028399292;4771.618270538366;4811.639127065467;4824.469308376076;4857.441394239655;4899.48555401683;4763.333133361332;4880.072786170616;4904.656674032819;4918.385201849769;4931.235658472942;4862.3922009748785;4870.561649451549;4871.951280487186;4936.284238785374;4954.108260513106;4633.397658304399;4664.416947881515;4673.182193116191;4810.06203790261;4834.516548345137;4843;4859.975700121477;4874.610031197496;4906.509349065101;4921.237208232729;5323.041852466555;5382.4886635769535;5391.379991301012;5393.487618676219;5405.27028851104;5453;5513.117901135839;5593.496585307342;5700.857478563028;5713.314402271712;5633.8591535211945;5715.428457154293;5716.771329146829;5725.055365864628;5745.08078707409;5305.973470132702;5307.814226502054;5309.840704778863;5313.628046036818;5315.441878602768;5815.273090863642;5820.748424605062;5829.708514574254;5834.299884013945;5842.036064049469;5325.893482130413;5439.374471935699;5577.470140336662;5627.634203776742;5636.943630563724;5707.857303567361;5753.798617048467;5758.3090029196765;5764.654120752768;5799.681017543991;5743.712814359265;5746.88506229873;5751.309842818889;5753.88492230153;5754.251947246915;5406.459354064562;5523.199136125239;5526.171074338881;5601.355844077983;5735.11105778605;4337.306031035019;4342.218400687906;4346.891327716832;4354.738715677069;4356.128774245164;3828.272628200633;3884.6309600587897;3891.8248678808955;3894.7078969077434;3943.073377756225;5423.3491980962535;5425.186222066722;5426.62013659048;5429.239906413105;5464.644798088111;5517.034518959246;5584.664920104807;5695.629784064023;5701.173329867229;5704.286964129484;5334.626576139633;5352;5400.756965936543;5424.83725488236;5470.835874923759;4886.584640305614;4892;4894.853154405374;4895.583875370633;4931.137051016058;5565.1374037024325;5947.613405128653;5951.28584569837;5958.463738263577;5959.821205363846;5491.313585801775;5544.22380866687;5570.888582228252;5571.916421253603;5574.581906356958;5710.828675139753;5752.338481074563;5758.481736643722;5765.221695071112;5770.2498675171955;5455.208994695668;5463.043967305785;5463.890722185613;5464.153056276284;5467.425920278313;5547.861303467445;5552.694601796778;5556.749946252509;5557.3331200256225;5558.138488534284;5511.917321240265;5529.198266251451;5531.751071201725;5535.225068490495;5535.308086489189;5527.8894422112135;5530.391656917816;5533.114701647717;5536.52939500147;5538.556915446835;5435.130379139318;5441.020616289106;5449.427810079885;5520.337559492887;5527.115661494142;5565.30433695788;5565.332160140809;5579.023670857665;5580.665160090408;5631.014572449887;5238.2404551340605;5317.654352467077;5392.946070539245;5422.864428389322;5460.290162278879 01:29:44 INFO - PROCESS | 16828 | |1;ext.html;577.7602295047556;587.5710731166247;593.4807043836643;600.1777564736312;602.7528713227578;39824.203515929665;41740.58259417405;41832.16335673288;45320.3201951971;45324.320135197995;43909.78045109778;44298.55701442985;44313.77843110788;44368.55631443684;44402.77798611002;7884.80287992799;8087.433879628428;8635.784105397352;8797.384183107186;8803.075677053914;10135.08784209421;10419;10422.374657520573;10724.517396717167;10725.35647861127;10548.578056877715;10632.627858024971;10634.096101831354;10634.521446534924;10644.254902156852;10508.894911050906;10516.737081572945;10523.052925236689;10550.103241224506;10561.683149505488;10265.127464165555;10330.690079297634;10333.638322658746;10333.79332413355;10346.689599311958;40818;41195.588044119475;41229.587704122874;41233.38149927754;41454;3400.2349471368743;3565.964340356615;3900.3564411872007;4008.9198216035516;4038.394240863894;29846;29933.550996735066;30437.543436848464;30528.694713052806;30647.38705225905;4188.979055104705;4318.762468064255;4349.195398851222;4522.62060071678;4534.342520334566;339734;339878;340945;341309.2934535336;343479;34265;35251.82374088164;57175.42824571784;57437.42562574404;57608.42391576031;37060.81469592635;37280;37335.4399684005;37348.25303493969;37377;13163.868361316456;13263.867361326264;13272.867271327355;13273.601791946257;13324.467021319038;9806;9965;10973.615923442641;11142.888571114185;11541;8492.787680308042;8507.27688146502;8530.763039359259;8590.226879580743;8598.570071496526;3323.6177839548764;3338.9666103338654;3351.631320554737;3364.798112113281;3395.0833275015607;1013.1489548779061;1021.5147804792813;1026.8049070676548;1147.1511081799408;1159.2928313728619;30433;30831.69168308288;31053.8447307762;31063.378732425226;31241.375172496424;1085.2945585369573;1112.3492756737237;1119.2780656476527;1132.8697199822127;1149.655103468956;15605.765913511306;16507.009579425034;16509.6698066038;16529;16622.168891555375;460675;461610;466539;467425;467752;56690.43309566934;56874.43125568691;56920.430795691515;56935.14597281044;57027.42972570304;1208.1784386617185;1236.9443375048145;1277.4890043982296;1323.0672375974723;1327.2368388176837;29115.41769164647;30833;31535.526967095055;31735.206619834687;32071.679283206868;48652.5134748648;49436.75281623569;49446.25830612472;49459;49509.75245123752;366858;367513;368745;369042;369559.30440695246;27577.310567235978;28503.857480712464;28517.287067823472;29519.85240073786;29816.552751709176;45883;46083.30875036944;46184.53815461802;46399.53600463952;46483;39007.414888776126;39255.214895701356;39332.410013850385;39391.80304098461;40972.38541421822;39075.413868791424;39211.6078839208;39353.2129357417;39565.20869582535;41017.58982410138;39402.60597393989;40136.197276054896;40576.98557536085;40635;40728.389074163315;32354.83822580872;34484.82757586196;34682.03505500266;35075;35571.466428003085;26328.47127884287;26674.866625666746;26798.330041749112;26932.596011060243;27241 01:29:44 INFO - PROCESS | 16828 | |2;jquery.html;376.25125999261445;387.09999251739697;396.4053919121319;397.7732692365352;423.66953776054686;13460.326983650815;15456.686181674557;16313.184340782973;18645.347412840554;18915.905420472915;18557.072146392693;18870.716939245922;18965.52586185346;19144.329948451807;19276.3253286135;5532.446755324476;5765.279340082489;5769.1923130761725;5770.7691692332255;5771.018926782457;4578.610818080467;6277.340879207663;6315.589486683374;6412.262589802162;6414.9679251603675;6169.876602467948;6296.307406185316;6385.042243663441;6435.163428754256;6440.838979025515;6234.625922444645;6260.40526150015;6267.4986001119805;6270.467010304107;6335.968320158393;5407.972960135214;5555.388907220203;5585.413531579207;5627.831165065014;5631.662100273997;20628.381148565568;21252.14991400342;21407.143714251568;22563;22744.886275568682;2252.8197744180425;2325.2094287942014;2562.3722188063857;2617.568101263308;2831.6602007758993;10642.361458312449;10881.945590271998;12825.230486170767;13833.79249311261;14049.43802247909;1884.6513395021964;1937.5059359863285;1968.7735910370347;2011.6379051770675;2094.1204694028393;76187.23812761856;79770.20229797743;80600.59699701464;80848;81195;9569.952150239344;9791.412515249107;9954.203663706887;10640.627578034731;10915.617953371753;14663.853361466463;14680.04579702316;14717.705645887236;14722.55832325032;14736.336864841109;7164.176119746296;7485.1017877855;7555.16893141754;7634.541927484369;7728.497647652997;7156.964215178891;7219.0976127984;7369.668364923591;7374.9262507375315;7379.557226566316;4209.915801683949;4332.913341733148;4345.565443455629;4378.868633940987;4432.977835110803;1855.2857149997349;1970.2808474906556;2008.9899550502155;2013.0941076515626;2030.9898450507653;852.5268475995758;893.829083900093;956.5695437053354;967.5500892085214;1002.2182697495965;16934.83065169357;17191.57021074458;17515.82484175142;18443.262269509338;19032.238710451427;946.4794363100405;997.1922742578535;1012.4178597306578;1026.650938680852;1057.5769692123058;9884.802303954024;10744.462776861126;11005.669829905115;11029.172812039129;11037.83443248352;482616;494080;500563;501314;507673;90701.54649226712;91354;91784.54107729418;91879.5406022979;93051.27794888128;1004.4525733475127;1029.4080903480378;1047.502436342731;1052.7736536644659;1059.5179193466954;16007.919960400124;16706.58233544171;16851.494455166365;17082.658346833243;17521;41745.16757404652;42285;42800.78599606982;43167.9208019802;44318;54774.72612636911;57071.71464142819;57504.424955749906;57592.136117959104;59321.70339148277;8154.673813047649;8410.201030902055;8507.23434890838;8560.529170895661;8786.121387861163;9591;11687.941560292484;12667.17663351916;12874.420651070912;12957.481700731865;11306.434678266218;11318.94340528292;11594.130440216848;11651.53393864236;11823.467943942715;10853.728656783644;11107.38909359993;11181.273217240854;11397;11482.712932176762;11192;11233.269837460539;11591.6522504325;11636.010939070275;12055.939720301343;8422.663093476192;8517.361197910306;8522.573871306535;8684.956575217084;8854.24738897201;10895.945520272347;11039.448027598748;11133.443327833738;11289.7742045157;11348.829767553329 01:29:44 INFO - PROCESS | 16828 | |3;mootools.html;1299.1360745104505;1436.3464623596265;1461.4300422835092;1560.6656308855927;1735.0457248513324;6719.764808231706;7712;7956.721514746985;7975.042994840613;8125.34997200224;7937.40469464791;8026.43814932955;8027.598620069002;8037.236462536064;8059.911911891908;2230.353197572702;2253.481699209183;2257.0745994142403;2259.548090381922;2264.2641141628956;2228.1310288987306;2291.8395712300144;2297.5634629420356;2298.5173113646156;2300.413394584387;2224.0992398078724;2244.394013616323;2253.5154941687533;2255.751867294596;2264.909403623853;2152.0853637204127;2161.146347192858;2181.0839447432118;2181.9563608727817;2182.508935489518;2195.7365116186;2202.570498752744;2211.259228158569;2218.9334319970426;2234.7988681018787;7931;8142.307903828182;8149.592520373958;8183.468074575193;8211.630476628567;4968.975155124237;5094;5099.413567439718;5101.15830887903;5105.489451054902;3314.419976504102;3344.0970937846887;3408.096854333579;3408.403529382348;3482.82585870708;1131.813250813623;1132.394169119517;1135.6593022093339;1136.5283407385925;1147.6040765935822;10969.506372213269;10971.83542246867;11019.393933333664;11037.227394082418;11039.116870650409;4064.7154699170774;4338.023944612437;4362.411074504901;4387.42963414754;4455.22033644111;8754.956225218833;8773.385862989657;8780.78048048804;8784.956075219583;8791;5018.397792264952;5019.29729837823;5023.09584274834;5027.069992051483;5033.295338652591;3877.7867217302755;4061.89845253871;4131.049858532554;4655.790489427984;4657.720536767804;3442.913927151791;3458.792472451661;3529.1177205698577;3547.5565554305713;3574.2315402188656;1085.7502774361942;1104.9392283424488;1130.8925652063042;1135.2223726747204;1139.1797905508022;945.7919257763281;950.7432993091827;953.3564843730454;959.0026372572586;968.331851022792;5428;5453.536449401845;5556.110922286442;5577.832665020056;5786.739596718157;464.5563486870031;467.63991726370506;471.8065593106878;476.12630822441207;484.98787530312023;3899.122697393064;3932.2135572885536;3971.543272523639;4039.313316736162;4280.743155410623;9682;10017.04838040385;10019.649312274036;10024.047715467019;10040.497975101362;10000.099991000845;10002.749931251778;10012.64955726546;10014.64948726791;10018.148457381058;7338.596377199306;7634.732784352521;7636.923630763732;7648.273414025659;7753.379729621617;5172.663776854492;5399.973000134974;5492.4507549246355;5555.138953462219;5564.38791732901;8848.601812918305;8872.600732967161;8900.77748056278;8942.50816205089;8960.820783584422;8610.612522436631;9152.17630413266;9259.814803704023;9275.489848058422;9301.162895339452;7347.963260183665;7620.961895190489;7625.084989801259;7628.80927976805;7633;7719.035120609924;7732.188120247293;7796.688132474637;7798.649060792164;7881.527108373516;6989.650517474208;7097.219305876246;7138.85722285541;7204.53170543913;7281.890771638324;6984.546004509691;6989.96505017492;7036.331548502884;7123.679434425567;7186.496945213785;6257.5932564383165;6414.583052101599;6454.806355809334;6556.639384833689;6558.868822623425;4690.366800481891;4752.287156926489;4802.255650374198;4843.200871856105;5029.371328583927;4666.78999445019;4748.62011039123;4849.151398505318;4908.214685650279;4909.4354149273295 01:29:44 INFO - PROCESS | 16828 | |4;prototype.html;327.129834639858;330.83954282173147;335.73141486810545;338.9593248810143;342.0695707675126;5072.797088116471;5146;5207.4271830098705;5208.166693329068;5227.294315267438;5043.546080852722;5156.3296771419755;5186.481351864812;5201.323827902367;5203.583713302936;4122.835086596532;4122.855700050499;4123.773192474413;4130.524989626194;4130.814113364906;3993.2429730918448;4087.305158123126;4121.5878412158845;4137.462129923106;4145.647619952308;4042.4138499917494;4052.371882358239;4053.169100334439;4065.6137666921595;4069.470968774055;4020.2160578687167;4037.636612704856;4043.2115737431213;4044.2720310344125;4049.8987525312104;3462.169079420946;3560.8219589020705;3569.464580312948;3589.8743543976097;3611.1513794258326;5048.545630893237;5051.873703157414;5066.923996140061;5071.518205770446;5080.644354895159;4651.651126165551;4675.270150044471;4676.438827340707;4677.345171675968;4694.554017368345;5244.265802787613;5332.120200166968;5344.182977787532;5436.809711660073;5458.4814442627885;3916.5104361954754;3923.2545816294814;3924.9018774530578;3958.0698535844053;3965.306071437487;5647.955128301236;5691.861627674441;5714.142903556361;5714.200011998323;5726.169705392695;3797.7531460454984;3978.5225772906856;3981.144054028398;3981.800909954549;3992.281389349887;4046.280330859432;4061.7766022869027;4069.877903662895;4072.8778136655947;4081.346984482528;4621.768911554409;4631.282151266559;4634;4653.557911998355;4665.580097791215;5227.424983251839;5463.972680136574;5470.835874923759;5473.261109750212;5532.5573954083575;1294.1199984010775;1320.4058173821818;1335.419092694681;1352.918824870511;1354.1671871798774;930.7021753039098;937.4562753602894;948.6584829461389;950.7813202963357;967.1923943507251;5017.623678224075;5039.4708555601865;5058.58359659296;5071.644984851025;5091.516305950929;5338.9466105339225;5388.568914486832;5422.91865622016;5435.7825686972865;5445.700486473203;4986.828095397579;5097.8725531861255;5145.482082785513;5148.3564554430695;5162.606096353963;2835.5463125899755;2838;2846.5730140479095;2854.3292326303304;2867.856607169633;5455.645383050089;5512.767329231668;5538.501534861882;5565.387807341189;5578.624931916213;5227.712475813791;5393.649412788156;5425.891482170335;5433.510984011379;5465.415029641439;5489.090781885607;5500.487365974389;5526.601140298768;5532.2891783026835;5562.72186390687;5179.663321884065;5335.493128152819;5339.395907762168;5387.946120538744;5400.081986062457;5243.213517972335;5252.080885845038;5254.238135470259;5285.867853303698;5300.204969254489;5492.752826122754;5508.63972976476;5530.889382212414;5565.38780734127;5573.331200255833;3760.266747984226;3903.863364782219;3918.451416801593;3918.589307849115;3930.292547341506;5312.946870531246;5319.920201197063;5323.6273460857365;5338.3593968724;5370.126982064577;5265.104562357472;5310.230016647642;5396.568274538106;5400.270963419888;5411.648242864201;5434.184872269191;5440.156775699773;5448.237246785374;5463.781448742165;5476.91784623223;5297.364316282071;5396.298481197419;5402.216678581505;5425.647332923348;5434.83695489136;5380.300560927054;5456.699881506555;5465.7813687453645;5469.316335458067;5476.3702174250475;5308.920366194433;5322.068637988414;5329.520343169133;5342.195347442624;5366.275552800478 01:29:44 INFO - PROCESS | 16828 | |5;yui.html;735.3565630073685;759.2976496740517;780.1101682298647;799.988000179997;804.8631732605456;13264.867351326484;13578.388972496237;13620.318984050808;13627.182369057851;13713.931430342847;13584.456621735118;13728.382222799974;13728.656783580416;13732;13739;658.6278752504843;673.6564352180399;758.7799538133935;768.8347005393839;781.8983532140813;784.5214419204281;793.4802704228711;798.3014861995754;799.5482552357928;799.9680012799511;797.6490344248512;799.0690845165375;799.3804801279026;799.8240387114826;802.1617409806737;678.1286047429055;695.0547255732225;792.1009654042646;819.9918000819976;822.321584692625;601.4106175947552;602.5300265792689;603.5714642603757;604.5556515960766;604.7188057553215;13887.236202008886;13930.094543854617;13939.303034848319;13943.860561394458;13970.441182352693;12652.114351995364;12767.74464510714;12919.935400323033;12925.870741292561;12955.870441295561;11536.480858361394;11645.126615503787;11749.94250517449;11793.528258869635;12136.332501712403;4190.937135942963;4370.344448332744;4373.562643735601;4426.690131690783;4442.466903971512;61788.38211617871;62493.37506624921;62730.68634656798;63578.36421635771;64393;9431.198348140348;9611.471369074769;9677.564509597085;9814.852777208347;10240.743981400525;17122.743158852627;17264.13679316029;17269.481915542554;17620.9118954407;17880;7473.775786726407;7739.845203096019;7800.765977020698;7818.709912864428;8103.027636683636;4564.360989461478;4602.217623004098;4603.723776573416;4760.880977975509;4776.235802271689;3077.4922137847007;3131.076332481923;3139.1367373971884;3163.066895265902;3173.0322251712987;544.0886515087213;558.3690429814284;560.6075746977132;569.703754047901;575.9625624334404;532.6005495878092;594.364030487383;609.1715267236555;639.6545865232722;666.3170250493283;8353.33173346131;8357.164283571716;8521.957390213132;8619.482831030158;8648.783780405414;552.0973208803636;573.8163787587932;634.0995785983914;680.1769858471206;682.754208484945;3927.3323534999117;4106.938395924063;4161.438205842233;4196.265653510623;4284.357346398066;70106.64946675234;85385.57307213548;85806.57096714477;88046;88374;66090.33909660939;67987;69246.65376673084;75691.86462203071;78444.2155578437;48402.75798620984;59522.70238648866;59735.701321493114;62203;62218.066728998194;8195.918040819515;8344.791380215544;8442.240198381929;8955.970063442526;9333.85999210026;36175.457368138974;41720.3741943865;46232.53767462282;47224.7638761804;48885.51114488809;59799.402005979384;61640.691796540734;62506.687466562376;62763.6861815688;65628.34371656222;11688.649340519798;11863.940680296888;11962.162648614514;12198.207116537396;12556.937215313865;13242.543320234574;13467.730645387233;13479.3934272956;13887.513937012156;14824.62938426548;12209.450574723982;12756.362181890683;12938.482460701467;13680.794788078387;13693.863061369259;12715.237085774883;12748.681282968;13462.663433414244;13466.19202847793;13484.05611607178;11404.600838970597;11670.358130302915;11966.162368634112;12152.270863748203;12292.877071229173;9510.762230944281;9742.75643108928;9774.657886973922;9900.25748068912;9951.402915825074;10198.541065652213;10566.894331056592;11056.226064175431;11106.167037472384;11297 01:29:44 INFO - PROCESS | 16828 | __end_tp_report 01:29:44 INFO - PROCESS | 16828 | __start_cc_report 01:29:44 INFO - PROCESS | 16828 | _x_x_mozilla_cycle_collect,2430 01:29:44 INFO - PROCESS | 16828 | __end_cc_report 01:29:44 INFO - PROCESS | 16828 | __startTimestamp1479461384186__endTimestamp 01:29:44 INFO - PROCESS | 16828 | 01:29:44 INFO - PROCESS | 16828 | ------- Summary: start ------- 01:29:44 INFO - PROCESS | 16828 | Number of tests: 6 01:29:44 INFO - PROCESS | 16828 | 01:29:44 INFO - PROCESS | 16828 | [#0] dojo.html Cycles:165 Average:5257.68 Median:5449.43 stddev:595.43 (10.9%) stddev-sans-first:568.94 01:29:44 INFO - PROCESS | 16828 | Values: 2944.9 2975.4 3003.0 3017.0 3017.5 5132.1 5208.2 5250.3 5333.9 5380.5 5274.1 5285.0 5329.3 5365.1 5438.9 4771.6 4811.6 4824.5 4857.4 4899.5 4763.3 4880.1 4904.7 4918.4 4931.2 4862.4 4870.6 4872.0 4936.3 4954.1 4633.4 4664.4 4673.2 4810.1 4834.5 4843.0 4860.0 4874.6 4906.5 4921.2 5323.0 5382.5 5391.4 5393.5 5405.3 5453.0 5513.1 5593.5 5700.9 5713.3 5633.9 5715.4 5716.8 5725.1 5745.1 5306.0 5307.8 5309.8 5313.6 5315.4 5815.3 5820.7 5829.7 5834.3 5842.0 5325.9 5439.4 5577.5 5627.6 5636.9 5707.9 5753.8 5758.3 5764.7 5799.7 5743.7 5746.9 5751.3 5753.9 5754.3 5406.5 5523.2 5526.2 5601.4 5735.1 4337.3 4342.2 4346.9 4354.7 4356.1 3828.3 3884.6 3891.8 3894.7 3943.1 5423.3 5425.2 5426.6 5429.2 5464.6 5517.0 5584.7 5695.6 5701.2 5704.3 5334.6 5352.0 5400.8 5424.8 5470.8 4886.6 4892.0 4894.9 4895.6 4931.1 5565.1 5947.6 5951.3 5958.5 5959.8 5491.3 5544.2 5570.9 5571.9 5574.6 5710.8 5752.3 5758.5 5765.2 5770.2 5455.2 5463.0 5463.9 5464.2 5467.4 5547.9 5552.7 5556.7 5557.3 5558.1 5511.9 5529.2 5531.8 5535.2 5535.3 5527.9 5530.4 5533.1 5536.5 5538.6 5435.1 5441.0 5449.4 5520.3 5527.1 5565.3 5565.3 5579.0 5580.7 5631.0 5238.2 5317.7 5392.9 5422.9 5460.3 01:29:44 INFO - PROCESS | 16828 | 01:29:44 INFO - PROCESS | 16828 | [#1] ext.html Cycles:180 Average:54364.58 Median:19568.72 stddev:104418.14 (533.6%) stddev-sans-first:104632.96 01:29:44 INFO - PROCESS | 16828 | Values: 577.8 587.6 593.5 600.2 602.8 39824.2 41740.6 41832.2 45320.3 45324.3 43909.8 44298.6 44313.8 44368.6 44402.8 7884.8 8087.4 8635.8 8797.4 8803.1 10135.1 10419.0 10422.4 10724.5 10725.4 10548.6 10632.6 10634.1 10634.5 10644.3 10508.9 10516.7 10523.1 10550.1 10561.7 10265.1 10330.7 10333.6 10333.8 10346.7 40818.0 41195.6 41229.6 41233.4 41454.0 3400.2 3566.0 3900.4 4008.9 4038.4 29846.0 29933.6 30437.5 30528.7 30647.4 4189.0 4318.8 4349.2 4522.6 4534.3 339734.0 339878.0 340945.0 341309.3 343479.0 34265.0 35251.8 57175.4 57437.4 57608.4 37060.8 37280.0 37335.4 37348.3 37377.0 13163.9 13263.9 13272.9 13273.6 13324.5 9806.0 9965.0 10973.6 11142.9 11541.0 8492.8 8507.3 8530.8 8590.2 8598.6 3323.6 3339.0 3351.6 3364.8 3395.1 1013.1 1021.5 1026.8 1147.2 1159.3 30433.0 30831.7 31053.8 31063.4 31241.4 1085.3 1112.3 1119.3 1132.9 1149.7 15605.8 16507.0 16509.7 16529.0 16622.2 460675.0 461610.0 466539.0 467425.0 467752.0 56690.4 56874.4 56920.4 56935.1 57027.4 1208.2 1236.9 1277.5 1323.1 1327.2 29115.4 30833.0 31535.5 31735.2 32071.7 48652.5 49436.8 49446.3 49459.0 49509.8 366858.0 367513.0 368745.0 369042.0 369559.3 27577.3 28503.9 28517.3 29519.9 29816.6 45883.0 46083.3 46184.5 46399.5 46483.0 39007.4 39255.2 39332.4 39391.8 40972.4 39075.4 39211.6 39353.2 39565.2 41017.6 39402.6 40136.2 40577.0 40635.0 40728.4 32354.8 34484.8 34682.0 35075.0 35571.5 26328.5 26674.9 26798.3 26932.6 27241.0 01:29:44 INFO - PROCESS | 16828 | 01:29:44 INFO - PROCESS | 16828 | [#2] jquery.html Cycles:180 Average:28949.33 Median:391.75 stddev:81961.31 (20921.7%) stddev-sans-first:82163.15 01:29:44 INFO - PROCESS | 16828 | Values: 376.3 387.1 396.4 397.8 423.7 13460.3 15456.7 16313.2 18645.3 18915.9 18557.1 18870.7 18965.5 19144.3 19276.3 5532.4 5765.3 5769.2 5770.8 5771.0 4578.6 6277.3 6315.6 6412.3 6415.0 6169.9 6296.3 6385.0 6435.2 6440.8 6234.6 6260.4 6267.5 6270.5 6336.0 5408.0 5555.4 5585.4 5627.8 5631.7 20628.4 21252.1 21407.1 22563.0 22744.9 2252.8 2325.2 2562.4 2617.6 2831.7 10642.4 10881.9 12825.2 13833.8 14049.4 1884.7 1937.5 1968.8 2011.6 2094.1 76187.2 79770.2 80600.6 80848.0 81195.0 9570.0 9791.4 9954.2 10640.6 10915.6 14663.9 14680.0 14717.7 14722.6 14736.3 7164.2 7485.1 7555.2 7634.5 7728.5 7157.0 7219.1 7369.7 7374.9 7379.6 4209.9 4332.9 4345.6 4378.9 4433.0 1855.3 1970.3 2009.0 2013.1 2031.0 852.5 893.8 956.6 967.6 1002.2 16934.8 17191.6 17515.8 18443.3 19032.2 946.5 997.2 1012.4 1026.7 1057.6 9884.8 10744.5 11005.7 11029.2 11037.8 482616.0 494080.0 500563.0 501314.0 507673.0 90701.5 91354.0 91784.5 91879.5 93051.3 1004.5 1029.4 1047.5 1052.8 1059.5 16007.9 16706.6 16851.5 17082.7 17521.0 41745.2 42285.0 42800.8 43167.9 44318.0 54774.7 57071.7 57504.4 57592.1 59321.7 8154.7 8410.2 8507.2 8560.5 8786.1 9591.0 11687.9 12667.2 12874.4 12957.5 11306.4 11318.9 11594.1 11651.5 11823.5 10853.7 11107.4 11181.3 11397.0 11482.7 11192.0 11233.3 11591.7 11636.0 12055.9 8422.7 8517.4 8522.6 8685.0 8854.2 10895.9 11039.4 11133.4 11289.8 11348.8 01:29:44 INFO - PROCESS | 16828 | 01:29:44 INFO - PROCESS | 16828 | [#3] mootools.html Cycles:180 Average:5328.93 Median:4878.68 stddev:2951.71 (60.5%) stddev-sans-first:2944.46 01:29:44 INFO - PROCESS | 16828 | Values: 1299.1 1436.3 1461.4 1560.7 1735.0 6719.8 7712.0 7956.7 7975.0 8125.3 7937.4 8026.4 8027.6 8037.2 8059.9 2230.4 2253.5 2257.1 2259.5 2264.3 2228.1 2291.8 2297.6 2298.5 2300.4 2224.1 2244.4 2253.5 2255.8 2264.9 2152.1 2161.1 2181.1 2182.0 2182.5 2195.7 2202.6 2211.3 2218.9 2234.8 7931.0 8142.3 8149.6 8183.5 8211.6 4969.0 5094.0 5099.4 5101.2 5105.5 3314.4 3344.1 3408.1 3408.4 3482.8 1131.8 1132.4 1135.7 1136.5 1147.6 10969.5 10971.8 11019.4 11037.2 11039.1 4064.7 4338.0 4362.4 4387.4 4455.2 8755.0 8773.4 8780.8 8785.0 8791.0 5018.4 5019.3 5023.1 5027.1 5033.3 3877.8 4061.9 4131.0 4655.8 4657.7 3442.9 3458.8 3529.1 3547.6 3574.2 1085.8 1104.9 1130.9 1135.2 1139.2 945.8 950.7 953.4 959.0 968.3 5428.0 5453.5 5556.1 5577.8 5786.7 464.6 467.6 471.8 476.1 485.0 3899.1 3932.2 3971.5 4039.3 4280.7 9682.0 10017.0 10019.6 10024.0 10040.5 10000.1 10002.7 10012.6 10014.6 10018.1 7338.6 7634.7 7636.9 7648.3 7753.4 5172.7 5400.0 5492.5 5555.1 5564.4 8848.6 8872.6 8900.8 8942.5 8960.8 8610.6 9152.2 9259.8 9275.5 9301.2 7348.0 7621.0 7625.1 7628.8 7633.0 7719.0 7732.2 7796.7 7798.6 7881.5 6989.7 7097.2 7138.9 7204.5 7281.9 6984.5 6990.0 7036.3 7123.7 7186.5 6257.6 6414.6 6454.8 6556.6 6558.9 4690.4 4752.3 4802.3 4843.2 5029.4 4666.8 4748.6 4849.2 4908.2 4909.4 01:29:44 INFO - PROCESS | 16828 | 01:29:44 INFO - PROCESS | 16828 | [#4] prototype.html Cycles:180 Average:4523.37 Median:5193.90 stddev:1309.13 (25.2%) stddev-sans-first:1274.36 01:29:44 INFO - PROCESS | 16828 | Values: 327.1 330.8 335.7 339.0 342.1 5072.8 5146.0 5207.4 5208.2 5227.3 5043.5 5156.3 5186.5 5201.3 5203.6 4122.8 4122.9 4123.8 4130.5 4130.8 3993.2 4087.3 4121.6 4137.5 4145.6 4042.4 4052.4 4053.2 4065.6 4069.5 4020.2 4037.6 4043.2 4044.3 4049.9 3462.2 3560.8 3569.5 3589.9 3611.2 5048.5 5051.9 5066.9 5071.5 5080.6 4651.7 4675.3 4676.4 4677.3 4694.6 5244.3 5332.1 5344.2 5436.8 5458.5 3916.5 3923.3 3924.9 3958.1 3965.3 5648.0 5691.9 5714.1 5714.2 5726.2 3797.8 3978.5 3981.1 3981.8 3992.3 4046.3 4061.8 4069.9 4072.9 4081.3 4621.8 4631.3 4634.0 4653.6 4665.6 5227.4 5464.0 5470.8 5473.3 5532.6 1294.1 1320.4 1335.4 1352.9 1354.2 930.7 937.5 948.7 950.8 967.2 5017.6 5039.5 5058.6 5071.6 5091.5 5338.9 5388.6 5422.9 5435.8 5445.7 4986.8 5097.9 5145.5 5148.4 5162.6 2835.5 2838.0 2846.6 2854.3 2867.9 5455.6 5512.8 5538.5 5565.4 5578.6 5227.7 5393.6 5425.9 5433.5 5465.4 5489.1 5500.5 5526.6 5532.3 5562.7 5179.7 5335.5 5339.4 5387.9 5400.1 5243.2 5252.1 5254.2 5285.9 5300.2 5492.8 5508.6 5530.9 5565.4 5573.3 3760.3 3903.9 3918.5 3918.6 3930.3 5312.9 5319.9 5323.6 5338.4 5370.1 5265.1 5310.2 5396.6 5400.3 5411.6 5434.2 5440.2 5448.2 5463.8 5476.9 5297.4 5396.3 5402.2 5425.6 5434.8 5380.3 5456.7 5465.8 5469.3 5476.4 5308.9 5322.1 5329.5 5342.2 5366.3 01:29:44 INFO - PROCESS | 16828 | 01:29:44 INFO - PROCESS | 16828 | [#5] yui.html Cycles:180 Average:16890.11 Median:559.49 stddev:22266.25 (3979.8%) stddev-sans-first:22295.67 01:29:44 INFO - PROCESS | 16828 | Values: 735.4 759.3 780.1 800.0 804.9 13264.9 13578.4 13620.3 13627.2 13713.9 13584.5 13728.4 13728.7 13732.0 13739.0 658.6 673.7 758.8 768.8 781.9 784.5 793.5 798.3 799.5 800.0 797.6 799.1 799.4 799.8 802.2 678.1 695.1 792.1 820.0 822.3 601.4 602.5 603.6 604.6 604.7 13887.2 13930.1 13939.3 13943.9 13970.4 12652.1 12767.7 12919.9 12925.9 12955.9 11536.5 11645.1 11749.9 11793.5 12136.3 4190.9 4370.3 4373.6 4426.7 4442.5 61788.4 62493.4 62730.7 63578.4 64393.0 9431.2 9611.5 9677.6 9814.9 10240.7 17122.7 17264.1 17269.5 17620.9 17880.0 7473.8 7739.8 7800.8 7818.7 8103.0 4564.4 4602.2 4603.7 4760.9 4776.2 3077.5 3131.1 3139.1 3163.1 3173.0 544.1 558.4 560.6 569.7 576.0 532.6 594.4 609.2 639.7 666.3 8353.3 8357.2 8522.0 8619.5 8648.8 552.1 573.8 634.1 680.2 682.8 3927.3 4106.9 4161.4 4196.3 4284.4 70106.6 85385.6 85806.6 88046.0 88374.0 66090.3 67987.0 69246.7 75691.9 78444.2 48402.8 59522.7 59735.7 62203.0 62218.1 8195.9 8344.8 8442.2 8956.0 9333.9 36175.5 41720.4 46232.5 47224.8 48885.5 59799.4 61640.7 62506.7 62763.7 65628.3 11688.6 11863.9 11962.2 12198.2 12556.9 13242.5 13467.7 13479.4 13887.5 14824.6 12209.5 12756.4 12938.5 13680.8 13693.9 12715.2 12748.7 13462.7 13466.2 13484.1 11404.6 11670.4 11966.2 12152.3 12292.9 9510.8 9742.8 9774.7 9900.3 9951.4 10198.5 10566.9 11056.2 11106.2 11297.0 01:29:44 INFO - PROCESS | 16828 | -------- Summary: end -------- 01:29:44 INFO - PROCESS | 16828 | 01:29:45 INFO - TEST-INFO | 16828: exit 0 01:29:45 INFO - TEST-OK | dromaeo_css | took 1117714ms 01:29:45 INFO - TEST-START | kraken 01:29:45 INFO - operating with platform_type : linux_ 01:29:45 INFO - Initialising browser for kraken test... 01:29:45 INFO - TEST-INFO | started process 17136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvobFno/profile http://localhost:50273/getInfo.html) 01:29:49 INFO - PROCESS | 17136 | __metrics Screen width/height:1600/1200 01:29:49 INFO - PROCESS | 17136 | colorDepth:24 01:29:49 INFO - PROCESS | 17136 | Browser inner width/height: 1024/697 01:29:49 INFO - PROCESS | 17136 | __metrics 01:29:49 INFO - PROCESS | 17136 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:29:49 INFO - PROCESS | 17136 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:29:50 INFO - PROCESS | 17136 | console.error: PushService: 01:29:50 INFO - PROCESS | 17136 | stateChangeProcessEnqueue: Error transitioning state 01:29:50 INFO - PROCESS | 17136 | UnknownError 01:29:51 INFO - TEST-INFO | 17136: exit 0 01:29:51 INFO - Browser initialized. 01:29:51 INFO - Running cycle 1/1 for kraken test... 01:29:51 INFO - TEST-INFO | started process 17219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvobFno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:30:03 INFO - PROCESS | 17219 | RSS: Main: 173813760 01:30:03 INFO - PROCESS | 17219 | 01:30:05 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50273/tests/kraken/driver.html?testName=audio-beat-detection) 01:30:06 INFO - PROCESS | 17219 | RSS: Main: 230748160 01:30:06 INFO - PROCESS | 17219 | 01:30:09 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50273/tests/kraken/driver.html?testName=audio-dft) 01:30:09 INFO - PROCESS | 17219 | RSS: Main: 216686592 01:30:09 INFO - PROCESS | 17219 | 01:30:12 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50273/tests/kraken/driver.html?testName=audio-fft) 01:30:13 INFO - PROCESS | 17219 | RSS: Main: 297590784 01:30:13 INFO - PROCESS | 17219 | 01:30:15 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50273/tests/kraken/driver.html?testName=audio-oscillator) 01:30:16 INFO - PROCESS | 17219 | RSS: Main: 209645568 01:30:16 INFO - PROCESS | 17219 | 01:30:18 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:30:18 INFO - PROCESS | 17219 | RSS: Main: 213442560 01:30:18 INFO - PROCESS | 17219 | 01:30:21 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50273/tests/kraken/driver.html?testName=imaging-darkroom) 01:30:22 INFO - PROCESS | 17219 | RSS: Main: 251314176 01:30:22 INFO - PROCESS | 17219 | 01:30:25 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50273/tests/kraken/driver.html?testName=imaging-desaturate) 01:30:26 INFO - PROCESS | 17219 | RSS: Main: 251944960 01:30:26 INFO - PROCESS | 17219 | 01:30:29 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50273/tests/kraken/driver.html?testName=json-parse-financial) 01:30:29 INFO - PROCESS | 17219 | RSS: Main: 251002880 01:30:29 INFO - PROCESS | 17219 | 01:30:31 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:30:31 INFO - PROCESS | 17219 | RSS: Main: 212901888 01:30:31 INFO - PROCESS | 17219 | 01:30:33 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50273/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:30:34 INFO - PROCESS | 17219 | RSS: Main: 221057024 01:30:34 INFO - PROCESS | 17219 | 01:30:36 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:30:36 INFO - PROCESS | 17219 | RSS: Main: 229670912 01:30:36 INFO - PROCESS | 17219 | 01:30:39 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:30:40 INFO - PROCESS | 17219 | RSS: Main: 231550976 01:30:40 INFO - PROCESS | 17219 | 01:30:43 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:30:43 INFO - PROCESS | 17219 | RSS: Main: 234205184 01:30:43 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | Cycle 1(1): loaded http://localhost:50273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50273/tests/kraken/driver.html?testName=ai-astar) 01:30:45 INFO - PROCESS | 17219 | RSS: Main: 283443200 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | __start_tp_report 01:30:45 INFO - PROCESS | 17219 | _x_x_mozilla_page_load 01:30:45 INFO - PROCESS | 17219 | _x_x_mozilla_page_load_details 01:30:45 INFO - PROCESS | 17219 | |i|pagename|runs| 01:30:45 INFO - PROCESS | 17219 | |0;ai-astar;104;113;111;113;113;114;113;113;114;113 01:30:45 INFO - PROCESS | 17219 | |1;audio-beat-detection;144;128;129;163;130;129;129;122;154;121 01:30:45 INFO - PROCESS | 17219 | |2;audio-dft;160;161;159;160;160;159;160;160;160;160 01:30:45 INFO - PROCESS | 17219 | |3;audio-fft;75;75;75;106;76;77;77;77;104;75 01:30:45 INFO - PROCESS | 17219 | |4;audio-oscillator;82;82;113;81;82;81;100;82;82;118 01:30:45 INFO - PROCESS | 17219 | |5;imaging-gaussian-blur;118;117;117;116;117;118;117;116;117;117 01:30:45 INFO - PROCESS | 17219 | |6;imaging-darkroom;146;147;146;145;146;146;147;146;146;147 01:30:45 INFO - PROCESS | 17219 | |7;imaging-desaturate;97;95;95;95;95;96;95;95;96;95 01:30:45 INFO - PROCESS | 17219 | |8;json-parse-financial;52;53;52;52;53;52;53;53;52;53 01:30:45 INFO - PROCESS | 17219 | |9;json-stringify-tinderbox;63;63;63;63;64;62;62;62;62;63 01:30:45 INFO - PROCESS | 17219 | |10;stanford-crypto-aes;81;80;87;80;81;79;81;81;80;80 01:30:45 INFO - PROCESS | 17219 | |11;stanford-crypto-ccm;135;135;142;132;131;131;142;131;178;145 01:30:45 INFO - PROCESS | 17219 | |12;stanford-crypto-pbkdf2;166;165;168;167;172;165;169;164;171;166 01:30:45 INFO - PROCESS | 17219 | |13;stanford-crypto-sha256-iterative;65;65;65;65;64;65;72;65;64;64 01:30:45 INFO - PROCESS | 17219 | __end_tp_report 01:30:45 INFO - PROCESS | 17219 | __start_cc_report 01:30:45 INFO - PROCESS | 17219 | _x_x_mozilla_cycle_collect,1667 01:30:45 INFO - PROCESS | 17219 | __end_cc_report 01:30:45 INFO - PROCESS | 17219 | __startTimestamp1479461445612__endTimestamp 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | ------- Summary: start ------- 01:30:45 INFO - PROCESS | 17219 | Number of tests: 14 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.96 (2.6%) stddev-sans-first:0.87 01:30:45 INFO - PROCESS | 17219 | Values: 104.0 113.0 111.0 113.0 113.0 114.0 113.0 113.0 114.0 113.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:129.50 stddev:14.04 (10.8%) stddev-sans-first:14.50 01:30:45 INFO - PROCESS | 17219 | Values: 144.0 128.0 129.0 163.0 130.0 129.0 129.0 122.0 154.0 121.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 01:30:45 INFO - PROCESS | 17219 | Values: 160.0 161.0 159.0 160.0 160.0 159.0 160.0 160.0 160.0 160.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:12.32 (16.3%) stddev-sans-first:12.83 01:30:45 INFO - PROCESS | 17219 | Values: 75.0 75.0 75.0 106.0 76.0 77.0 77.0 77.0 104.0 75.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:14.51 (17.7%) stddev-sans-first:15.07 01:30:45 INFO - PROCESS | 17219 | Values: 82.0 82.0 113.0 81.0 82.0 81.0 100.0 82.0 82.0 118.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 01:30:45 INFO - PROCESS | 17219 | Values: 118.0 117.0 117.0 116.0 117.0 118.0 117.0 116.0 117.0 117.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 01:30:45 INFO - PROCESS | 17219 | Values: 146.0 147.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 147.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 01:30:45 INFO - PROCESS | 17219 | Values: 97.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 01:30:45 INFO - PROCESS | 17219 | Values: 52.0 53.0 52.0 52.0 53.0 52.0 53.0 53.0 52.0 53.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 01:30:45 INFO - PROCESS | 17219 | Values: 63.0 63.0 63.0 63.0 64.0 62.0 62.0 62.0 62.0 63.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:2.21 (2.7%) stddev-sans-first:2.35 01:30:45 INFO - PROCESS | 17219 | Values: 81.0 80.0 87.0 80.0 81.0 79.0 81.0 81.0 80.0 80.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:138.50 stddev:14.27 (10.3%) stddev-sans-first:15.01 01:30:45 INFO - PROCESS | 17219 | Values: 135.0 135.0 142.0 132.0 131.0 131.0 142.0 131.0 178.0 145.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.50 stddev:2.67 (1.6%) stddev-sans-first:2.79 01:30:45 INFO - PROCESS | 17219 | Values: 166.0 165.0 168.0 167.0 172.0 165.0 169.0 164.0 171.0 166.0 01:30:45 INFO - PROCESS | 17219 | 01:30:45 INFO - PROCESS | 17219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:2.37 (3.6%) stddev-sans-first:2.51 01:30:45 INFO - PROCESS | 17219 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 72.0 65.0 64.0 64.0 01:30:45 INFO - PROCESS | 17219 | -------- Summary: end -------- 01:30:45 INFO - PROCESS | 17219 | 01:30:46 INFO - TEST-INFO | 17219: exit 0 01:30:46 INFO - TEST-OK | kraken | took 61700ms 01:30:46 INFO - SUITE-END | took 1179s 01:30:47 INFO - Completed test suite (00:19:39) 01:30:47 INFO - javascript benchmark 01:30:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2944.8822047118115, 2975.4049190161973, 3003.0240171944124, 3017.034548944339, 3017.471942410079, 5132.076226279269, 5208.218767184915, 5250.291210686561, 5333.893322133555, 5380.515753582182, 5274.05067087924, 5284.973575132129, 5329.280547126146, 5365.141577347626, 5438.864028399292, 4771.618270538366, 4811.639127065467, 4824.469308376076, 4857.441394239655, 4899.48555401683, 4763.333133361332, 4880.072786170616, 4904.656674032819, 4918.385201849769, 4931.235658472942, 4862.3922009748785, 4870.561649451549, 4871.951280487186, 4936.284238785374, 4954.108260513106, 4633.397658304399, 4664.416947881515, 4673.182193116191, 4810.06203790261, 4834.516548345137, 4843.0, 4859.975700121477, 4874.610031197496, 4906.509349065101, 4921.237208232729, 5323.041852466555, 5382.4886635769535, 5391.379991301012, 5393.487618676219, 5405.27028851104, 5453.0, 5513.117901135839, 5593.496585307342, 5700.857478563028, 5713.314402271712, 5633.8591535211945, 5715.428457154293, 5716.771329146829, 5725.055365864628, 5745.08078707409, 5305.973470132702, 5307.814226502054, 5309.840704778863, 5313.628046036818, 5315.441878602768, 5815.273090863642, 5820.748424605062, 5829.708514574254, 5834.299884013945, 5842.036064049469, 5325.893482130413, 5439.374471935699, 5577.470140336662, 5627.634203776742, 5636.943630563724, 5707.857303567361, 5753.798617048467, 5758.3090029196765, 5764.654120752768, 5799.681017543991, 5743.712814359265, 5746.88506229873, 5751.309842818889, 5753.88492230153, 5754.251947246915, 5406.459354064562, 5523.199136125239, 5526.171074338881, 5601.355844077983, 5735.11105778605, 4337.306031035019, 4342.218400687906, 4346.891327716832, 4354.738715677069, 4356.128774245164, 3828.272628200633, 3884.6309600587897, 3891.8248678808955, 3894.7078969077434, 3943.073377756225, 5423.3491980962535, 5425.186222066722, 5426.62013659048, 5429.239906413105, 5464.644798088111, 5517.034518959246, 5584.664920104807, 5695.629784064023, 5701.173329867229, 5704.286964129484, 5334.626576139633, 5352.0, 5400.756965936543, 5424.83725488236, 5470.835874923759, 4886.584640305614, 4892.0, 4894.853154405374, 4895.583875370633, 4931.137051016058, 5565.1374037024325, 5947.613405128653, 5951.28584569837, 5958.463738263577, 5959.821205363846, 5491.313585801775, 5544.22380866687, 5570.888582228252, 5571.916421253603, 5574.581906356958, 5710.828675139753, 5752.338481074563, 5758.481736643722, 5765.221695071112, 5770.2498675171955, 5455.208994695668, 5463.043967305785, 5463.890722185613, 5464.153056276284, 5467.425920278313, 5547.861303467445, 5552.694601796778, 5556.749946252509, 5557.3331200256225, 5558.138488534284, 5511.917321240265, 5529.198266251451, 5531.751071201725, 5535.225068490495, 5535.308086489189, 5527.8894422112135, 5530.391656917816, 5533.114701647717, 5536.52939500147, 5538.556915446835, 5435.130379139318, 5441.020616289106, 5449.427810079885, 5520.337559492887, 5527.115661494142, 5565.30433695788, 5565.332160140809, 5579.023670857665, 5580.665160090408, 5631.014572449887, 5238.2404551340605, 5317.654352467077, 5392.946070539245, 5422.864428389322, 5460.290162278879], "value": 5217.0365538519145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.7602295047556, 587.5710731166247, 593.4807043836643, 600.1777564736312, 602.7528713227578, 39824.203515929665, 41740.58259417405, 41832.16335673288, 45320.3201951971, 45324.320135197995, 43909.78045109778, 44298.55701442985, 44313.77843110788, 44368.55631443684, 44402.77798611002, 7884.80287992799, 8087.433879628428, 8635.784105397352, 8797.384183107186, 8803.075677053914, 10135.08784209421, 10419.0, 10422.374657520573, 10724.517396717167, 10725.35647861127, 10548.578056877715, 10632.627858024971, 10634.096101831354, 10634.521446534924, 10644.254902156852, 10508.894911050906, 10516.737081572945, 10523.052925236689, 10550.103241224506, 10561.683149505488, 10265.127464165555, 10330.690079297634, 10333.638322658746, 10333.79332413355, 10346.689599311958, 40818.0, 41195.588044119475, 41229.587704122874, 41233.38149927754, 41454.0, 3400.2349471368743, 3565.964340356615, 3900.3564411872007, 4008.9198216035516, 4038.394240863894, 29846.0, 29933.550996735066, 30437.543436848464, 30528.694713052806, 30647.38705225905, 4188.979055104705, 4318.762468064255, 4349.195398851222, 4522.62060071678, 4534.342520334566, 339734.0, 339878.0, 340945.0, 341309.2934535336, 343479.0, 34265.0, 35251.82374088164, 57175.42824571784, 57437.42562574404, 57608.42391576031, 37060.81469592635, 37280.0, 37335.4399684005, 37348.25303493969, 37377.0, 13163.868361316456, 13263.867361326264, 13272.867271327355, 13273.601791946257, 13324.467021319038, 9806.0, 9965.0, 10973.615923442641, 11142.888571114185, 11541.0, 8492.787680308042, 8507.27688146502, 8530.763039359259, 8590.226879580743, 8598.570071496526, 3323.6177839548764, 3338.9666103338654, 3351.631320554737, 3364.798112113281, 3395.0833275015607, 1013.1489548779061, 1021.5147804792813, 1026.8049070676548, 1147.1511081799408, 1159.2928313728619, 30433.0, 30831.69168308288, 31053.8447307762, 31063.378732425226, 31241.375172496424, 1085.2945585369573, 1112.3492756737237, 1119.2780656476527, 1132.8697199822127, 1149.655103468956, 15605.765913511306, 16507.009579425034, 16509.6698066038, 16529.0, 16622.168891555375, 460675.0, 461610.0, 466539.0, 467425.0, 467752.0, 56690.43309566934, 56874.43125568691, 56920.430795691515, 56935.14597281044, 57027.42972570304, 1208.1784386617185, 1236.9443375048145, 1277.4890043982296, 1323.0672375974723, 1327.2368388176837, 29115.41769164647, 30833.0, 31535.526967095055, 31735.206619834687, 32071.679283206868, 48652.5134748648, 49436.75281623569, 49446.25830612472, 49459.0, 49509.75245123752, 366858.0, 367513.0, 368745.0, 369042.0, 369559.30440695246, 27577.310567235978, 28503.857480712464, 28517.287067823472, 29519.85240073786, 29816.552751709176, 45883.0, 46083.30875036944, 46184.53815461802, 46399.53600463952, 46483.0, 39007.414888776126, 39255.214895701356, 39332.410013850385, 39391.80304098461, 40972.38541421822, 39075.413868791424, 39211.6078839208, 39353.2129357417, 39565.20869582535, 41017.58982410138, 39402.60597393989, 40136.197276054896, 40576.98557536085, 40635.0, 40728.389074163315, 32354.83822580872, 34484.82757586196, 34682.03505500266, 35075.0, 35571.466428003085, 26328.47127884287, 26674.866625666746, 26798.330041749112, 26932.596011060243, 27241.0], "value": 18629.34067346589, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.25125999261445, 387.09999251739697, 396.4053919121319, 397.7732692365352, 423.66953776054686, 13460.326983650815, 15456.686181674557, 16313.184340782973, 18645.347412840554, 18915.905420472915, 18557.072146392693, 18870.716939245922, 18965.52586185346, 19144.329948451807, 19276.3253286135, 5532.446755324476, 5765.279340082489, 5769.1923130761725, 5770.7691692332255, 5771.018926782457, 4578.610818080467, 6277.340879207663, 6315.589486683374, 6412.262589802162, 6414.9679251603675, 6169.876602467948, 6296.307406185316, 6385.042243663441, 6435.163428754256, 6440.838979025515, 6234.625922444645, 6260.40526150015, 6267.4986001119805, 6270.467010304107, 6335.968320158393, 5407.972960135214, 5555.388907220203, 5585.413531579207, 5627.831165065014, 5631.662100273997, 20628.381148565568, 21252.14991400342, 21407.143714251568, 22563.0, 22744.886275568682, 2252.8197744180425, 2325.2094287942014, 2562.3722188063857, 2617.568101263308, 2831.6602007758993, 10642.361458312449, 10881.945590271998, 12825.230486170767, 13833.79249311261, 14049.43802247909, 1884.6513395021964, 1937.5059359863285, 1968.7735910370347, 2011.6379051770675, 2094.1204694028393, 76187.23812761856, 79770.20229797743, 80600.59699701464, 80848.0, 81195.0, 9569.952150239344, 9791.412515249107, 9954.203663706887, 10640.627578034731, 10915.617953371753, 14663.853361466463, 14680.04579702316, 14717.705645887236, 14722.55832325032, 14736.336864841109, 7164.176119746296, 7485.1017877855, 7555.16893141754, 7634.541927484369, 7728.497647652997, 7156.964215178891, 7219.0976127984, 7369.668364923591, 7374.9262507375315, 7379.557226566316, 4209.915801683949, 4332.913341733148, 4345.565443455629, 4378.868633940987, 4432.977835110803, 1855.2857149997349, 1970.2808474906556, 2008.9899550502155, 2013.0941076515626, 2030.9898450507653, 852.5268475995758, 893.829083900093, 956.5695437053354, 967.5500892085214, 1002.2182697495965, 16934.83065169357, 17191.57021074458, 17515.82484175142, 18443.262269509338, 19032.238710451427, 946.4794363100405, 997.1922742578535, 1012.4178597306578, 1026.650938680852, 1057.5769692123058, 9884.802303954024, 10744.462776861126, 11005.669829905115, 11029.172812039129, 11037.83443248352, 482616.0, 494080.0, 500563.0, 501314.0, 507673.0, 90701.54649226712, 91354.0, 91784.54107729418, 91879.5406022979, 93051.27794888128, 1004.4525733475127, 1029.4080903480378, 1047.502436342731, 1052.7736536644659, 1059.5179193466954, 16007.919960400124, 16706.58233544171, 16851.494455166365, 17082.658346833243, 17521.0, 41745.16757404652, 42285.0, 42800.78599606982, 43167.9208019802, 44318.0, 54774.72612636911, 57071.71464142819, 57504.424955749906, 57592.136117959104, 59321.70339148277, 8154.673813047649, 8410.201030902055, 8507.23434890838, 8560.529170895661, 8786.121387861163, 9591.0, 11687.941560292484, 12667.17663351916, 12874.420651070912, 12957.481700731865, 11306.434678266218, 11318.94340528292, 11594.130440216848, 11651.53393864236, 11823.467943942715, 10853.728656783644, 11107.38909359993, 11181.273217240854, 11397.0, 11482.712932176762, 11192.0, 11233.269837460539, 11591.6522504325, 11636.010939070275, 12055.939720301343, 8422.663093476192, 8517.361197910306, 8522.573871306535, 8684.956575217084, 8854.24738897201, 10895.945520272347, 11039.448027598748, 11133.443327833738, 11289.7742045157, 11348.829767553329], "value": 9123.540660264372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.1360745104505, 1436.3464623596265, 1461.4300422835092, 1560.6656308855927, 1735.0457248513324, 6719.764808231706, 7712.0, 7956.721514746985, 7975.042994840613, 8125.34997200224, 7937.40469464791, 8026.43814932955, 8027.598620069002, 8037.236462536064, 8059.911911891908, 2230.353197572702, 2253.481699209183, 2257.0745994142403, 2259.548090381922, 2264.2641141628956, 2228.1310288987306, 2291.8395712300144, 2297.5634629420356, 2298.5173113646156, 2300.413394584387, 2224.0992398078724, 2244.394013616323, 2253.5154941687533, 2255.751867294596, 2264.909403623853, 2152.0853637204127, 2161.146347192858, 2181.0839447432118, 2181.9563608727817, 2182.508935489518, 2195.7365116186, 2202.570498752744, 2211.259228158569, 2218.9334319970426, 2234.7988681018787, 7931.0, 8142.307903828182, 8149.592520373958, 8183.468074575193, 8211.630476628567, 4968.975155124237, 5094.0, 5099.413567439718, 5101.15830887903, 5105.489451054902, 3314.419976504102, 3344.0970937846887, 3408.096854333579, 3408.403529382348, 3482.82585870708, 1131.813250813623, 1132.394169119517, 1135.6593022093339, 1136.5283407385925, 1147.6040765935822, 10969.506372213269, 10971.83542246867, 11019.393933333664, 11037.227394082418, 11039.116870650409, 4064.7154699170774, 4338.023944612437, 4362.411074504901, 4387.42963414754, 4455.22033644111, 8754.956225218833, 8773.385862989657, 8780.78048048804, 8784.956075219583, 8791.0, 5018.397792264952, 5019.29729837823, 5023.09584274834, 5027.069992051483, 5033.295338652591, 3877.7867217302755, 4061.89845253871, 4131.049858532554, 4655.790489427984, 4657.720536767804, 3442.913927151791, 3458.792472451661, 3529.1177205698577, 3547.5565554305713, 3574.2315402188656, 1085.7502774361942, 1104.9392283424488, 1130.8925652063042, 1135.2223726747204, 1139.1797905508022, 945.7919257763281, 950.7432993091827, 953.3564843730454, 959.0026372572586, 968.331851022792, 5428.0, 5453.536449401845, 5556.110922286442, 5577.832665020056, 5786.739596718157, 464.5563486870031, 467.63991726370506, 471.8065593106878, 476.12630822441207, 484.98787530312023, 3899.122697393064, 3932.2135572885536, 3971.543272523639, 4039.313316736162, 4280.743155410623, 9682.0, 10017.04838040385, 10019.649312274036, 10024.047715467019, 10040.497975101362, 10000.099991000845, 10002.749931251778, 10012.64955726546, 10014.64948726791, 10018.148457381058, 7338.596377199306, 7634.732784352521, 7636.923630763732, 7648.273414025659, 7753.379729621617, 5172.663776854492, 5399.973000134974, 5492.4507549246355, 5555.138953462219, 5564.38791732901, 8848.601812918305, 8872.600732967161, 8900.77748056278, 8942.50816205089, 8960.820783584422, 8610.612522436631, 9152.17630413266, 9259.814803704023, 9275.489848058422, 9301.162895339452, 7347.963260183665, 7620.961895190489, 7625.084989801259, 7628.80927976805, 7633.0, 7719.035120609924, 7732.188120247293, 7796.688132474637, 7798.649060792164, 7881.527108373516, 6989.650517474208, 7097.219305876246, 7138.85722285541, 7204.53170543913, 7281.890771638324, 6984.546004509691, 6989.96505017492, 7036.331548502884, 7123.679434425567, 7186.496945213785, 6257.5932564383165, 6414.583052101599, 6454.806355809334, 6556.639384833689, 6558.868822623425, 4690.366800481891, 4752.287156926489, 4802.255650374198, 4843.200871856105, 5029.371328583927, 4666.78999445019, 4748.62011039123, 4849.151398505318, 4908.214685650279, 4909.4354149273295], "value": 4254.682278186863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.129834639858, 330.83954282173147, 335.73141486810545, 338.9593248810143, 342.0695707675126, 5072.797088116471, 5146.0, 5207.4271830098705, 5208.166693329068, 5227.294315267438, 5043.546080852722, 5156.3296771419755, 5186.481351864812, 5201.323827902367, 5203.583713302936, 4122.835086596532, 4122.855700050499, 4123.773192474413, 4130.524989626194, 4130.814113364906, 3993.2429730918448, 4087.305158123126, 4121.5878412158845, 4137.462129923106, 4145.647619952308, 4042.4138499917494, 4052.371882358239, 4053.169100334439, 4065.6137666921595, 4069.470968774055, 4020.2160578687167, 4037.636612704856, 4043.2115737431213, 4044.2720310344125, 4049.8987525312104, 3462.169079420946, 3560.8219589020705, 3569.464580312948, 3589.8743543976097, 3611.1513794258326, 5048.545630893237, 5051.873703157414, 5066.923996140061, 5071.518205770446, 5080.644354895159, 4651.651126165551, 4675.270150044471, 4676.438827340707, 4677.345171675968, 4694.554017368345, 5244.265802787613, 5332.120200166968, 5344.182977787532, 5436.809711660073, 5458.4814442627885, 3916.5104361954754, 3923.2545816294814, 3924.9018774530578, 3958.0698535844053, 3965.306071437487, 5647.955128301236, 5691.861627674441, 5714.142903556361, 5714.200011998323, 5726.169705392695, 3797.7531460454984, 3978.5225772906856, 3981.144054028398, 3981.800909954549, 3992.281389349887, 4046.280330859432, 4061.7766022869027, 4069.877903662895, 4072.8778136655947, 4081.346984482528, 4621.768911554409, 4631.282151266559, 4634.0, 4653.557911998355, 4665.580097791215, 5227.424983251839, 5463.972680136574, 5470.835874923759, 5473.261109750212, 5532.5573954083575, 1294.1199984010775, 1320.4058173821818, 1335.419092694681, 1352.918824870511, 1354.1671871798774, 930.7021753039098, 937.4562753602894, 948.6584829461389, 950.7813202963357, 967.1923943507251, 5017.623678224075, 5039.4708555601865, 5058.58359659296, 5071.644984851025, 5091.516305950929, 5338.9466105339225, 5388.568914486832, 5422.91865622016, 5435.7825686972865, 5445.700486473203, 4986.828095397579, 5097.8725531861255, 5145.482082785513, 5148.3564554430695, 5162.606096353963, 2835.5463125899755, 2838.0, 2846.5730140479095, 2854.3292326303304, 2867.856607169633, 5455.645383050089, 5512.767329231668, 5538.501534861882, 5565.387807341189, 5578.624931916213, 5227.712475813791, 5393.649412788156, 5425.891482170335, 5433.510984011379, 5465.415029641439, 5489.090781885607, 5500.487365974389, 5526.601140298768, 5532.2891783026835, 5562.72186390687, 5179.663321884065, 5335.493128152819, 5339.395907762168, 5387.946120538744, 5400.081986062457, 5243.213517972335, 5252.080885845038, 5254.238135470259, 5285.867853303698, 5300.204969254489, 5492.752826122754, 5508.63972976476, 5530.889382212414, 5565.38780734127, 5573.331200255833, 3760.266747984226, 3903.863364782219, 3918.451416801593, 3918.589307849115, 3930.292547341506, 5312.946870531246, 5319.920201197063, 5323.6273460857365, 5338.3593968724, 5370.126982064577, 5265.104562357472, 5310.230016647642, 5396.568274538106, 5400.270963419888, 5411.648242864201, 5434.184872269191, 5440.156775699773, 5448.237246785374, 5463.781448742165, 5476.91784623223, 5297.364316282071, 5396.298481197419, 5402.216678581505, 5425.647332923348, 5434.83695489136, 5380.300560927054, 5456.699881506555, 5465.7813687453645, 5469.316335458067, 5476.3702174250475, 5308.920366194433, 5322.068637988414, 5329.520343169133, 5342.195347442624, 5366.275552800478], "value": 4108.608196637572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.3565630073685, 759.2976496740517, 780.1101682298647, 799.988000179997, 804.8631732605456, 13264.867351326484, 13578.388972496237, 13620.318984050808, 13627.182369057851, 13713.931430342847, 13584.456621735118, 13728.382222799974, 13728.656783580416, 13732.0, 13739.0, 658.6278752504843, 673.6564352180399, 758.7799538133935, 768.8347005393839, 781.8983532140813, 784.5214419204281, 793.4802704228711, 798.3014861995754, 799.5482552357928, 799.9680012799511, 797.6490344248512, 799.0690845165375, 799.3804801279026, 799.8240387114826, 802.1617409806737, 678.1286047429055, 695.0547255732225, 792.1009654042646, 819.9918000819976, 822.321584692625, 601.4106175947552, 602.5300265792689, 603.5714642603757, 604.5556515960766, 604.7188057553215, 13887.236202008886, 13930.094543854617, 13939.303034848319, 13943.860561394458, 13970.441182352693, 12652.114351995364, 12767.74464510714, 12919.935400323033, 12925.870741292561, 12955.870441295561, 11536.480858361394, 11645.126615503787, 11749.94250517449, 11793.528258869635, 12136.332501712403, 4190.937135942963, 4370.344448332744, 4373.562643735601, 4426.690131690783, 4442.466903971512, 61788.38211617871, 62493.37506624921, 62730.68634656798, 63578.36421635771, 64393.0, 9431.198348140348, 9611.471369074769, 9677.564509597085, 9814.852777208347, 10240.743981400525, 17122.743158852627, 17264.13679316029, 17269.481915542554, 17620.9118954407, 17880.0, 7473.775786726407, 7739.845203096019, 7800.765977020698, 7818.709912864428, 8103.027636683636, 4564.360989461478, 4602.217623004098, 4603.723776573416, 4760.880977975509, 4776.235802271689, 3077.4922137847007, 3131.076332481923, 3139.1367373971884, 3163.066895265902, 3173.0322251712987, 544.0886515087213, 558.3690429814284, 560.6075746977132, 569.703754047901, 575.9625624334404, 532.6005495878092, 594.364030487383, 609.1715267236555, 639.6545865232722, 666.3170250493283, 8353.33173346131, 8357.164283571716, 8521.957390213132, 8619.482831030158, 8648.783780405414, 552.0973208803636, 573.8163787587932, 634.0995785983914, 680.1769858471206, 682.754208484945, 3927.3323534999117, 4106.938395924063, 4161.438205842233, 4196.265653510623, 4284.357346398066, 70106.64946675234, 85385.57307213548, 85806.57096714477, 88046.0, 88374.0, 66090.33909660939, 67987.0, 69246.65376673084, 75691.86462203071, 78444.2155578437, 48402.75798620984, 59522.70238648866, 59735.701321493114, 62203.0, 62218.066728998194, 8195.918040819515, 8344.791380215544, 8442.240198381929, 8955.970063442526, 9333.85999210026, 36175.457368138974, 41720.3741943865, 46232.53767462282, 47224.7638761804, 48885.51114488809, 59799.402005979384, 61640.691796540734, 62506.687466562376, 62763.6861815688, 65628.34371656222, 11688.649340519798, 11863.940680296888, 11962.162648614514, 12198.207116537396, 12556.937215313865, 13242.543320234574, 13467.730645387233, 13479.3934272956, 13887.513937012156, 14824.62938426548, 12209.450574723982, 12756.362181890683, 12938.482460701467, 13680.794788078387, 13693.863061369259, 12715.237085774883, 12748.681282968, 13462.663433414244, 13466.19202847793, 13484.05611607178, 11404.600838970597, 11670.358130302915, 11966.162368634112, 12152.270863748203, 12292.877071229173, 9510.762230944281, 9742.75643108928, 9774.657886973922, 9900.25748068912, 9951.402915825074, 10198.541065652213, 10566.894331056592, 11056.226064175431, 11106.167037472384, 11297.0], "value": 6766.22073545605, "unit": "score"}], "name": "dromaeo_css", "value": 6867.361531318145, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 111.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 128.0, 129.0, 163.0, 130.0, 129.0, 129.0, 122.0, 154.0, 121.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 160.0, 159.0, 160.0, 160.0, 160.0, 160.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 106.0, 76.0, 77.0, 77.0, 77.0, 104.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 81.0, 82.0, 81.0, 100.0, 82.0, 82.0, 118.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 53.0, 52.0, 53.0, 53.0, 52.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 87.0, 80.0, 81.0, 79.0, 81.0, 81.0, 80.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 142.0, 132.0, 131.0, 131.0, 142.0, 131.0, 178.0, 145.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 168.0, 167.0, 172.0, 165.0, 169.0, 164.0, 171.0, 166.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 72.0, 65.0, 64.0, 64.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1506.6, "alertThreshold": 2.0}]} 01:30:47 INFO - Return code: 0 01:30:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:30:47 INFO - # TBPL SUCCESS # 01:30:47 INFO - Running post-action listener: _resource_record_post_action 01:30:47 INFO - [mozharness: 2016-11-18 09:30:47.410243Z] Finished run-tests step (success) 01:30:47 INFO - Running post-run listener: _resource_record_post_run 01:30:47 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 408756224; Read time: 24; Write time: 256448 01:30:47 INFO - TinderboxPrint: CPU usage
13.1% 01:30:47 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 01:30:47 INFO - TinderboxPrint: I/O write bytes / time
408,756,224 / 256,448 01:30:47 INFO - TinderboxPrint: CPU idle
8,300.4 (86.9%) 01:30:47 INFO - TinderboxPrint: CPU user
1,200.1 (12.6%) 01:30:47 INFO - TinderboxPrint: Swap in / out
0 / 0 01:30:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120528896; Read time: 0; Write time: 81000 01:30:47 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287870976; Read time: 12; Write time: 175448 01:30:48 INFO - Running post-run listener: _upload_blobber_files 01:30:48 INFO - Blob upload gear active. 01:30:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:30:48 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 01:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:30:48 INFO - (blobuploader) - INFO - Open directory for files ... 01:30:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:30:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:52 INFO - (blobuploader) - INFO - Done attempting. 01:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:53 INFO - (blobuploader) - INFO - Done attempting. 01:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:54 INFO - (blobuploader) - INFO - Done attempting. 01:30:54 INFO - (blobuploader) - INFO - Iteration through files over. 01:30:54 INFO - Return code: 0 01:30:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:30:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:30:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed1d718627e63342aa4e1cb9360cb6c969ad96503b33cde07ae1807e009f56615d43155077c5219a0aad6cf03e2827cfe5c1087080e51bd83e9249a885ffe312", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/628415251f9e597f6e5fa129afdc766786381677b9157bd3411adf1ecc3064e824e6bbc80f4eefe8b901f444681f25ea3ba522f1db5672edb55e2f82b279f539", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea357de21d81c862f1fa0fbf53230df51e324edc725e45f0106fe0ddf56dee11c47c0b252297993c9ddfd283d3be11adeef157b181b3328f37c79cdcfca5947f"} 01:30:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:30:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:30:54 INFO - Contents: 01:30:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed1d718627e63342aa4e1cb9360cb6c969ad96503b33cde07ae1807e009f56615d43155077c5219a0aad6cf03e2827cfe5c1087080e51bd83e9249a885ffe312", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/628415251f9e597f6e5fa129afdc766786381677b9157bd3411adf1ecc3064e824e6bbc80f4eefe8b901f444681f25ea3ba522f1db5672edb55e2f82b279f539", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea357de21d81c862f1fa0fbf53230df51e324edc725e45f0106fe0ddf56dee11c47c0b252297993c9ddfd283d3be11adeef157b181b3328f37c79cdcfca5947f"} 01:30:54 INFO - Running post-run listener: copy_logs_to_upload_dir 01:30:54 INFO - Copying logs to upload dir... 01:30:54 INFO - mkdir: /builds/slave/test/build/upload/logs 01:30:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.343621 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-18 01:30:54.205158) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 01:30:54.210004) ========= 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=32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed1d718627e63342aa4e1cb9360cb6c969ad96503b33cde07ae1807e009f56615d43155077c5219a0aad6cf03e2827cfe5c1087080e51bd83e9249a885ffe312", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/628415251f9e597f6e5fa129afdc766786381677b9157bd3411adf1ecc3064e824e6bbc80f4eefe8b901f444681f25ea3ba522f1db5672edb55e2f82b279f539", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea357de21d81c862f1fa0fbf53230df51e324edc725e45f0106fe0ddf56dee11c47c0b252297993c9ddfd283d3be11adeef157b181b3328f37c79cdcfca5947f"} build_url:https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011724 build_url: 'https://queue.taskcluster.net/v1/task/fv-OAdqCS8Sga9w5oaqVVw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed1d718627e63342aa4e1cb9360cb6c969ad96503b33cde07ae1807e009f56615d43155077c5219a0aad6cf03e2827cfe5c1087080e51bd83e9249a885ffe312", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/628415251f9e597f6e5fa129afdc766786381677b9157bd3411adf1ecc3064e824e6bbc80f4eefe8b901f444681f25ea3ba522f1db5672edb55e2f82b279f539", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea357de21d81c862f1fa0fbf53230df51e324edc725e45f0106fe0ddf56dee11c47c0b252297993c9ddfd283d3be11adeef157b181b3328f37c79cdcfca5947f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 01:30:54.238280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:30:54.238619) ========= 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=32c5991c409366f7fec8a718000001d2-1479459935.306327-1392685758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:30:54.288260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 01:30:54.291589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 01:30:54.291937) ========= ========= Total master_lag: 0.38 =========