builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1485244313.56 results: success (0) buildid: 20170123215943 builduid: cba516d785c94b9abc9d0e681f55ea8c revision: 7c6d7296c07d6df56a1f1a4a4861bb1e6f104c26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.563391) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.564203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.564517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.611450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.611783) ========= 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=1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-23 23:51:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 93.8M=0s 2017-01-23 23:51:53 (93.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102503 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.728366) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.728669) ========= 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=1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.779166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:53.779494) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7c6d7296c07d6df56a1f1a4a4861bb1e6f104c26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7c6d7296c07d6df56a1f1a4a4861bb1e6f104c26 --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=1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-23 23:51:53,918 truncating revision to first 12 chars 2017-01-23 23:51:53,918 Setting DEBUG logging. 2017-01-23 23:51:53,918 attempt 1/10 2017-01-23 23:51:53,918 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7c6d7296c07d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 23:51:54,617 unpacking tar archive at: mozilla-beta-7c6d7296c07d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.964517 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:54.758198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:54.758520) ========= script_repo_revision: 7c6d7296c07d6df56a1f1a4a4861bb1e6f104c26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:54.758923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:54.759185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:51:54.775983) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-23 23:51:54.776252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:51:55 INFO - MultiFileLogger online at 20170123 23:51:55 in /builds/slave/test 23:51:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:51:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:51:55 INFO - {'append_to_log': False, 23:51:55 INFO - 'base_work_dir': '/builds/slave/test', 23:51:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:51:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:51:55 INFO - 'branch': 'Mozilla-Beta', 23:51:55 INFO - 'buildbot_json_path': 'buildprops.json', 23:51:55 INFO - 'config_files': ('talos/linux_config.py',), 23:51:55 INFO - 'default_actions': ('clobber', 23:51:55 INFO - 'read-buildbot-config', 23:51:55 INFO - 'download-and-extract', 23:51:55 INFO - 'populate-webroot', 23:51:55 INFO - 'create-virtualenv', 23:51:55 INFO - 'install', 23:51:55 INFO - 'run-tests'), 23:51:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:51:55 INFO - 'download_minidump_stackwalk': True, 23:51:55 INFO - 'download_symbols': 'ondemand', 23:51:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:51:55 INFO - 'tooltool.py': '/tools/tooltool.py', 23:51:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:51:55 INFO - '/tools/misc-python/virtualenv.py')}, 23:51:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:51:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:51:55 INFO - 'installer_path': 'installer.exe', 23:51:55 INFO - 'log_level': 'info', 23:51:55 INFO - 'log_name': 'talos', 23:51:55 INFO - 'log_to_console': True, 23:51:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:51:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:51:55 INFO - 'opt_config_files': (), 23:51:55 INFO - 'pip_index': False, 23:51:55 INFO - 'sps_profile': False, 23:51:55 INFO - 'sps_profile_interval': 0, 23:51:55 INFO - 'suite': 'dromaeojs', 23:51:55 INFO - 'system_bits': '32', 23:51:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:51:55 INFO - 'title': 'talos-linux64-ix-027', 23:51:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:51:55 INFO - 'use_talos_json': True, 23:51:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:51:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:51:55 INFO - 'work_dir': 'build'} 23:51:55 INFO - [mozharness: 2017-01-24 07:51:55.008889Z] Running clobber step. 23:51:55 INFO - Running pre-action listener: _resource_record_pre_action 23:51:55 INFO - Running main action method: clobber 23:51:55 INFO - rmtree: /builds/slave/test/build 23:51:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:51:55 INFO - Running post-action listener: _resource_record_post_action 23:51:55 INFO - [mozharness: 2017-01-24 07:51:55.459201Z] Finished clobber step (success) 23:51:55 INFO - [mozharness: 2017-01-24 07:51:55.459301Z] Running read-buildbot-config step. 23:51:55 INFO - Running pre-action listener: _resource_record_pre_action 23:51:55 INFO - Running main action method: read_buildbot_config 23:51:55 INFO - Using buildbot properties: 23:51:55 INFO - { 23:51:55 INFO - "project": "", 23:51:55 INFO - "product": "firefox", 23:51:55 INFO - "script_repo_revision": "production", 23:51:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 23:51:55 INFO - "repository": "", 23:51:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 23:51:55 INFO - "buildid": "20170123215943", 23:51:55 INFO - "pgo_build": "True", 23:51:55 INFO - "basedir": "/builds/slave/test", 23:51:55 INFO - "buildnumber": 103, 23:51:55 INFO - "slavename": "talos-linux64-ix-027", 23:51:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:51:55 INFO - "platform": "ubuntu64_hw", 23:51:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:51:55 INFO - "branch": "mozilla-beta", 23:51:55 INFO - "repo_path": "releases/mozilla-beta", 23:51:55 INFO - "revision": "7c6d7296c07d6df56a1f1a4a4861bb1e6f104c26", 23:51:55 INFO - "stage_platform": "linux64-pgo", 23:51:55 INFO - "builduid": "cba516d785c94b9abc9d0e681f55ea8c", 23:51:55 INFO - "slavebuilddir": "test" 23:51:55 INFO - } 23:51:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 23:51:55 INFO - Running post-action listener: _resource_record_post_action 23:51:55 INFO - [mozharness: 2017-01-24 07:51:55.461905Z] Finished read-buildbot-config step (success) 23:51:55 INFO - [mozharness: 2017-01-24 07:51:55.461999Z] Running download-and-extract step. 23:51:55 INFO - Running pre-action listener: _resource_record_pre_action 23:51:55 INFO - Running main action method: download_and_extract 23:51:55 INFO - mkdir: /builds/slave/test/build/tests 23:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:51:55 INFO - trying https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:51:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:51:56 INFO - Downloaded 1327 bytes. 23:51:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:51:56 INFO - Using the following test package requirements: 23:51:56 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:51:56 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:51:56 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:51:56 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:51:56 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 23:51:56 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:51:56 INFO - u'jsshell-linux-x86_64.zip'], 23:51:56 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:51:56 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:51:56 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:51:56 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:51:56 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 23:51:56 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:51:56 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 23:51:56 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:51:56 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:51:56 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:51:56 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:51:56 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:51:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:51:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:51:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:51:56 INFO - Http code: 200 23:51:56 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 23:51:56 INFO - x-amz-cf-id: bTSaugl40ySNY7W1dNXBOfyY7pvob8jb5Iu1dV3DdGYzDfR31sx3oA== 23:51:56 INFO - x-amz-version-id: 7R7ApnDai_yRNkRuAdJ3NjEdpF1xZsKX 23:51:57 INFO - Expected file size: 21949519 23:51:57 INFO - Obtained file size: 21949519 23:52:01 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:52:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:52:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:52:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:52:02 INFO - Http code: 200 23:52:02 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 23:52:02 INFO - x-amz-cf-id: vusPXargW6tBDXKNuUx0-EYBI-7zeMv-qLnZywjE9tEKuOsw4KZIPQ== 23:52:02 INFO - x-amz-version-id: 7R7ApnDai_yRNkRuAdJ3NjEdpF1xZsKX 23:52:02 INFO - Expected file size: 21949519 23:52:02 INFO - Obtained file size: 21949519 23:52:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 23:52:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:52:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 23:52:07 INFO - Http code: 200 23:52:07 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 23:52:07 INFO - x-amz-cf-id: OL73B7a7l44LmwWQF7ag-drXgZbXPetxm7VSEg6bALi7xRKPeXT-Gg== 23:52:07 INFO - x-amz-version-id: 3qVSj.e8r1ERpfwAOyDbZJgY6UrrKZo8 23:52:08 INFO - Expected file size: 14402992 23:52:08 INFO - Obtained file size: 14402992 23:52:08 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')]} 23:52:08 INFO - trying https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:52:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:52:11 INFO - Downloaded 57670418 bytes. 23:52:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:52:11 INFO - mkdir: /builds/slave/test/properties 23:52:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:52:11 INFO - Writing to file /builds/slave/test/properties/build_url 23:52:11 INFO - Contents: 23:52:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:52:11 INFO - Running post-action listener: _resource_record_post_action 23:52:11 INFO - Running post-action listener: set_extra_try_arguments 23:52:11 INFO - [mozharness: 2017-01-24 07:52:11.905689Z] Finished download-and-extract step (success) 23:52:11 INFO - [mozharness: 2017-01-24 07:52:11.905915Z] Running populate-webroot step. 23:52:11 INFO - Running pre-action listener: _resource_record_pre_action 23:52:11 INFO - Running main action method: populate_webroot 23:52:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:52:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:52:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:52:11 INFO - '--tppagecycles', 23:52:11 INFO - '7'], 23:52:11 INFO - 'tests': ['tsvgm']}}, 23:52:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:52:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:52:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:52:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:52:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['damp', 'tps']}, 23:52:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'tests': ['damp', 'tps']}, 23:52:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['dromaeo_dom']}, 23:52:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:52:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['basic_compositor_video']}, 23:52:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:52:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other-e10s': {'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['tsvgx', 23:52:11 INFO - 'tsvgr_opacity', 23:52:11 INFO - 'tart', 23:52:11 INFO - 'tscrollx', 23:52:11 INFO - 'cart']}, 23:52:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:52:11 INFO - 'tsvgr_opacity', 23:52:11 INFO - 'tart', 23:52:11 INFO - 'tscrollx', 23:52:11 INFO - 'cart']}, 23:52:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['tp5o']}, 23:52:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'tests': ['tp5o']}, 23:52:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--disable-e10s', 23:52:11 INFO - '--xperf_path', 23:52:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:11 INFO - 'tests': ['tp5n']}, 23:52:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--xperf_path', 23:52:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:11 INFO - 'tests': ['tp5n']}}, 23:52:11 INFO - 'talos.zip': {'path': '', 23:52:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:52:11 INFO - Running post-action listener: _resource_record_post_action 23:52:11 INFO - [mozharness: 2017-01-24 07:52:11.923779Z] Finished populate-webroot step (success) 23:52:11 INFO - [mozharness: 2017-01-24 07:52:11.923866Z] Running create-virtualenv step. 23:52:11 INFO - Running pre-action listener: _resource_record_pre_action 23:52:11 INFO - Running main action method: create_virtualenv 23:52:11 INFO - Creating virtualenv /builds/slave/test/build/venv 23:52:11 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 23:52:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:52:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:52:12 INFO - Using real prefix '/usr' 23:52:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:52:12 INFO - Installing distribute.............................................................................................................................................................................................done. 23:52:14 INFO - Installing pip.................done. 23:52:14 INFO - Return code: 0 23:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:52:14 INFO - Reading from file tmpfile_stdout 23:52:14 INFO - Output received: 23:52:14 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) 23:52:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:14 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 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:14 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 23:52:14 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 23:52:14 INFO - Using env: {'DISPLAY': ':0', 23:52:14 INFO - 'HOME': '/home/cltbld', 23:52:14 INFO - 'LANG': 'en_US.UTF-8', 23:52:14 INFO - 'LANGUAGE': 'en_US:en', 23:52:14 INFO - 'LOGNAME': 'cltbld', 23:52:14 INFO - 'MAIL': '/var/mail/cltbld', 23:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:14 INFO - 'MOZ_NO_REMOTE': '1', 23:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:14 INFO - 'NO_EM_RESTART': '1', 23:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:14 INFO - 'PWD': '/builds/slave/test', 23:52:14 INFO - 'SHELL': '/bin/bash', 23:52:14 INFO - 'SHLVL': '1', 23:52:14 INFO - 'TERM': 'linux', 23:52:14 INFO - 'TMOUT': '86400', 23:52:14 INFO - 'USER': 'cltbld', 23:52:14 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:14 INFO - '_': '/tools/buildbot/bin/python'} 23:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:14 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 23:52:14 INFO - Cleaning up... 23:52:14 INFO - Return code: 0 23:52:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:14 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 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:14 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 23:52:14 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 23:52:14 INFO - Using env: {'DISPLAY': ':0', 23:52:14 INFO - 'HOME': '/home/cltbld', 23:52:14 INFO - 'LANG': 'en_US.UTF-8', 23:52:14 INFO - 'LANGUAGE': 'en_US:en', 23:52:14 INFO - 'LOGNAME': 'cltbld', 23:52:14 INFO - 'MAIL': '/var/mail/cltbld', 23:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:14 INFO - 'MOZ_NO_REMOTE': '1', 23:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:14 INFO - 'NO_EM_RESTART': '1', 23:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:14 INFO - 'PWD': '/builds/slave/test', 23:52:14 INFO - 'SHELL': '/bin/bash', 23:52:14 INFO - 'SHLVL': '1', 23:52:14 INFO - 'TERM': 'linux', 23:52:14 INFO - 'TMOUT': '86400', 23:52:14 INFO - 'USER': 'cltbld', 23:52:14 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:14 INFO - '_': '/tools/buildbot/bin/python'} 23:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:15 INFO - Downloading/unpacking psutil>=3.1.1 23:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:17 INFO - Installing collected packages: psutil 23:52:17 INFO - Running setup.py install for psutil 23:52:17 INFO - building 'psutil._psutil_linux' extension 23:52:17 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 23:52:17 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 23:52:17 INFO - building 'psutil._psutil_posix' extension 23:52:17 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 23:52:17 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 23:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:17 INFO - Successfully installed psutil 23:52:17 INFO - Cleaning up... 23:52:17 INFO - Return code: 0 23:52:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:52:17 INFO - Using env: {'DISPLAY': ':0', 23:52:17 INFO - 'HOME': '/home/cltbld', 23:52:17 INFO - 'LANG': 'en_US.UTF-8', 23:52:17 INFO - 'LANGUAGE': 'en_US:en', 23:52:17 INFO - 'LOGNAME': 'cltbld', 23:52:17 INFO - 'MAIL': '/var/mail/cltbld', 23:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:17 INFO - 'MOZ_NO_REMOTE': '1', 23:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:17 INFO - 'NO_EM_RESTART': '1', 23:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:17 INFO - 'PWD': '/builds/slave/test', 23:52:17 INFO - 'SHELL': '/bin/bash', 23:52:17 INFO - 'SHLVL': '1', 23:52:17 INFO - 'TERM': 'linux', 23:52:17 INFO - 'TMOUT': '86400', 23:52:17 INFO - 'USER': 'cltbld', 23:52:17 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:17 INFO - '_': '/tools/buildbot/bin/python'} 23:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:52:18 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 23:52:18 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 23:52:18 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 23:52:18 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 23:52:18 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 23:52:18 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 23:52:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:52:20 INFO - Installing collected packages: mozsystemmonitor 23:52:20 INFO - Running setup.py install for mozsystemmonitor 23:52:20 INFO - Successfully installed mozsystemmonitor 23:52:20 INFO - Cleaning up... 23:52:20 INFO - Return code: 0 23:52:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:52:20 INFO - Using env: {'DISPLAY': ':0', 23:52:20 INFO - 'HOME': '/home/cltbld', 23:52:20 INFO - 'LANG': 'en_US.UTF-8', 23:52:20 INFO - 'LANGUAGE': 'en_US:en', 23:52:20 INFO - 'LOGNAME': 'cltbld', 23:52:20 INFO - 'MAIL': '/var/mail/cltbld', 23:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:20 INFO - 'MOZ_NO_REMOTE': '1', 23:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:20 INFO - 'NO_EM_RESTART': '1', 23:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:20 INFO - 'PWD': '/builds/slave/test', 23:52:20 INFO - 'SHELL': '/bin/bash', 23:52:20 INFO - 'SHLVL': '1', 23:52:20 INFO - 'TERM': 'linux', 23:52:20 INFO - 'TMOUT': '86400', 23:52:20 INFO - 'USER': 'cltbld', 23:52:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:20 INFO - '_': '/tools/buildbot/bin/python'} 23:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:20 INFO - Downloading/unpacking jsonschema==2.5.1 23:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:52:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:52:22 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 23:52:22 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 23:52:22 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 23:52:22 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 23:52:22 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 23:52:22 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 23:52:22 INFO - Downloading functools32-3.2.3-2.tar.gz 23:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:52:22 INFO - warning: no files found matching '*.txt' 23:52:22 INFO - no previously-included directories found matching 'build' 23:52:22 INFO - no previously-included directories found matching 'dist' 23:52:22 INFO - no previously-included directories found matching '.git*' 23:52:22 INFO - Installing collected packages: jsonschema, functools32 23:52:22 INFO - Running setup.py install for functools32 23:52:22 INFO - warning: no files found matching '*.txt' 23:52:22 INFO - no previously-included directories found matching 'build' 23:52:22 INFO - no previously-included directories found matching 'dist' 23:52:22 INFO - no previously-included directories found matching '.git*' 23:52:22 INFO - Successfully installed jsonschema functools32 23:52:22 INFO - Cleaning up... 23:52:22 INFO - Return code: 0 23:52:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:52:22 INFO - Using env: {'DISPLAY': ':0', 23:52:22 INFO - 'HOME': '/home/cltbld', 23:52:22 INFO - 'LANG': 'en_US.UTF-8', 23:52:22 INFO - 'LANGUAGE': 'en_US:en', 23:52:22 INFO - 'LOGNAME': 'cltbld', 23:52:22 INFO - 'MAIL': '/var/mail/cltbld', 23:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:22 INFO - 'MOZ_NO_REMOTE': '1', 23:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:22 INFO - 'NO_EM_RESTART': '1', 23:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:22 INFO - 'PWD': '/builds/slave/test', 23:52:23 INFO - 'SHELL': '/bin/bash', 23:52:23 INFO - 'SHLVL': '1', 23:52:23 INFO - 'TERM': 'linux', 23:52:23 INFO - 'TMOUT': '86400', 23:52:23 INFO - 'USER': 'cltbld', 23:52:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:23 INFO - '_': '/tools/buildbot/bin/python'} 23:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:52:23 INFO - Cleaning up... 23:52:23 INFO - Return code: 0 23:52:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:52:23 INFO - Using env: {'DISPLAY': ':0', 23:52:23 INFO - 'HOME': '/home/cltbld', 23:52:23 INFO - 'LANG': 'en_US.UTF-8', 23:52:23 INFO - 'LANGUAGE': 'en_US:en', 23:52:23 INFO - 'LOGNAME': 'cltbld', 23:52:23 INFO - 'MAIL': '/var/mail/cltbld', 23:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:23 INFO - 'MOZ_NO_REMOTE': '1', 23:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:23 INFO - 'NO_EM_RESTART': '1', 23:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:23 INFO - 'PWD': '/builds/slave/test', 23:52:23 INFO - 'SHELL': '/bin/bash', 23:52:23 INFO - 'SHLVL': '1', 23:52:23 INFO - 'TERM': 'linux', 23:52:23 INFO - 'TMOUT': '86400', 23:52:23 INFO - 'USER': 'cltbld', 23:52:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:23 INFO - '_': '/tools/buildbot/bin/python'} 23:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:23 INFO - Downloading/unpacking blobuploader==1.2.4 23:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:26 INFO - Downloading blobuploader-1.2.4.tar.gz 23:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:52:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:52:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:27 INFO - Downloading docopt-0.6.1.tar.gz 23:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:52:27 INFO - Installing collected packages: blobuploader, requests, docopt 23:52:27 INFO - Running setup.py install for blobuploader 23:52:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:52:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:52:27 INFO - Running setup.py install for requests 23:52:27 INFO - Running setup.py install for docopt 23:52:27 INFO - Successfully installed blobuploader requests docopt 23:52:27 INFO - Cleaning up... 23:52:27 INFO - Return code: 0 23:52:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:27 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 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:27 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 23:52:27 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 23:52:27 INFO - Using env: {'DISPLAY': ':0', 23:52:27 INFO - 'HOME': '/home/cltbld', 23:52:27 INFO - 'LANG': 'en_US.UTF-8', 23:52:27 INFO - 'LANGUAGE': 'en_US:en', 23:52:27 INFO - 'LOGNAME': 'cltbld', 23:52:27 INFO - 'MAIL': '/var/mail/cltbld', 23:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:27 INFO - 'MOZ_NO_REMOTE': '1', 23:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:27 INFO - 'NO_EM_RESTART': '1', 23:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:27 INFO - 'PWD': '/builds/slave/test', 23:52:27 INFO - 'SHELL': '/bin/bash', 23:52:27 INFO - 'SHLVL': '1', 23:52:27 INFO - 'TERM': 'linux', 23:52:27 INFO - 'TMOUT': '86400', 23:52:27 INFO - 'USER': 'cltbld', 23:52:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:27 INFO - '_': '/tools/buildbot/bin/python'} 23:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:52:28 INFO - Running setup.py (path:/tmp/pip-6i1HjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:52:28 INFO - Running setup.py (path:/tmp/pip-gZfrwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:52:28 INFO - Running setup.py (path:/tmp/pip-9wtqAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:52:28 INFO - Running setup.py (path:/tmp/pip-NMi_Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:52:28 INFO - Running setup.py (path:/tmp/pip-TKJA60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:52:28 INFO - Running setup.py (path:/tmp/pip-espjOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:52:28 INFO - Running setup.py (path:/tmp/pip-58PLy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:52:28 INFO - Running setup.py (path:/tmp/pip-Ws4SUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:52:28 INFO - Running setup.py (path:/tmp/pip-DAQC2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:52:28 INFO - Running setup.py (path:/tmp/pip-vPOChG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:52:28 INFO - Running setup.py (path:/tmp/pip-_U17xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:52:28 INFO - Running setup.py (path:/tmp/pip-S0xZ__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:52:28 INFO - Running setup.py (path:/tmp/pip-4GQD_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:52:29 INFO - Running setup.py (path:/tmp/pip-J2Qd18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:29 INFO - Running setup.py (path:/tmp/pip-45VwfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:52:29 INFO - Running setup.py (path:/tmp/pip-N9CBuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:52:29 INFO - Running setup.py (path:/tmp/pip-sYr_9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:52:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:52:29 INFO - Running setup.py install for manifestparser 23:52:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:52:29 INFO - Running setup.py install for mozcrash 23:52:29 INFO - Running setup.py install for mozdebug 23:52:29 INFO - Running setup.py install for mozdevice 23:52:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:52:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:52:29 INFO - Running setup.py install for mozfile 23:52:29 INFO - Running setup.py install for mozhttpd 23:52:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:52:29 INFO - Running setup.py install for mozinfo 23:52:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Running setup.py install for mozInstall 23:52:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Running setup.py install for mozleak 23:52:30 INFO - Running setup.py install for mozlog 23:52:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Running setup.py install for moznetwork 23:52:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Running setup.py install for mozprocess 23:52:30 INFO - Running setup.py install for mozprofile 23:52:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Running setup.py install for mozrunner 23:52:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:52:30 INFO - Running setup.py install for mozscreenshot 23:52:30 INFO - Running setup.py install for moztest 23:52:30 INFO - Running setup.py install for mozversion 23:52:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:52:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:52:31 INFO - Cleaning up... 23:52:31 INFO - Return code: 0 23:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:31 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 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:31 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 23:52:31 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 23:52:31 INFO - Using env: {'DISPLAY': ':0', 23:52:31 INFO - 'HOME': '/home/cltbld', 23:52:31 INFO - 'LANG': 'en_US.UTF-8', 23:52:31 INFO - 'LANGUAGE': 'en_US:en', 23:52:31 INFO - 'LOGNAME': 'cltbld', 23:52:31 INFO - 'MAIL': '/var/mail/cltbld', 23:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:31 INFO - 'MOZ_NO_REMOTE': '1', 23:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:31 INFO - 'NO_EM_RESTART': '1', 23:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:31 INFO - 'PWD': '/builds/slave/test', 23:52:31 INFO - 'SHELL': '/bin/bash', 23:52:31 INFO - 'SHLVL': '1', 23:52:31 INFO - 'TERM': 'linux', 23:52:31 INFO - 'TMOUT': '86400', 23:52:31 INFO - 'USER': 'cltbld', 23:52:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:31 INFO - '_': '/tools/buildbot/bin/python'} 23:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:52:31 INFO - Running setup.py (path:/tmp/pip-1IKthV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:52:31 INFO - Running setup.py (path:/tmp/pip-S4dfi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:52:31 INFO - Running setup.py (path:/tmp/pip-xjTmeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:52:31 INFO - Running setup.py (path:/tmp/pip-9i3Ngu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:52:31 INFO - Running setup.py (path:/tmp/pip-DuLKWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:52:31 INFO - Running setup.py (path:/tmp/pip-KKFJq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:52:31 INFO - Running setup.py (path:/tmp/pip-AXfxFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:52:31 INFO - Running setup.py (path:/tmp/pip-dqC597-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:52:31 INFO - Running setup.py (path:/tmp/pip-phO5rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:52:31 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)) 23:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:52:31 INFO - Running setup.py (path:/tmp/pip-wrS4Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:52:32 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)) 23:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:52:32 INFO - Running setup.py (path:/tmp/pip-exIUqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:52:32 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)) 23:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:52:32 INFO - Running setup.py (path:/tmp/pip-2AquW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:52:32 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)) 23:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:52:32 INFO - Running setup.py (path:/tmp/pip-l5AvNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:52:32 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)) 23:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:52:32 INFO - Running setup.py (path:/tmp/pip-lvhi8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:52:32 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)) 23:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:32 INFO - Running setup.py (path:/tmp/pip-aMAZpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:32 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)) 23:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:52:32 INFO - Running setup.py (path:/tmp/pip-HewuGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:52:32 INFO - Running setup.py (path:/tmp/pip-7gJjzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:52:32 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)) 23:52:32 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)) 23:52:32 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)) 23:52:32 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)) 23:52:32 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)) 23:52:32 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)) 23:52:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:52:32 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 23:52:32 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 23:52:32 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 23:52:32 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 23:52:32 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 23:52:32 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 23:52:34 INFO - Downloading blessings-1.6.tar.gz 23:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:52:34 INFO - Installing collected packages: blessings 23:52:34 INFO - Running setup.py install for blessings 23:52:34 INFO - Successfully installed blessings 23:52:34 INFO - Cleaning up... 23:52:34 INFO - Return code: 0 23:52:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:52:35 INFO - Reading from file tmpfile_stdout 23:52:35 INFO - Current package versions: 23:52:35 INFO - argparse == 1.2.1 23:52:35 INFO - blessings == 1.6 23:52:35 INFO - blobuploader == 1.2.4 23:52:35 INFO - docopt == 0.6.1 23:52:35 INFO - functools32 == 3.2.3-2 23:52:35 INFO - jsonschema == 2.5.1 23:52:35 INFO - manifestparser == 1.1 23:52:35 INFO - mozInstall == 1.12 23:52:35 INFO - mozcrash == 1.0 23:52:35 INFO - mozdebug == 0.1 23:52:35 INFO - mozdevice == 0.48 23:52:35 INFO - mozfile == 1.2 23:52:35 INFO - mozhttpd == 0.7 23:52:35 INFO - mozinfo == 0.9 23:52:35 INFO - mozleak == 0.1 23:52:35 INFO - mozlog == 3.4 23:52:35 INFO - moznetwork == 0.27 23:52:35 INFO - mozprocess == 0.23 23:52:35 INFO - mozprofile == 0.28 23:52:35 INFO - mozrunner == 6.13 23:52:35 INFO - mozscreenshot == 0.1 23:52:35 INFO - mozsystemmonitor == 0.3 23:52:35 INFO - moztest == 0.8 23:52:35 INFO - mozversion == 1.4 23:52:35 INFO - psutil == 3.1.1 23:52:35 INFO - requests == 1.2.3 23:52:35 INFO - wsgiref == 0.1.2 23:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52: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')]} 23:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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')]} 23:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:35 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 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52:35 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 23:52:35 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 23:52:35 INFO - Using env: {'DISPLAY': ':0', 23:52:35 INFO - 'HOME': '/home/cltbld', 23:52:35 INFO - 'LANG': 'en_US.UTF-8', 23:52:35 INFO - 'LANGUAGE': 'en_US:en', 23:52:35 INFO - 'LOGNAME': 'cltbld', 23:52:35 INFO - 'MAIL': '/var/mail/cltbld', 23:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:35 INFO - 'MOZ_NO_REMOTE': '1', 23:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:35 INFO - 'NO_EM_RESTART': '1', 23:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:35 INFO - 'PWD': '/builds/slave/test', 23:52:35 INFO - 'SHELL': '/bin/bash', 23:52:35 INFO - 'SHLVL': '1', 23:52:35 INFO - 'TERM': 'linux', 23:52:35 INFO - 'TMOUT': '86400', 23:52:35 INFO - 'USER': 'cltbld', 23:52:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:35 INFO - '_': '/tools/buildbot/bin/python'} 23:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 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)) 23:52:35 INFO - Cleaning up... 23:52:35 INFO - Return code: 0 23:52:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:52: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')]} 23:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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')]} 23:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0a3d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, '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': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', '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 23:52: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'] in /builds/slave/test/build 23:52: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 23:52:35 INFO - Using env: {'DISPLAY': ':0', 23:52:35 INFO - 'HOME': '/home/cltbld', 23:52:35 INFO - 'LANG': 'en_US.UTF-8', 23:52:35 INFO - 'LANGUAGE': 'en_US:en', 23:52:35 INFO - 'LOGNAME': 'cltbld', 23:52:35 INFO - 'MAIL': '/var/mail/cltbld', 23:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:35 INFO - 'MOZ_NO_REMOTE': '1', 23:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:35 INFO - 'NO_EM_RESTART': '1', 23:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:35 INFO - 'PWD': '/builds/slave/test', 23:52:35 INFO - 'SHELL': '/bin/bash', 23:52:35 INFO - 'SHLVL': '1', 23:52:35 INFO - 'TERM': 'linux', 23:52:35 INFO - 'TMOUT': '86400', 23:52:35 INFO - 'USER': 'cltbld', 23:52:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:35 INFO - '_': '/tools/buildbot/bin/python'} 23:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:52:35 INFO - Cleaning up... 23:52:35 INFO - Return code: 0 23:52:35 INFO - Running post-action listener: _resource_record_post_action 23:52:35 INFO - Running post-action listener: _start_resource_monitoring 23:52:35 INFO - Starting resource monitoring. 23:52:35 INFO - [mozharness: 2017-01-24 07:52:35.542054Z] Finished create-virtualenv step (success) 23:52:35 INFO - [mozharness: 2017-01-24 07:52:35.542516Z] Running install step. 23:52:35 INFO - Running pre-action listener: _resource_record_pre_action 23:52:35 INFO - Running main action method: install 23:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:52:35 INFO - Reading from file tmpfile_stdout 23:52:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:52:35 INFO - Reading from file tmpfile_stdout 23:52:35 INFO - Output received: 23:52:35 INFO - Usage: mozinstall [options] installer 23:52:35 INFO - Options: 23:52:35 INFO - -h, --help show this help message and exit 23:52:35 INFO - -d DEST, --destination=DEST 23:52:35 INFO - Directory to install application into. [default: 23:52:35 INFO - "/builds/slave/test"] 23:52:35 INFO - --app=APP Application being installed. [default: firefox] 23:52:35 INFO - mkdir: /builds/slave/test/build/application 23:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:52:49 INFO - Reading from file tmpfile_stdout 23:52:49 INFO - Output received: 23:52:49 INFO - /builds/slave/test/build/application/firefox/firefox 23:52:49 INFO - Running post-action listener: _resource_record_post_action 23:52:49 INFO - [mozharness: 2017-01-24 07:52:49.496764Z] Finished install step (success) 23:52:49 INFO - [mozharness: 2017-01-24 07:52:49.497005Z] Running run-tests step. 23:52:49 INFO - Running pre-action listener: _resource_record_pre_action 23:52:49 INFO - Running main action method: run_tests 23:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:52:49 INFO - Python 2.7.3 23:52:49 INFO - Return code: 0 23:52:49 INFO - grabbing minidump binary from tooltool 23:52: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')]} 23:52:49 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2380f60>, '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 0x2381d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23821d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:52:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:52:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:52:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:52:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:52:49 INFO - Return code: 0 23:52:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:52:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:52:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:52:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:52:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 23:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 23:52:49 INFO - Using env: {'DISPLAY': ':0', 23:52:49 INFO - 'HOME': '/home/cltbld', 23:52:49 INFO - 'LANG': 'en_US.UTF-8', 23:52:49 INFO - 'LANGUAGE': 'en_US:en', 23:52:49 INFO - 'LOGNAME': 'cltbld', 23:52:49 INFO - 'MAIL': '/var/mail/cltbld', 23:52:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:52:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:49 INFO - 'MOZ_NO_REMOTE': '1', 23:52:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:49 INFO - 'NO_EM_RESTART': '1', 23:52:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:49 INFO - 'PWD': '/builds/slave/test', 23:52:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:52:49 INFO - 'SHELL': '/bin/bash', 23:52:49 INFO - 'SHLVL': '1', 23:52:49 INFO - 'TERM': 'linux', 23:52:49 INFO - 'TMOUT': '86400', 23:52:49 INFO - 'USER': 'cltbld', 23:52:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499', 23:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:49 INFO - '_': '/tools/buildbot/bin/python'} 23:52:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 23:52:49 INFO - mozversion application_buildid: 20170123215943 23:52:49 INFO - mozversion application_changeset: 7c6d7296c07d6df56a1f1a4a4861bb1e6f104c26 23:52:49 INFO - mozversion application_display_name: Firefox 23:52:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:52:49 INFO - mozversion application_name: Firefox 23:52:49 INFO - mozversion application_remotingname: firefox 23:52:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:52:49 INFO - mozversion application_vendor: Mozilla 23:52:49 INFO - mozversion application_version: 52.0 23:52:49 INFO - mozversion platform_buildid: 20170123215943 23:52:49 INFO - mozversion platform_changeset: 7c6d7296c07d6df56a1f1a4a4861bb1e6f104c26 23:52:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:52:49 INFO - mozversion platform_version: 52.0 23:52:49 INFO - using testdate: 1485244369 23:52:49 INFO - actual date: 1485244369 23:52:49 INFO - starting webserver on 'localhost:58911' 23:52:49 INFO - SUITE-START | Running 2 tests 23:52:49 INFO - TEST-START | dromaeo_css 23:52:49 INFO - operating with platform_type : linux_ 23:52:49 INFO - Initialising browser for dromaeo_css test... 23:52:49 INFO - TEST-INFO | started process 22167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK2o_uv/profile http://localhost:58911/getInfo.html) 23:52:53 INFO - PROCESS | 22167 | __metrics Screen width/height:1600/1200 23:52:53 INFO - PROCESS | 22167 | colorDepth:24 23:52:53 INFO - PROCESS | 22167 | Browser inner width/height: 1024/697 23:52:53 INFO - PROCESS | 22167 | __metrics 23:52:53 INFO - PROCESS | 22167 | 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" 23:52:53 INFO - PROCESS | 22167 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:52:54 INFO - PROCESS | 22167 | console.error: PushService: 23:52:54 INFO - PROCESS | 22167 | stateChangeProcessEnqueue: Error transitioning state 23:52:54 INFO - PROCESS | 22167 | UnknownError 23:52:55 INFO - TEST-INFO | 22167: exit 0 23:52:55 INFO - Browser initialized. 23:52:55 INFO - Running cycle 1/1 for dromaeo_css test... 23:52:55 INFO - TEST-INFO | started process 22260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK2o_uv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:53:06 INFO - PROCESS | 22260 | RSS: Main: 141115392 23:53:06 INFO - PROCESS | 22260 | 23:56:07 INFO - PROCESS | 22260 | Cycle 1(1): loaded http://localhost:58911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58911/tests/dromaeo/cssquery-ext.html) 23:56:08 INFO - PROCESS | 22260 | RSS: Main: 238493696 23:56:08 INFO - PROCESS | 22260 | 23:59:11 INFO - PROCESS | 22260 | Cycle 1(1): loaded http://localhost:58911/tests/dromaeo/cssquery-ext.html (next: http://localhost:58911/tests/dromaeo/cssquery-jquery.html) 23:59:11 INFO - PROCESS | 22260 | RSS: Main: 228118528 23:59:11 INFO - PROCESS | 22260 | 00:02:13 INFO - PROCESS | 22260 | Cycle 1(1): loaded http://localhost:58911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58911/tests/dromaeo/cssquery-mootools.html) 00:02:14 INFO - PROCESS | 22260 | RSS: Main: 175312896 00:02:14 INFO - PROCESS | 22260 | 00:05:16 INFO - PROCESS | 22260 | Cycle 1(1): loaded http://localhost:58911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58911/tests/dromaeo/cssquery-prototype.html) 00:05:16 INFO - PROCESS | 22260 | RSS: Main: 218984448 00:05:16 INFO - PROCESS | 22260 | 00:08:19 INFO - PROCESS | 22260 | Cycle 1(1): loaded http://localhost:58911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58911/tests/dromaeo/cssquery-yui.html) 00:08:20 INFO - PROCESS | 22260 | RSS: Main: 175415296 00:08:20 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | Cycle 1(1): loaded http://localhost:58911/tests/dromaeo/cssquery-yui.html (next: http://localhost:58911/tests/dromaeo/cssquery-dojo.html) 00:11:22 INFO - PROCESS | 22260 | RSS: Main: 263946240 00:11:22 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | __start_tp_report 00:11:22 INFO - PROCESS | 22260 | _x_x_mozilla_page_load 00:11:22 INFO - PROCESS | 22260 | _x_x_mozilla_page_load_details 00:11:22 INFO - PROCESS | 22260 | |i|pagename|runs| 00:11:22 INFO - PROCESS | 22260 | |0;dojo.html;3206.9358612827746;3241.2869168782872;3245.2211469247386;3276.6068071831382;3293.868245270188;5466.890662186754;5569.582281328906;5579.1910173024835;5581.6930068846195;5607.7476513556885;5526.06056970315;5587;5594.86012849679;5609.57928155389;5626.493615574597;5056.620753443497;5077.923831142536;5114.386273647149;5146.897062058757;5162.096633089194;4964.776585053663;4994.076095922266;5110.821121260757;5166.095933211692;5169.6898186108765;4970.329005584236;4997.975010124945;5003.149464591028;5033.993201359743;5081.1108056090225;5071.391433028023;5162.277281180638;5162.483751624845;5163.457836927144;5191.091558977164;4858.708477491362;5067.873303167414;5082;5097.2608971699265;5140.126178549655;5385.21914322425;5394.460553944614;5405.621606487547;5428.104362780136;5510.779568817243;5844.240248767675;5888.322842873082;5947.078202878561;5966.612170208922;5973.671448070354;5863.3257175424515;5994.880102397971;6009.429104235091;6026.728797204137;6027.939720602782;5452.154915988028;5462.5083742462975;5519.116941289455;5537.667739935617;5544.3346798384455;6044.516438684895;6048.123022161762;6055.455009049207;6063.181470501514;6072.605280656743;5690.857728556819;5803.419658034163;5810.825675229666;5811.56413268998;5820.505257053113;5814.389489103668;5877.089051197071;5929.970350148308;5938.28740551128;6023.969880150571;5963.850903727442;5975.43233392827;5977.462028417463;5979.342272350038;5979.9402005980255;5932.822015339547;5992.0712289595185;5993.250843644544;6011.849703757353;6020.217371741645;4418.977905110454;4498.212812757754;4502.954970450319;4524.932126018112;4560.954390456053;4073.674106071507;4098.815553300109;4100.425940368351;4122.2786012448305;4128.1330920506425;5574.609777315549;5584.357798853102;5587.580931430159;5588.720563971867;5621.241132447149;5753.597248192586;5769.365369809318;5813.79651712188;5845.357010728816;5959.880802383928;5625.662460252398;5661.46216109469;5662.8301150965535;5673.290838645169;5690.658560486384;5084.694918304914;5093.651665750946;5095.184770436712;5099.082165210223;5124;5895.263092113486;6011.819645410645;6078.118672792509;6160.661163636043;6169.043798211284;5838.211841401357;5954.46409823118;5971.164037034731;5988.760449581968;6005.939940600538;6162.352952939877;6168.599041062316;6175.814725558241;6178.258608966773;6193.969030155001;5640.830775076754;5811.680357580373;5864.06175011996;5868.911966320594;5879.147523609138;5832.300123985149;5850.12248162779;5868.765249390148;5877.588568800143;5975.940240597538;5789.507891829242;5792.333881603669;5799.246098007232;5801.5938884279385;5802.5357971361345;5773.711314434177;5777.046787280052;5781.971090144522;5783.306003279633;5787.276590426197;5523.6409633373705;5608.130739735348;5640.689762063126;5642.351129620146;5657.688827114548;5744.080947048452;5758.395368486249;5778.566607504538;5788.131780232999;5800.970995144998;5574.470425309589;5622.044252477171;5625.774969001194;5639.041362968387;5642.181883626933 00:11:22 INFO - PROCESS | 22260 | |1;ext.html;581.5434883616359;621.7637297826826;641.4804008752909;657.6054367379572;685.2051620120661;34192;38136.618633813654;38142.61857381429;38146.809265953634;44809.32786008212;43461.34807977883;47564.524354756526;47622.28566571504;47631.52368476314;47663.52336476634;8960.193582577584;9090.318226133033;9119.772005699877;9121.543922803834;9124.863127053099;8493.787655308604;8645.308375329958;8928.330375221853;9022.729318120468;10656.733581660443;10705.411202383866;11147.832782508269;11151.163662725288;11156.832647510293;11159.163062770283;10994.560217591286;11054.723631909186;11058.170637202242;11073.557057717682;11080.335179889233;10849.457527123612;10915.508802103925;10922.126229901589;10929.617463388744;10930;43619;43870;43884.341734873684;43964;44113.77943110264;3496.8426420811124;3554.431290993429;3600.3339382214112;3638.326909521747;3983.521977362735;33228.6677133228;33424.331513369594;33453.49819752706;33461;33602.1599460013;4280.59334363235;4430.712003719748;4438.667099967483;4479.10417916418;4546.568076032805;338897;339701;341687;342381;343142;38231.617683822806;60518.697406512685;60826;60857;60894.69552652208;38978.6102138975;40941.38587921183;41275.1744965105;41290.79354603208;41307.58692413037;14545.78181327281;14625.707485850224;14632.414703411745;14634.487792927197;14637;12669.873301267055;12711.55509557161;12739.299338536284;12742.80885786714;12749.681257968625;8983.77540561478;9211.170994610517;9216.953915230515;9279.118483744034;9575.425474471554;3602.2615363850346;3615.168511242429;3639.454081887738;3678.0988657779017;3690.206605579813;984.950752462374;1012.9442880641635;1101.3336931156534;1110.245033377295;1181.2794195540714;31552.684473155434;33510;33516.832415837765;33746.325073498396;33746.662533374845;1108.6895669212633;1116.5812820192427;1206.1255589697398;1215.7629262293767;1234.9876501234874;15324.310406031755;16506.504804855875;18594.25622975066;18843.434696959113;19858.205671773256;518822;540466;552553;557651;827192;60542;61192;61380;61418.385816141265;61526;1386.5840247925582;1402.446033816657;1441.6035590212566;1443.5164219986423;1447.3269929482842;31266.843665782435;33701.3259734799;33764;33844.492332615526;34135.146621333675;54862;55399.16901246404;55475.72262138664;55547.16679249895;55562.44437555573;472992;479700;480397;481653;481659;27323.72676273212;27953.161405157065;29755;30830.53754193644;31456;43254.783726081165;47205;47350.763246183546;47993.520064798904;48434.75782621205;40699;40863;40983.18033639251;41803.37294940639;41931.7903410481;40185.1962960745;40474.797626011685;40742;41592.792036039624;42853.357199642654;41226.38160427536;41334.79332603318;42000.57999419967;42177;42369.36445953252;33364.66635333616;36254.637453625124;36605.81697091604;37100.44349334816;37587.248255035294;27918.44163116767;28040.439191215653;28176.71823281741;28352.43295134127;28411.147665570064 00:11:22 INFO - PROCESS | 22260 | |2;jquery.html;408.3935355996347;414.37636357282287;421.91350773091517;425.7892343290072;444.79317117540336;18491.815081849178;19645.214191432362;19748.605027899433;19795.70306445401;20127.59744805103;19449.222031118774;19566.413007609794;20514.076866541003;20710.48223794406;20722.68915966258;5280.102382594959;5501.559875209973;5537.501624853762;5581.413951535092;5586.10622300432;5507.669539827623;5512.669239845602;5527.55779537638;5546.611737178399;5765.68288744121;5948.1969934059;5986.8802623947495;5994;5996.430339117776;5997.460228579427;5785.334686511063;5950.285965684146;5968.164456976006;5978.40215978403;6014.879702405971;5434.239206511092;5435.809746658848;5441.238226648273;5441.374241962186;5441.891162176735;14941.17823519706;22474.43813904649;23144.65283020756;23499.29502114939;24768.752312476823;2347.953040939172;2376.2277259890434;2407.65089062085;2489.253224032801;2932.237618219257;10388.117010054155;10411.583536658525;10514.579416823319;10701.411422371766;10849.67450976464;1914.9712754308696;1978.2581531925528;2004.9097790599458;2008.3171721614722;2049.764277108122;64668;64738.67630661864;80104.19895801083;83950.16049839485;87659.12340876638;10084.142847858015;10168.593256269667;10458.895411045793;10494.842577361345;11427.942860285812;14201.715965680629;14263.07290026145;14298.499552515612;14298.785518217235;14301.141931484144;7950.7217247396065;7979.723244280887;8028.715405535087;8102.473339232931;8145.755627331189;7915.287624113857;7966.920330796734;8153.79615509617;8276.544790036605;8359.164083591713;4325.84859529915;4413.713108647992;4450.955490445119;4524.0951809637545;4550.203714349976;1963.9198440857472;2063.6801295799173;2075.564131532395;2110.6622940329476;2127.5319429725437;898.2723993565234;965.3098034905076;975.0882924465648;1033.7570670892335;1081.5889961814617;19917.402477925687;19993.900030500045;20082.89958550198;20155.79844201539;20414.489637759176;1007.9798404031878;1037.7509397744486;1064.2337516987757;1065.2649671726483;1086.9891301087046;10386.169106471463;11169.931180518812;11286.717832054264;11292.378919159524;11439.656810295704;422378;424020;424098;434319;446832;90030.54984725034;91303;92114.53942730243;93823;104763;1037.911777498921;1057.9100776433936;1058.4229498047853;1065.2330322168027;1066.7973085113804;17748.55628609295;18259.178336975132;18445.53886152857;18562.164702588147;18865.528361790515;43618.34572481479;43946.34080488731;44169.11661766811;44813;45307.773461132485;60157.39842601518;61050;61222.69388653028;61413.385866140765;62113.378866212566;8748.69379571712;8789.824203515765;8807.471551706918;8948.910510895068;9335.346525743133;10734.892651073389;13568.59294221175;13640.522581709592;13838.861611383758;13932.164070155823;11840.28958262507;12014.579489717818;12022.458989345676;12086.576969806014;12480.625581232578;10463.68608941733;11080.944595276973;11470.369129697947;11843.822342665038;11924.165308428674;11096.889031109586;11122;11970;12331.828476294737;12355.135140540076;7959.920400795918;8870.911290887008;8904.287656987295;9068.818623627623;9112.043235460447;10447.320924139907;11667;11706.590269340531;11723.589674361356;12047 00:11:22 INFO - PROCESS | 22260 | |3;mootools.html;1317.7298653775977;1419.0988722161428;1516.0448917182175;1626.138146782205;1812.1482903035576;7610.391168706504;7951.602419879005;8645.13548645136;8896.555172241395;8915.866262006075;8967.775805604862;9064.45613263203;9069.591868365922;9074.909250907489;9087.636494540227;2465.9136930207446;2488.8382255153447;2490.6762120924254;2497.3756560859783;2497.463045445229;2420.286015625386;2457.1891275879007;2461.2739241923587;2465.6671349367784;2466.938326541833;2415.577273977047;2424.054618698709;2438.9024439022505;2456.299954512964;2461.6676748638974;2337.181986304788;2399.1602938971396;2401.0875867170453;2407.277816655014;2443.3525115844313;2235.1841577823975;2365.077619728307;2379.3694670912223;2416.5408572371193;2416.7583241675866;8762.824743505094;8815.338849586307;8945.73162805117;9045.638174473013;9062.501562414065;5410.729463526808;5552.278203833475;5578.497935185812;5648.830535083954;5651.576131790132;3469.7918124912335;3514;3569.928601427983;3575.821208939569;3623.7282203834816;1162.3316592959081;1171.1860257121305;1171.8691462738414;1175.253713891685;1225.785487539677;12525.43635536403;12525.686857828536;12542.811857822231;12551.435185416587;12634.557790477289;4424.646028317727;4485.529019452975;4581.266997280419;4612.077584483117;4615.746133962664;9233.630654773733;9238.983711791698;9240.815183696423;9243.352965292499;9251.121143491358;5282.577393808486;5343.679379237258;5354.973225133849;5355.7054362009685;5358.678479291255;4326.805293761725;4482.8655140345845;4516.3902873112365;4648.697834640738;5030.3963524377305;3964.9008774780286;3974.980125099356;4058.228936502055;4118.361653943583;4127.277726397869;1222.9082818788627;1261.79180435229;1270.1299609767339;1278.7570361631447;1300.5578103444875;876.7150676030316;954.5465903695828;970.4371464550544;992.4095163377779;998.026923749353;5622.240997465372;5756.7121643917635;5896.970515147397;6023.759049638053;6064.06007068905;485.62364167769556;486.84907678619743;506.1648280337399;515.4201523286303;515.4304493534665;3709.4621279914263;3722.813859307024;3724.7206459515646;3736.7944763038295;3851.6533511983494;10926.508307126198;11325.943370283096;11433.59982400612;11445.885541144482;11455.140864435201;11352.37561934085;11373.601923932789;11396.658100257006;11410.828837567444;11415.372154531415;8232.300254478436;8526.403151779316;8620.525871077025;8625.223729864218;8661.263792577576;5546.97226513881;5579.944200557942;5616.466435688603;5665.773369065191;5696;10056.69829905104;10067.395956242648;10103.797924041331;10185.439800811026;10197.9490102549;10434.113100386552;10438.53026613789;10521.210909181995;10546.419946902994;10554.261201715806;7518.774436766906;7616.20029896875;7633.770986870402;7637.198094200029;7648.388128949782;8197.46716463428;8268.627911744106;8268.627911744106;8287.50274983503;8287.751367458986;7368.59472729005;7406.296401841816;7529.88705169412;7605.619719014137;7685.923140768521;7278.96360518194;7342.449316301406;7385.409167266498;7389.667464963982;7395.7411490599725;6861.176658800976;6991.405730512964;6999.860002799814;7002.929970700227;7007.754728584475;4811.735354555533;4835.564799168092;4869.9026019480125;4974.5771609413605;5117;4698.788554514987;4742.193827049341;4939.827106051271;5017.623678224075;5080.669756465818 00:11:22 INFO - PROCESS | 22260 | |4;prototype.html;332.38897285004106;333.05412628136094;344.4557598993589;345.52490325802023;348.4181417033554;5216.634835561512;5278.841634750959;5353.357597088345;5357.678539287645;5368.731563421833;5127.7948882044675;5225.6603320784125;5229.529342359187;5245.659032162906;5267.789288428458;4182.519010313822;4192.203481338551;4195.160967806451;4206.326987681971;4217.704760666755;4146.232946904832;4169.207240886418;4212.7682977436225;4214.051838336381;4239.47006624172;4146.201314112976;4154.273002224599;4164.146349998243;4168.687348448879;4182.728122672017;4145.647619952308;4163.812628431728;4178.770167640779;4181.310083836163;4199.782063201668;3518.9296214075575;3672.944905826415;3677.5403074615674;3689.5019172411917;3778.1310298631192;5147.121300725245;5157.355330583677;5158.561522270612;5164.354455693038;5184.896302073975;4732.367333270016;4751.40607424072;4752.120857641347;4773.4510531289;4786.449558300805;5307.601929855237;5505.944940550583;5541.556675465993;5563;5597.272354593917;4014.3577027675724;4016;4020.6783457323636;4028.47629808126;4028.9194216115516;5740.5981581289325;5749.712514374264;5755.194272801811;5766.942330576682;5793.855153621151;4046.7571945683353;4054.614811592953;4101.815418306183;4115.670746340285;4130.979345103256;4122.587741225853;4141.875743727693;4157.438745769343;4163.770992595436;4181.581841815855;4731.432228132646;4733.597644200281;4746.440169872595;4764.809407623657;4768.642351823558;5429.239906413105;5546.55627549795;5569.470900264469;5574.163875418639;5601.355844077983;1335.9398827052805;1358;1360.31984007996;1380.1856904426236;1394.5328315014583;934.5374039850182;967.2310513142069;969.676391725304;971.7813491964251;974.6899847361798;5148.716820574904;5159.17453207485;5197.816916894913;5226.503482169188;5227.895442091213;5412.215228791882;5453.727313634303;5458.216309682011;5501.872116216166;5561.221428999943;5172.431032586413;5198.81804136861;5221.477852214748;5261.526462618306;5467.726613669301;2902.6371703537056;2916.7666586673017;2923.2399576110365;2934.7652187824924;2949.896753613656;5714.971425142848;5751.252337196222;5752.619371350929;5761.510271626875;5806.82579522615;5478.753456094485;5614.967917324599;5646.915296270559;5659.830205093854;5663.745131469093;5728.570357223225;5734.741936612862;5756.251687280626;5756.856078597984;5757.5393968481585;5360.946390536044;5529.225908372911;5535.501804837584;5540.307461567304;5566.276384070045;5422.322209723785;5433.728313584384;5458.754356053908;5467.17992301158;5473.3055187748905;5707.6575405475805;5726;5730.570207234391;5733.5126514245085;5751.194832723339;3919.8236079377066;3971.7021223407783;4029.574861367931;4037.5558688544825;4043.5147782266317;5473.589480789036;5512.200730893917;5514.834554963358;5516.200150978166;5552.583556233218;5395.622306438511;5440.374356949002;5539.667619942817;5545.722713864371;5548.167774833807;5468.371137319259;5470.91793623104;5514.696691681996;5554.944450555443;5569.886022795376;5338.866528336823;5472.781088756406;5476.288082549243;5492.478214569769;5534.335879694301;5531.368246367251;5549.028919939075;5561.360443549043;5565.575367582701;5580.1629755537;5441.156620723794;5447.291852059207;5457.317835270591;5471.50756431923;5505.6696598204235 00:11:22 INFO - PROCESS | 22260 | |5;yui.html;666.7566338286526;748.1657951384201;750.6922161913617;752.6537792615396;851.6833124538877;13736;14411.423543058265;14414.423423063065;14433.927830360833;14507.637309067266;13245.602631921058;13293.734125317487;13409.262490563015;13495.932520337385;13522.323883805795;704.9400800931927;721.4949535325293;846.1496196322687;853.2789792625252;861.6984055580529;849.5327569836596;850.3707256630111;850.8425941200898;851;851.5401683091123;887.414306557672;894.168423366269;895.8566629339307;896.059137905197;896.5696465696437;882.8057827277988;887.4143065576753;893.4951752259952;893.5130353957077;893.8346405914895;653.2422390027592;653.6960313454266;654.3816093791369;654.5385503220218;654.5549026661868;12923.353832308441;13104.934475327658;13284.800727989088;13298.933505332412;13312.400941957636;13227.272500012496;14599.197044162567;14637.194954277511;14690.55928322152;14744.3365048572;11402.429878506124;11645;11646.242994205435;11691.590794322157;11862.822057669142;3631.473436351714;3656.524651795276;3664.263246555119;3693.445983102556;3695.1870588470492;58519.414805851826;59831.40168598345;60295.69852150711;61953;62805.37194628041;10059.94370591092;10303.278770486144;10373.585056597802;10445.791084178274;10834.729131771768;18828.341008064926;19025.524361890788;21051.052702628418;21919.452013699785;22174.778252217595;7781.301737378546;7840.647170877324;7858.174891636296;7909.24862138096;8236.711715089943;3976.2842688315804;4053.91892162161;4092.5293591237387;4239.618434340862;4398.846040388571;3558.5551806024246;3649.9635003650155;3652.579953305351;3653.2145588698027;3653.4519822026377;606.0515293565555;611.2634275697862;616.4113271825396;619.8667286533417;622.2874808344511;635.841039740065;650.4276236911487;754.5774366354859;764.7017663111391;774.7598244544209;9121.31590130743;9224.7693807654;9506.239500839916;9631.759206019906;9761.609535618638;645.1451826330132;648.3225029843825;653.4543656047159;689.0938415983067;764.7935057534546;4572.748498832596;4572.977135114304;4590.563896429834;4609.539046095364;4611.423572053493;54928;85170;89070.55464722635;90734.54632726795;91866.54066729757;73781;76099.61950190214;76649.23350766533;76687;77236.61381693168;45069.54930450719;63823.68088159622;65414;65446;67431.32568674348;8694.565271736514;8700.956495217737;8719.389642725202;8753.343499237455;8856.247218986458;46578.53421465877;47544.52455475401;47666.76166619144;48146.759266203444;50214.497855020985;42646.78676606721;56620;57100.428995711176;57719.422805771406;63784;11383.829242561535;12260.26438413698;12261.118637120448;12390.5663301784;12426.316552589695;13569.253691047088;13637.79543306871;13750.518731844337;13765.862341376458;13954;13188.208707477583;13519.459221631418;13556.186628801908;14001.43994240219;14183.929080354532;12259.460431834179;12823.422945967268;12823.93588032054;13102.344882756015;13167.341632918124;11215.158863085138;11955.222910510789;11972.16194866351;12150.02799775998;13566.186028838301;8933.28533717288;9113.134252246025;9334.159925606727;9455.858162127435;9670.419774813534;10182.592696292066;10816.242862999829;11035.282706624044;11333.206675532963;11754.11844111678 00:11:22 INFO - PROCESS | 22260 | __end_tp_report 00:11:22 INFO - PROCESS | 22260 | __start_cc_report 00:11:22 INFO - PROCESS | 22260 | _x_x_mozilla_cycle_collect,1004 00:11:22 INFO - PROCESS | 22260 | __end_cc_report 00:11:22 INFO - PROCESS | 22260 | __startTimestamp1485245482566__endTimestamp 00:11:22 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | ------- Summary: start ------- 00:11:22 INFO - PROCESS | 22260 | Number of tests: 6 00:11:22 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | [#0] dojo.html Cycles:165 Average:5504.05 Median:5661.46 stddev:610.32 (10.8%) stddev-sans-first:584.98 00:11:22 INFO - PROCESS | 22260 | Values: 3206.9 3241.3 3245.2 3276.6 3293.9 5466.9 5569.6 5579.2 5581.7 5607.7 5526.1 5587.0 5594.9 5609.6 5626.5 5056.6 5077.9 5114.4 5146.9 5162.1 4964.8 4994.1 5110.8 5166.1 5169.7 4970.3 4998.0 5003.1 5034.0 5081.1 5071.4 5162.3 5162.5 5163.5 5191.1 4858.7 5067.9 5082.0 5097.3 5140.1 5385.2 5394.5 5405.6 5428.1 5510.8 5844.2 5888.3 5947.1 5966.6 5973.7 5863.3 5994.9 6009.4 6026.7 6027.9 5452.2 5462.5 5519.1 5537.7 5544.3 6044.5 6048.1 6055.5 6063.2 6072.6 5690.9 5803.4 5810.8 5811.6 5820.5 5814.4 5877.1 5930.0 5938.3 6024.0 5963.9 5975.4 5977.5 5979.3 5979.9 5932.8 5992.1 5993.3 6011.8 6020.2 4419.0 4498.2 4503.0 4524.9 4561.0 4073.7 4098.8 4100.4 4122.3 4128.1 5574.6 5584.4 5587.6 5588.7 5621.2 5753.6 5769.4 5813.8 5845.4 5959.9 5625.7 5661.5 5662.8 5673.3 5690.7 5084.7 5093.7 5095.2 5099.1 5124.0 5895.3 6011.8 6078.1 6160.7 6169.0 5838.2 5954.5 5971.2 5988.8 6005.9 6162.4 6168.6 6175.8 6178.3 6194.0 5640.8 5811.7 5864.1 5868.9 5879.1 5832.3 5850.1 5868.8 5877.6 5975.9 5789.5 5792.3 5799.2 5801.6 5802.5 5773.7 5777.0 5782.0 5783.3 5787.3 5523.6 5608.1 5640.7 5642.4 5657.7 5744.1 5758.4 5778.6 5788.1 5801.0 5574.5 5622.0 5625.8 5639.0 5642.2 00:11:22 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | [#1] ext.html Cycles:180 Average:62482.95 Median:38139.62 stddev:130565.70 (342.3%) stddev-sans-first:130849.26 00:11:22 INFO - PROCESS | 22260 | Values: 581.5 621.8 641.5 657.6 685.2 34192.0 38136.6 38142.6 38146.8 44809.3 43461.3 47564.5 47622.3 47631.5 47663.5 8960.2 9090.3 9119.8 9121.5 9124.9 8493.8 8645.3 8928.3 9022.7 10656.7 10705.4 11147.8 11151.2 11156.8 11159.2 10994.6 11054.7 11058.2 11073.6 11080.3 10849.5 10915.5 10922.1 10929.6 10930.0 43619.0 43870.0 43884.3 43964.0 44113.8 3496.8 3554.4 3600.3 3638.3 3983.5 33228.7 33424.3 33453.5 33461.0 33602.2 4280.6 4430.7 4438.7 4479.1 4546.6 338897.0 339701.0 341687.0 342381.0 343142.0 38231.6 60518.7 60826.0 60857.0 60894.7 38978.6 40941.4 41275.2 41290.8 41307.6 14545.8 14625.7 14632.4 14634.5 14637.0 12669.9 12711.6 12739.3 12742.8 12749.7 8983.8 9211.2 9217.0 9279.1 9575.4 3602.3 3615.2 3639.5 3678.1 3690.2 985.0 1012.9 1101.3 1110.2 1181.3 31552.7 33510.0 33516.8 33746.3 33746.7 1108.7 1116.6 1206.1 1215.8 1235.0 15324.3 16506.5 18594.3 18843.4 19858.2 518822.0 540466.0 552553.0 557651.0 827192.0 60542.0 61192.0 61380.0 61418.4 61526.0 1386.6 1402.4 1441.6 1443.5 1447.3 31266.8 33701.3 33764.0 33844.5 34135.1 54862.0 55399.2 55475.7 55547.2 55562.4 472992.0 479700.0 480397.0 481653.0 481659.0 27323.7 27953.2 29755.0 30830.5 31456.0 43254.8 47205.0 47350.8 47993.5 48434.8 40699.0 40863.0 40983.2 41803.4 41931.8 40185.2 40474.8 40742.0 41592.8 42853.4 41226.4 41334.8 42000.6 42177.0 42369.4 33364.7 36254.6 36605.8 37100.4 37587.2 27918.4 28040.4 28176.7 28352.4 28411.1 00:11:22 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | [#2] jquery.html Cycles:180 Average:27493.48 Median:12746.30 stddev:71378.18 (560.0%) stddev-sans-first:71549.45 00:11:22 INFO - PROCESS | 22260 | Values: 408.4 414.4 421.9 425.8 444.8 18491.8 19645.2 19748.6 19795.7 20127.6 19449.2 19566.4 20514.1 20710.5 20722.7 5280.1 5501.6 5537.5 5581.4 5586.1 5507.7 5512.7 5527.6 5546.6 5765.7 5948.2 5986.9 5994.0 5996.4 5997.5 5785.3 5950.3 5968.2 5978.4 6014.9 5434.2 5435.8 5441.2 5441.4 5441.9 14941.2 22474.4 23144.7 23499.3 24768.8 2348.0 2376.2 2407.7 2489.3 2932.2 10388.1 10411.6 10514.6 10701.4 10849.7 1915.0 1978.3 2004.9 2008.3 2049.8 64668.0 64738.7 80104.2 83950.2 87659.1 10084.1 10168.6 10458.9 10494.8 11427.9 14201.7 14263.1 14298.5 14298.8 14301.1 7950.7 7979.7 8028.7 8102.5 8145.8 7915.3 7966.9 8153.8 8276.5 8359.2 4325.8 4413.7 4451.0 4524.1 4550.2 1963.9 2063.7 2075.6 2110.7 2127.5 898.3 965.3 975.1 1033.8 1081.6 19917.4 19993.9 20082.9 20155.8 20414.5 1008.0 1037.8 1064.2 1065.3 1087.0 10386.2 11169.9 11286.7 11292.4 11439.7 422378.0 424020.0 424098.0 434319.0 446832.0 90030.5 91303.0 92114.5 93823.0 104763.0 1037.9 1057.9 1058.4 1065.2 1066.8 17748.6 18259.2 18445.5 18562.2 18865.5 43618.3 43946.3 44169.1 44813.0 45307.8 60157.4 61050.0 61222.7 61413.4 62113.4 8748.7 8789.8 8807.5 8948.9 9335.3 10734.9 13568.6 13640.5 13838.9 13932.2 11840.3 12014.6 12022.5 12086.6 12480.6 10463.7 11080.9 11470.4 11843.8 11924.2 11096.9 11122.0 11970.0 12331.8 12355.1 7959.9 8870.9 8904.3 9068.8 9112.0 10447.3 11667.0 11706.6 11723.6 12047.0 00:11:22 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | [#3] mootools.html Cycles:180 Average:5779.62 Median:4776.96 stddev:3329.45 (69.7%) stddev-sans-first:3321.90 00:11:22 INFO - PROCESS | 22260 | Values: 1317.7 1419.1 1516.0 1626.1 1812.1 7610.4 7951.6 8645.1 8896.6 8915.9 8967.8 9064.5 9069.6 9074.9 9087.6 2465.9 2488.8 2490.7 2497.4 2497.5 2420.3 2457.2 2461.3 2465.7 2466.9 2415.6 2424.1 2438.9 2456.3 2461.7 2337.2 2399.2 2401.1 2407.3 2443.4 2235.2 2365.1 2379.4 2416.5 2416.8 8762.8 8815.3 8945.7 9045.6 9062.5 5410.7 5552.3 5578.5 5648.8 5651.6 3469.8 3514.0 3569.9 3575.8 3623.7 1162.3 1171.2 1171.9 1175.3 1225.8 12525.4 12525.7 12542.8 12551.4 12634.6 4424.6 4485.5 4581.3 4612.1 4615.7 9233.6 9239.0 9240.8 9243.4 9251.1 5282.6 5343.7 5355.0 5355.7 5358.7 4326.8 4482.9 4516.4 4648.7 5030.4 3964.9 3975.0 4058.2 4118.4 4127.3 1222.9 1261.8 1270.1 1278.8 1300.6 876.7 954.5 970.4 992.4 998.0 5622.2 5756.7 5897.0 6023.8 6064.1 485.6 486.8 506.2 515.4 515.4 3709.5 3722.8 3724.7 3736.8 3851.7 10926.5 11325.9 11433.6 11445.9 11455.1 11352.4 11373.6 11396.7 11410.8 11415.4 8232.3 8526.4 8620.5 8625.2 8661.3 5547.0 5579.9 5616.5 5665.8 5696.0 10056.7 10067.4 10103.8 10185.4 10197.9 10434.1 10438.5 10521.2 10546.4 10554.3 7518.8 7616.2 7633.8 7637.2 7648.4 8197.5 8268.6 8268.6 8287.5 8287.8 7368.6 7406.3 7529.9 7605.6 7685.9 7279.0 7342.4 7385.4 7389.7 7395.7 6861.2 6991.4 6999.9 7002.9 7007.8 4811.7 4835.6 4869.9 4974.6 5117.0 4698.8 4742.2 4939.8 5017.6 5080.7 00:11:22 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | [#4] prototype.html Cycles:180 Average:4639.47 Median:5293.22 stddev:1343.57 (25.4%) stddev-sans-first:1307.87 00:11:22 INFO - PROCESS | 22260 | Values: 332.4 333.1 344.5 345.5 348.4 5216.6 5278.8 5353.4 5357.7 5368.7 5127.8 5225.7 5229.5 5245.7 5267.8 4182.5 4192.2 4195.2 4206.3 4217.7 4146.2 4169.2 4212.8 4214.1 4239.5 4146.2 4154.3 4164.1 4168.7 4182.7 4145.6 4163.8 4178.8 4181.3 4199.8 3518.9 3672.9 3677.5 3689.5 3778.1 5147.1 5157.4 5158.6 5164.4 5184.9 4732.4 4751.4 4752.1 4773.5 4786.4 5307.6 5505.9 5541.6 5563.0 5597.3 4014.4 4016.0 4020.7 4028.5 4028.9 5740.6 5749.7 5755.2 5766.9 5793.9 4046.8 4054.6 4101.8 4115.7 4131.0 4122.6 4141.9 4157.4 4163.8 4181.6 4731.4 4733.6 4746.4 4764.8 4768.6 5429.2 5546.6 5569.5 5574.2 5601.4 1335.9 1358.0 1360.3 1380.2 1394.5 934.5 967.2 969.7 971.8 974.7 5148.7 5159.2 5197.8 5226.5 5227.9 5412.2 5453.7 5458.2 5501.9 5561.2 5172.4 5198.8 5221.5 5261.5 5467.7 2902.6 2916.8 2923.2 2934.8 2949.9 5715.0 5751.3 5752.6 5761.5 5806.8 5478.8 5615.0 5646.9 5659.8 5663.7 5728.6 5734.7 5756.3 5756.9 5757.5 5360.9 5529.2 5535.5 5540.3 5566.3 5422.3 5433.7 5458.8 5467.2 5473.3 5707.7 5726.0 5730.6 5733.5 5751.2 3919.8 3971.7 4029.6 4037.6 4043.5 5473.6 5512.2 5514.8 5516.2 5552.6 5395.6 5440.4 5539.7 5545.7 5548.2 5468.4 5470.9 5514.7 5554.9 5569.9 5338.9 5472.8 5476.3 5492.5 5534.3 5531.4 5549.0 5561.4 5565.6 5580.2 5441.2 5447.3 5457.3 5471.5 5505.7 00:11:22 INFO - PROCESS | 22260 | 00:11:22 INFO - PROCESS | 22260 | [#5] yui.html Cycles:180 Average:17111.04 Median:49180.63 stddev:22410.01 (45.6%) stddev-sans-first:22438.86 00:11:22 INFO - PROCESS | 22260 | Values: 666.8 748.2 750.7 752.7 851.7 13736.0 14411.4 14414.4 14433.9 14507.6 13245.6 13293.7 13409.3 13495.9 13522.3 704.9 721.5 846.1 853.3 861.7 849.5 850.4 850.8 851.0 851.5 887.4 894.2 895.9 896.1 896.6 882.8 887.4 893.5 893.5 893.8 653.2 653.7 654.4 654.5 654.6 12923.4 13104.9 13284.8 13298.9 13312.4 13227.3 14599.2 14637.2 14690.6 14744.3 11402.4 11645.0 11646.2 11691.6 11862.8 3631.5 3656.5 3664.3 3693.4 3695.2 58519.4 59831.4 60295.7 61953.0 62805.4 10059.9 10303.3 10373.6 10445.8 10834.7 18828.3 19025.5 21051.1 21919.5 22174.8 7781.3 7840.6 7858.2 7909.2 8236.7 3976.3 4053.9 4092.5 4239.6 4398.8 3558.6 3650.0 3652.6 3653.2 3653.5 606.1 611.3 616.4 619.9 622.3 635.8 650.4 754.6 764.7 774.8 9121.3 9224.8 9506.2 9631.8 9761.6 645.1 648.3 653.5 689.1 764.8 4572.7 4573.0 4590.6 4609.5 4611.4 54928.0 85170.0 89070.6 90734.5 91866.5 73781.0 76099.6 76649.2 76687.0 77236.6 45069.5 63823.7 65414.0 65446.0 67431.3 8694.6 8701.0 8719.4 8753.3 8856.2 46578.5 47544.5 47666.8 48146.8 50214.5 42646.8 56620.0 57100.4 57719.4 63784.0 11383.8 12260.3 12261.1 12390.6 12426.3 13569.3 13637.8 13750.5 13765.9 13954.0 13188.2 13519.5 13556.2 14001.4 14183.9 12259.5 12823.4 12823.9 13102.3 13167.3 11215.2 11955.2 11972.2 12150.0 13566.2 8933.3 9113.1 9334.2 9455.9 9670.4 10182.6 10816.2 11035.3 11333.2 11754.1 00:11:22 INFO - PROCESS | 22260 | -------- Summary: end -------- 00:11:22 INFO - PROCESS | 22260 | 00:11:23 INFO - TEST-INFO | 22260: exit 0 00:11:23 INFO - TEST-OK | dromaeo_css | took 1113574ms 00:11:23 INFO - TEST-START | kraken 00:11:23 INFO - operating with platform_type : linux_ 00:11:23 INFO - Initialising browser for kraken test... 00:11:23 INFO - TEST-INFO | started process 22563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnM7stb/profile http://localhost:58911/getInfo.html) 00:11:27 INFO - PROCESS | 22563 | __metrics Screen width/height:1600/1200 00:11:27 INFO - PROCESS | 22563 | colorDepth:24 00:11:27 INFO - PROCESS | 22563 | Browser inner width/height: 1024/697 00:11:27 INFO - PROCESS | 22563 | __metrics 00:11:27 INFO - PROCESS | 22563 | 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" 00:11:27 INFO - PROCESS | 22563 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:11:28 INFO - PROCESS | 22563 | console.error: PushService: 00:11:28 INFO - PROCESS | 22563 | stateChangeProcessEnqueue: Error transitioning state 00:11:28 INFO - PROCESS | 22563 | UnknownError 00:11:28 INFO - TEST-INFO | 22563: exit 0 00:11:28 INFO - Browser initialized. 00:11:28 INFO - Running cycle 1/1 for kraken test... 00:11:28 INFO - TEST-INFO | started process 22654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnM7stb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:11:40 INFO - PROCESS | 22654 | RSS: Main: 142114816 00:11:40 INFO - PROCESS | 22654 | 00:11:42 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58911/tests/kraken/driver.html?testName=audio-beat-detection) 00:11:43 INFO - PROCESS | 22654 | RSS: Main: 183738368 00:11:43 INFO - PROCESS | 22654 | 00:11:46 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58911/tests/kraken/driver.html?testName=audio-dft) 00:11:46 INFO - PROCESS | 22654 | RSS: Main: 173182976 00:11:46 INFO - PROCESS | 22654 | 00:11:49 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58911/tests/kraken/driver.html?testName=audio-fft) 00:11:50 INFO - PROCESS | 22654 | RSS: Main: 264491008 00:11:50 INFO - PROCESS | 22654 | 00:11:52 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58911/tests/kraken/driver.html?testName=audio-oscillator) 00:11:52 INFO - PROCESS | 22654 | RSS: Main: 171175936 00:11:52 INFO - PROCESS | 22654 | 00:11:55 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:11:55 INFO - PROCESS | 22654 | RSS: Main: 173789184 00:11:55 INFO - PROCESS | 22654 | 00:11:58 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58911/tests/kraken/driver.html?testName=imaging-darkroom) 00:11:59 INFO - PROCESS | 22654 | RSS: Main: 211730432 00:11:59 INFO - PROCESS | 22654 | 00:12:02 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58911/tests/kraken/driver.html?testName=imaging-desaturate) 00:12:03 INFO - PROCESS | 22654 | RSS: Main: 210743296 00:12:03 INFO - PROCESS | 22654 | 00:12:05 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58911/tests/kraken/driver.html?testName=json-parse-financial) 00:12:06 INFO - PROCESS | 22654 | RSS: Main: 209268736 00:12:06 INFO - PROCESS | 22654 | 00:12:07 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:12:08 INFO - PROCESS | 22654 | RSS: Main: 171720704 00:12:08 INFO - PROCESS | 22654 | 00:12:10 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58911/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:12:10 INFO - PROCESS | 22654 | RSS: Main: 177946624 00:12:10 INFO - PROCESS | 22654 | 00:12:12 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:12:13 INFO - PROCESS | 22654 | RSS: Main: 188096512 00:12:13 INFO - PROCESS | 22654 | 00:12:15 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:12:16 INFO - PROCESS | 22654 | RSS: Main: 195969024 00:12:16 INFO - PROCESS | 22654 | 00:12:19 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:12:19 INFO - PROCESS | 22654 | RSS: Main: 192458752 00:12:19 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:58911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58911/tests/kraken/driver.html?testName=ai-astar) 00:12:21 INFO - PROCESS | 22654 | RSS: Main: 243896320 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | __start_tp_report 00:12:21 INFO - PROCESS | 22654 | _x_x_mozilla_page_load 00:12:21 INFO - PROCESS | 22654 | _x_x_mozilla_page_load_details 00:12:21 INFO - PROCESS | 22654 | |i|pagename|runs| 00:12:21 INFO - PROCESS | 22654 | |0;ai-astar;100;110;110;109;110;109;110;109;111;110 00:12:21 INFO - PROCESS | 22654 | |1;audio-beat-detection;149;123;124;171;123;121;119;121;151;124 00:12:21 INFO - PROCESS | 22654 | |2;audio-dft;160;159;160;160;161;161;161;163;160;161 00:12:21 INFO - PROCESS | 22654 | |3;audio-fft;74;75;75;103;75;77;75;76;108;75 00:12:21 INFO - PROCESS | 22654 | |4;audio-oscillator;82;81;107;82;82;83;98;82;82;111 00:12:21 INFO - PROCESS | 22654 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;116;117;117 00:12:21 INFO - PROCESS | 22654 | |6;imaging-darkroom;146;145;145;146;146;146;145;146;147;147 00:12:21 INFO - PROCESS | 22654 | |7;imaging-desaturate;85;85;85;85;85;85;85;84;85;85 00:12:21 INFO - PROCESS | 22654 | |8;json-parse-financial;52;53;52;49;54;51;53;51;50;51 00:12:21 INFO - PROCESS | 22654 | |9;json-stringify-tinderbox;59;60;59;60;70;60;59;60;60;59 00:12:21 INFO - PROCESS | 22654 | |10;stanford-crypto-aes;79;74;83;77;83;75;77;75;73;79 00:12:21 INFO - PROCESS | 22654 | |11;stanford-crypto-ccm;125;122;123;122;128;120;121;122;160;119 00:12:21 INFO - PROCESS | 22654 | |12;stanford-crypto-pbkdf2;156;156;155;157;157;163;162;159;154;152 00:12:21 INFO - PROCESS | 22654 | |13;stanford-crypto-sha256-iterative;64;61;62;62;63;62;62;62;61;61 00:12:21 INFO - PROCESS | 22654 | __end_tp_report 00:12:21 INFO - PROCESS | 22654 | __start_cc_report 00:12:21 INFO - PROCESS | 22654 | _x_x_mozilla_cycle_collect,1564 00:12:21 INFO - PROCESS | 22654 | __end_cc_report 00:12:21 INFO - PROCESS | 22654 | __startTimestamp1485245541615__endTimestamp 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | ------- Summary: start ------- 00:12:21 INFO - PROCESS | 22654 | Number of tests: 14 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.16 (2.9%) stddev-sans-first:0.67 00:12:21 INFO - PROCESS | 22654 | Values: 100.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 111.0 110.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:124.00 stddev:17.85 (14.4%) stddev-sans-first:17.92 00:12:21 INFO - PROCESS | 22654 | Values: 149.0 123.0 124.0 171.0 123.0 121.0 119.0 121.0 151.0 124.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 00:12:21 INFO - PROCESS | 22654 | Values: 160.0 159.0 160.0 160.0 161.0 161.0 161.0 163.0 160.0 161.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:12.83 (17.1%) stddev-sans-first:13.34 00:12:21 INFO - PROCESS | 22654 | Values: 74.0 75.0 75.0 103.0 75.0 77.0 75.0 76.0 108.0 75.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:11.71 (14.3%) stddev-sans-first:12.14 00:12:21 INFO - PROCESS | 22654 | Values: 82.0 81.0 107.0 82.0 82.0 83.0 98.0 82.0 82.0 111.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 00:12:21 INFO - PROCESS | 22654 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 00:12:21 INFO - PROCESS | 22654 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 147.0 147.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 00:12:21 INFO - PROCESS | 22654 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.51 (2.9%) stddev-sans-first:1.59 00:12:21 INFO - PROCESS | 22654 | Values: 52.0 53.0 52.0 49.0 54.0 51.0 53.0 51.0 50.0 51.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:3.34 (5.6%) stddev-sans-first:3.49 00:12:21 INFO - PROCESS | 22654 | Values: 59.0 60.0 59.0 60.0 70.0 60.0 59.0 60.0 60.0 59.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:3.50 (4.5%) stddev-sans-first:3.67 00:12:21 INFO - PROCESS | 22654 | Values: 79.0 74.0 83.0 77.0 83.0 75.0 77.0 75.0 73.0 79.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:122.50 stddev:12.15 (9.9%) stddev-sans-first:12.87 00:12:21 INFO - PROCESS | 22654 | Values: 125.0 122.0 123.0 122.0 128.0 120.0 121.0 122.0 160.0 119.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.00 stddev:3.41 (2.2%) stddev-sans-first:3.60 00:12:21 INFO - PROCESS | 22654 | Values: 156.0 156.0 155.0 157.0 157.0 163.0 162.0 159.0 154.0 152.0 00:12:21 INFO - PROCESS | 22654 | 00:12:21 INFO - PROCESS | 22654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:0.94 (1.5%) stddev-sans-first:0.67 00:12:21 INFO - PROCESS | 22654 | Values: 64.0 61.0 62.0 62.0 63.0 62.0 62.0 62.0 61.0 61.0 00:12:21 INFO - PROCESS | 22654 | -------- Summary: end -------- 00:12:21 INFO - PROCESS | 22654 | 00:12:22 INFO - TEST-INFO | 22654: exit 0 00:12:22 INFO - TEST-OK | kraken | took 59279ms 00:12:22 INFO - SUITE-END | took 1172s 00:12:22 INFO - Completed test suite (00:19:33) 00:12:22 INFO - javascript benchmark 00:12:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3206.9358612827746, 3241.2869168782872, 3245.2211469247386, 3276.6068071831382, 3293.868245270188, 5466.890662186754, 5569.582281328906, 5579.1910173024835, 5581.6930068846195, 5607.7476513556885, 5526.06056970315, 5587.0, 5594.86012849679, 5609.57928155389, 5626.493615574597, 5056.620753443497, 5077.923831142536, 5114.386273647149, 5146.897062058757, 5162.096633089194, 4964.776585053663, 4994.076095922266, 5110.821121260757, 5166.095933211692, 5169.6898186108765, 4970.329005584236, 4997.975010124945, 5003.149464591028, 5033.993201359743, 5081.1108056090225, 5071.391433028023, 5162.277281180638, 5162.483751624845, 5163.457836927144, 5191.091558977164, 4858.708477491362, 5067.873303167414, 5082.0, 5097.2608971699265, 5140.126178549655, 5385.21914322425, 5394.460553944614, 5405.621606487547, 5428.104362780136, 5510.779568817243, 5844.240248767675, 5888.322842873082, 5947.078202878561, 5966.612170208922, 5973.671448070354, 5863.3257175424515, 5994.880102397971, 6009.429104235091, 6026.728797204137, 6027.939720602782, 5452.154915988028, 5462.5083742462975, 5519.116941289455, 5537.667739935617, 5544.3346798384455, 6044.516438684895, 6048.123022161762, 6055.455009049207, 6063.181470501514, 6072.605280656743, 5690.857728556819, 5803.419658034163, 5810.825675229666, 5811.56413268998, 5820.505257053113, 5814.389489103668, 5877.089051197071, 5929.970350148308, 5938.28740551128, 6023.969880150571, 5963.850903727442, 5975.43233392827, 5977.462028417463, 5979.342272350038, 5979.9402005980255, 5932.822015339547, 5992.0712289595185, 5993.250843644544, 6011.849703757353, 6020.217371741645, 4418.977905110454, 4498.212812757754, 4502.954970450319, 4524.932126018112, 4560.954390456053, 4073.674106071507, 4098.815553300109, 4100.425940368351, 4122.2786012448305, 4128.1330920506425, 5574.609777315549, 5584.357798853102, 5587.580931430159, 5588.720563971867, 5621.241132447149, 5753.597248192586, 5769.365369809318, 5813.79651712188, 5845.357010728816, 5959.880802383928, 5625.662460252398, 5661.46216109469, 5662.8301150965535, 5673.290838645169, 5690.658560486384, 5084.694918304914, 5093.651665750946, 5095.184770436712, 5099.082165210223, 5124.0, 5895.263092113486, 6011.819645410645, 6078.118672792509, 6160.661163636043, 6169.043798211284, 5838.211841401357, 5954.46409823118, 5971.164037034731, 5988.760449581968, 6005.939940600538, 6162.352952939877, 6168.599041062316, 6175.814725558241, 6178.258608966773, 6193.969030155001, 5640.830775076754, 5811.680357580373, 5864.06175011996, 5868.911966320594, 5879.147523609138, 5832.300123985149, 5850.12248162779, 5868.765249390148, 5877.588568800143, 5975.940240597538, 5789.507891829242, 5792.333881603669, 5799.246098007232, 5801.5938884279385, 5802.5357971361345, 5773.711314434177, 5777.046787280052, 5781.971090144522, 5783.306003279633, 5787.276590426197, 5523.6409633373705, 5608.130739735348, 5640.689762063126, 5642.351129620146, 5657.688827114548, 5744.080947048452, 5758.395368486249, 5778.566607504538, 5788.131780232999, 5800.970995144998, 5574.470425309589, 5622.044252477171, 5625.774969001194, 5639.041362968387, 5642.181883626933], "value": 5463.997377776319, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.5434883616359, 621.7637297826826, 641.4804008752909, 657.6054367379572, 685.2051620120661, 34192.0, 38136.618633813654, 38142.61857381429, 38146.809265953634, 44809.32786008212, 43461.34807977883, 47564.524354756526, 47622.28566571504, 47631.52368476314, 47663.52336476634, 8960.193582577584, 9090.318226133033, 9119.772005699877, 9121.543922803834, 9124.863127053099, 8493.787655308604, 8645.308375329958, 8928.330375221853, 9022.729318120468, 10656.733581660443, 10705.411202383866, 11147.832782508269, 11151.163662725288, 11156.832647510293, 11159.163062770283, 10994.560217591286, 11054.723631909186, 11058.170637202242, 11073.557057717682, 11080.335179889233, 10849.457527123612, 10915.508802103925, 10922.126229901589, 10929.617463388744, 10930.0, 43619.0, 43870.0, 43884.341734873684, 43964.0, 44113.77943110264, 3496.8426420811124, 3554.431290993429, 3600.3339382214112, 3638.326909521747, 3983.521977362735, 33228.6677133228, 33424.331513369594, 33453.49819752706, 33461.0, 33602.1599460013, 4280.59334363235, 4430.712003719748, 4438.667099967483, 4479.10417916418, 4546.568076032805, 338897.0, 339701.0, 341687.0, 342381.0, 343142.0, 38231.617683822806, 60518.697406512685, 60826.0, 60857.0, 60894.69552652208, 38978.6102138975, 40941.38587921183, 41275.1744965105, 41290.79354603208, 41307.58692413037, 14545.78181327281, 14625.707485850224, 14632.414703411745, 14634.487792927197, 14637.0, 12669.873301267055, 12711.55509557161, 12739.299338536284, 12742.80885786714, 12749.681257968625, 8983.77540561478, 9211.170994610517, 9216.953915230515, 9279.118483744034, 9575.425474471554, 3602.2615363850346, 3615.168511242429, 3639.454081887738, 3678.0988657779017, 3690.206605579813, 984.950752462374, 1012.9442880641635, 1101.3336931156534, 1110.245033377295, 1181.2794195540714, 31552.684473155434, 33510.0, 33516.832415837765, 33746.325073498396, 33746.662533374845, 1108.6895669212633, 1116.5812820192427, 1206.1255589697398, 1215.7629262293767, 1234.9876501234874, 15324.310406031755, 16506.504804855875, 18594.25622975066, 18843.434696959113, 19858.205671773256, 518822.0, 540466.0, 552553.0, 557651.0, 827192.0, 60542.0, 61192.0, 61380.0, 61418.385816141265, 61526.0, 1386.5840247925582, 1402.446033816657, 1441.6035590212566, 1443.5164219986423, 1447.3269929482842, 31266.843665782435, 33701.3259734799, 33764.0, 33844.492332615526, 34135.146621333675, 54862.0, 55399.16901246404, 55475.72262138664, 55547.16679249895, 55562.44437555573, 472992.0, 479700.0, 480397.0, 481653.0, 481659.0, 27323.72676273212, 27953.161405157065, 29755.0, 30830.53754193644, 31456.0, 43254.783726081165, 47205.0, 47350.763246183546, 47993.520064798904, 48434.75782621205, 40699.0, 40863.0, 40983.18033639251, 41803.37294940639, 41931.7903410481, 40185.1962960745, 40474.797626011685, 40742.0, 41592.792036039624, 42853.357199642654, 41226.38160427536, 41334.79332603318, 42000.57999419967, 42177.0, 42369.36445953252, 33364.66635333616, 36254.637453625124, 36605.81697091604, 37100.44349334816, 37587.248255035294, 27918.44163116767, 28040.439191215653, 28176.71823281741, 28352.43295134127, 28411.147665570064], "value": 19846.206050960234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.3935355996347, 414.37636357282287, 421.91350773091517, 425.7892343290072, 444.79317117540336, 18491.815081849178, 19645.214191432362, 19748.605027899433, 19795.70306445401, 20127.59744805103, 19449.222031118774, 19566.413007609794, 20514.076866541003, 20710.48223794406, 20722.68915966258, 5280.102382594959, 5501.559875209973, 5537.501624853762, 5581.413951535092, 5586.10622300432, 5507.669539827623, 5512.669239845602, 5527.55779537638, 5546.611737178399, 5765.68288744121, 5948.1969934059, 5986.8802623947495, 5994.0, 5996.430339117776, 5997.460228579427, 5785.334686511063, 5950.285965684146, 5968.164456976006, 5978.40215978403, 6014.879702405971, 5434.239206511092, 5435.809746658848, 5441.238226648273, 5441.374241962186, 5441.891162176735, 14941.17823519706, 22474.43813904649, 23144.65283020756, 23499.29502114939, 24768.752312476823, 2347.953040939172, 2376.2277259890434, 2407.65089062085, 2489.253224032801, 2932.237618219257, 10388.117010054155, 10411.583536658525, 10514.579416823319, 10701.411422371766, 10849.67450976464, 1914.9712754308696, 1978.2581531925528, 2004.9097790599458, 2008.3171721614722, 2049.764277108122, 64668.0, 64738.67630661864, 80104.19895801083, 83950.16049839485, 87659.12340876638, 10084.142847858015, 10168.593256269667, 10458.895411045793, 10494.842577361345, 11427.942860285812, 14201.715965680629, 14263.07290026145, 14298.499552515612, 14298.785518217235, 14301.141931484144, 7950.7217247396065, 7979.723244280887, 8028.715405535087, 8102.473339232931, 8145.755627331189, 7915.287624113857, 7966.920330796734, 8153.79615509617, 8276.544790036605, 8359.164083591713, 4325.84859529915, 4413.713108647992, 4450.955490445119, 4524.0951809637545, 4550.203714349976, 1963.9198440857472, 2063.6801295799173, 2075.564131532395, 2110.6622940329476, 2127.5319429725437, 898.2723993565234, 965.3098034905076, 975.0882924465648, 1033.7570670892335, 1081.5889961814617, 19917.402477925687, 19993.900030500045, 20082.89958550198, 20155.79844201539, 20414.489637759176, 1007.9798404031878, 1037.7509397744486, 1064.2337516987757, 1065.2649671726483, 1086.9891301087046, 10386.169106471463, 11169.931180518812, 11286.717832054264, 11292.378919159524, 11439.656810295704, 422378.0, 424020.0, 424098.0, 434319.0, 446832.0, 90030.54984725034, 91303.0, 92114.53942730243, 93823.0, 104763.0, 1037.911777498921, 1057.9100776433936, 1058.4229498047853, 1065.2330322168027, 1066.7973085113804, 17748.55628609295, 18259.178336975132, 18445.53886152857, 18562.164702588147, 18865.528361790515, 43618.34572481479, 43946.34080488731, 44169.11661766811, 44813.0, 45307.773461132485, 60157.39842601518, 61050.0, 61222.69388653028, 61413.385866140765, 62113.378866212566, 8748.69379571712, 8789.824203515765, 8807.471551706918, 8948.910510895068, 9335.346525743133, 10734.892651073389, 13568.59294221175, 13640.522581709592, 13838.861611383758, 13932.164070155823, 11840.28958262507, 12014.579489717818, 12022.458989345676, 12086.576969806014, 12480.625581232578, 10463.68608941733, 11080.944595276973, 11470.369129697947, 11843.822342665038, 11924.165308428674, 11096.889031109586, 11122.0, 11970.0, 12331.828476294737, 12355.135140540076, 7959.920400795918, 8870.911290887008, 8904.287656987295, 9068.818623627623, 9112.043235460447, 10447.320924139907, 11667.0, 11706.590269340531, 11723.589674361356, 12047.0], "value": 9308.165976056922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.7298653775977, 1419.0988722161428, 1516.0448917182175, 1626.138146782205, 1812.1482903035576, 7610.391168706504, 7951.602419879005, 8645.13548645136, 8896.555172241395, 8915.866262006075, 8967.775805604862, 9064.45613263203, 9069.591868365922, 9074.909250907489, 9087.636494540227, 2465.9136930207446, 2488.8382255153447, 2490.6762120924254, 2497.3756560859783, 2497.463045445229, 2420.286015625386, 2457.1891275879007, 2461.2739241923587, 2465.6671349367784, 2466.938326541833, 2415.577273977047, 2424.054618698709, 2438.9024439022505, 2456.299954512964, 2461.6676748638974, 2337.181986304788, 2399.1602938971396, 2401.0875867170453, 2407.277816655014, 2443.3525115844313, 2235.1841577823975, 2365.077619728307, 2379.3694670912223, 2416.5408572371193, 2416.7583241675866, 8762.824743505094, 8815.338849586307, 8945.73162805117, 9045.638174473013, 9062.501562414065, 5410.729463526808, 5552.278203833475, 5578.497935185812, 5648.830535083954, 5651.576131790132, 3469.7918124912335, 3514.0, 3569.928601427983, 3575.821208939569, 3623.7282203834816, 1162.3316592959081, 1171.1860257121305, 1171.8691462738414, 1175.253713891685, 1225.785487539677, 12525.43635536403, 12525.686857828536, 12542.811857822231, 12551.435185416587, 12634.557790477289, 4424.646028317727, 4485.529019452975, 4581.266997280419, 4612.077584483117, 4615.746133962664, 9233.630654773733, 9238.983711791698, 9240.815183696423, 9243.352965292499, 9251.121143491358, 5282.577393808486, 5343.679379237258, 5354.973225133849, 5355.7054362009685, 5358.678479291255, 4326.805293761725, 4482.8655140345845, 4516.3902873112365, 4648.697834640738, 5030.3963524377305, 3964.9008774780286, 3974.980125099356, 4058.228936502055, 4118.361653943583, 4127.277726397869, 1222.9082818788627, 1261.79180435229, 1270.1299609767339, 1278.7570361631447, 1300.5578103444875, 876.7150676030316, 954.5465903695828, 970.4371464550544, 992.4095163377779, 998.026923749353, 5622.240997465372, 5756.7121643917635, 5896.970515147397, 6023.759049638053, 6064.06007068905, 485.62364167769556, 486.84907678619743, 506.1648280337399, 515.4201523286303, 515.4304493534665, 3709.4621279914263, 3722.813859307024, 3724.7206459515646, 3736.7944763038295, 3851.6533511983494, 10926.508307126198, 11325.943370283096, 11433.59982400612, 11445.885541144482, 11455.140864435201, 11352.37561934085, 11373.601923932789, 11396.658100257006, 11410.828837567444, 11415.372154531415, 8232.300254478436, 8526.403151779316, 8620.525871077025, 8625.223729864218, 8661.263792577576, 5546.97226513881, 5579.944200557942, 5616.466435688603, 5665.773369065191, 5696.0, 10056.69829905104, 10067.395956242648, 10103.797924041331, 10185.439800811026, 10197.9490102549, 10434.113100386552, 10438.53026613789, 10521.210909181995, 10546.419946902994, 10554.261201715806, 7518.774436766906, 7616.20029896875, 7633.770986870402, 7637.198094200029, 7648.388128949782, 8197.46716463428, 8268.627911744106, 8268.627911744106, 8287.50274983503, 8287.751367458986, 7368.59472729005, 7406.296401841816, 7529.88705169412, 7605.619719014137, 7685.923140768521, 7278.96360518194, 7342.449316301406, 7385.409167266498, 7389.667464963982, 7395.7411490599725, 6861.176658800976, 6991.405730512964, 6999.860002799814, 7002.929970700227, 7007.754728584475, 4811.735354555533, 4835.564799168092, 4869.9026019480125, 4974.5771609413605, 5117.0, 4698.788554514987, 4742.193827049341, 4939.827106051271, 5017.623678224075, 5080.669756465818], "value": 4567.043222563811, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.38897285004106, 333.05412628136094, 344.4557598993589, 345.52490325802023, 348.4181417033554, 5216.634835561512, 5278.841634750959, 5353.357597088345, 5357.678539287645, 5368.731563421833, 5127.7948882044675, 5225.6603320784125, 5229.529342359187, 5245.659032162906, 5267.789288428458, 4182.519010313822, 4192.203481338551, 4195.160967806451, 4206.326987681971, 4217.704760666755, 4146.232946904832, 4169.207240886418, 4212.7682977436225, 4214.051838336381, 4239.47006624172, 4146.201314112976, 4154.273002224599, 4164.146349998243, 4168.687348448879, 4182.728122672017, 4145.647619952308, 4163.812628431728, 4178.770167640779, 4181.310083836163, 4199.782063201668, 3518.9296214075575, 3672.944905826415, 3677.5403074615674, 3689.5019172411917, 3778.1310298631192, 5147.121300725245, 5157.355330583677, 5158.561522270612, 5164.354455693038, 5184.896302073975, 4732.367333270016, 4751.40607424072, 4752.120857641347, 4773.4510531289, 4786.449558300805, 5307.601929855237, 5505.944940550583, 5541.556675465993, 5563.0, 5597.272354593917, 4014.3577027675724, 4016.0, 4020.6783457323636, 4028.47629808126, 4028.9194216115516, 5740.5981581289325, 5749.712514374264, 5755.194272801811, 5766.942330576682, 5793.855153621151, 4046.7571945683353, 4054.614811592953, 4101.815418306183, 4115.670746340285, 4130.979345103256, 4122.587741225853, 4141.875743727693, 4157.438745769343, 4163.770992595436, 4181.581841815855, 4731.432228132646, 4733.597644200281, 4746.440169872595, 4764.809407623657, 4768.642351823558, 5429.239906413105, 5546.55627549795, 5569.470900264469, 5574.163875418639, 5601.355844077983, 1335.9398827052805, 1358.0, 1360.31984007996, 1380.1856904426236, 1394.5328315014583, 934.5374039850182, 967.2310513142069, 969.676391725304, 971.7813491964251, 974.6899847361798, 5148.716820574904, 5159.17453207485, 5197.816916894913, 5226.503482169188, 5227.895442091213, 5412.215228791882, 5453.727313634303, 5458.216309682011, 5501.872116216166, 5561.221428999943, 5172.431032586413, 5198.81804136861, 5221.477852214748, 5261.526462618306, 5467.726613669301, 2902.6371703537056, 2916.7666586673017, 2923.2399576110365, 2934.7652187824924, 2949.896753613656, 5714.971425142848, 5751.252337196222, 5752.619371350929, 5761.510271626875, 5806.82579522615, 5478.753456094485, 5614.967917324599, 5646.915296270559, 5659.830205093854, 5663.745131469093, 5728.570357223225, 5734.741936612862, 5756.251687280626, 5756.856078597984, 5757.5393968481585, 5360.946390536044, 5529.225908372911, 5535.501804837584, 5540.307461567304, 5566.276384070045, 5422.322209723785, 5433.728313584384, 5458.754356053908, 5467.17992301158, 5473.3055187748905, 5707.6575405475805, 5726.0, 5730.570207234391, 5733.5126514245085, 5751.194832723339, 3919.8236079377066, 3971.7021223407783, 4029.574861367931, 4037.5558688544825, 4043.5147782266317, 5473.589480789036, 5512.200730893917, 5514.834554963358, 5516.200150978166, 5552.583556233218, 5395.622306438511, 5440.374356949002, 5539.667619942817, 5545.722713864371, 5548.167774833807, 5468.371137319259, 5470.91793623104, 5514.696691681996, 5554.944450555443, 5569.886022795376, 5338.866528336823, 5472.781088756406, 5476.288082549243, 5492.478214569769, 5534.335879694301, 5531.368246367251, 5549.028919939075, 5561.360443549043, 5565.575367582701, 5580.1629755537, 5441.156620723794, 5447.291852059207, 5457.317835270591, 5471.50756431923, 5505.6696598204235], "value": 4212.555765208129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.7566338286526, 748.1657951384201, 750.6922161913617, 752.6537792615396, 851.6833124538877, 13736.0, 14411.423543058265, 14414.423423063065, 14433.927830360833, 14507.637309067266, 13245.602631921058, 13293.734125317487, 13409.262490563015, 13495.932520337385, 13522.323883805795, 704.9400800931927, 721.4949535325293, 846.1496196322687, 853.2789792625252, 861.6984055580529, 849.5327569836596, 850.3707256630111, 850.8425941200898, 851.0, 851.5401683091123, 887.414306557672, 894.168423366269, 895.8566629339307, 896.059137905197, 896.5696465696437, 882.8057827277988, 887.4143065576753, 893.4951752259952, 893.5130353957077, 893.8346405914895, 653.2422390027592, 653.6960313454266, 654.3816093791369, 654.5385503220218, 654.5549026661868, 12923.353832308441, 13104.934475327658, 13284.800727989088, 13298.933505332412, 13312.400941957636, 13227.272500012496, 14599.197044162567, 14637.194954277511, 14690.55928322152, 14744.3365048572, 11402.429878506124, 11645.0, 11646.242994205435, 11691.590794322157, 11862.822057669142, 3631.473436351714, 3656.524651795276, 3664.263246555119, 3693.445983102556, 3695.1870588470492, 58519.414805851826, 59831.40168598345, 60295.69852150711, 61953.0, 62805.37194628041, 10059.94370591092, 10303.278770486144, 10373.585056597802, 10445.791084178274, 10834.729131771768, 18828.341008064926, 19025.524361890788, 21051.052702628418, 21919.452013699785, 22174.778252217595, 7781.301737378546, 7840.647170877324, 7858.174891636296, 7909.24862138096, 8236.711715089943, 3976.2842688315804, 4053.91892162161, 4092.5293591237387, 4239.618434340862, 4398.846040388571, 3558.5551806024246, 3649.9635003650155, 3652.579953305351, 3653.2145588698027, 3653.4519822026377, 606.0515293565555, 611.2634275697862, 616.4113271825396, 619.8667286533417, 622.2874808344511, 635.841039740065, 650.4276236911487, 754.5774366354859, 764.7017663111391, 774.7598244544209, 9121.31590130743, 9224.7693807654, 9506.239500839916, 9631.759206019906, 9761.609535618638, 645.1451826330132, 648.3225029843825, 653.4543656047159, 689.0938415983067, 764.7935057534546, 4572.748498832596, 4572.977135114304, 4590.563896429834, 4609.539046095364, 4611.423572053493, 54928.0, 85170.0, 89070.55464722635, 90734.54632726795, 91866.54066729757, 73781.0, 76099.61950190214, 76649.23350766533, 76687.0, 77236.61381693168, 45069.54930450719, 63823.68088159622, 65414.0, 65446.0, 67431.32568674348, 8694.565271736514, 8700.956495217737, 8719.389642725202, 8753.343499237455, 8856.247218986458, 46578.53421465877, 47544.52455475401, 47666.76166619144, 48146.759266203444, 50214.497855020985, 42646.78676606721, 56620.0, 57100.428995711176, 57719.422805771406, 63784.0, 11383.829242561535, 12260.26438413698, 12261.118637120448, 12390.5663301784, 12426.316552589695, 13569.253691047088, 13637.79543306871, 13750.518731844337, 13765.862341376458, 13954.0, 13188.208707477583, 13519.459221631418, 13556.186628801908, 14001.43994240219, 14183.929080354532, 12259.460431834179, 12823.422945967268, 12823.93588032054, 13102.344882756015, 13167.341632918124, 11215.158863085138, 11955.222910510789, 11972.16194866351, 12150.02799775998, 13566.186028838301, 8933.28533717288, 9113.134252246025, 9334.159925606727, 9455.858162127435, 9670.419774813534, 10182.592696292066, 10816.242862999829, 11035.282706624044, 11333.206675532963, 11754.11844111678], "value": 7008.609148318779, "unit": "score"}], "name": "dromaeo_css", "value": 7172.186853392588, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 111.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 124.0, 171.0, 123.0, 121.0, 119.0, 121.0, 151.0, 124.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 160.0, 161.0, 161.0, 161.0, 163.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 103.0, 75.0, 77.0, 75.0, 76.0, 108.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 107.0, 82.0, 82.0, 83.0, 98.0, 82.0, 82.0, 111.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 49.0, 54.0, 51.0, 53.0, 51.0, 50.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 70.0, 60.0, 59.0, 60.0, 60.0, 59.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 83.0, 77.0, 83.0, 75.0, 77.0, 75.0, 73.0, 79.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 123.0, 122.0, 128.0, 120.0, 121.0, 122.0, 160.0, 119.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 155.0, 157.0, 157.0, 163.0, 162.0, 159.0, 154.0, 152.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1454.8, "alertThreshold": 2.0}]} 00:12:22 INFO - Return code: 0 00:12:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:12:22 INFO - # TBPL SUCCESS # 00:12:22 INFO - Running post-action listener: _resource_record_post_action 00:12:22 INFO - [mozharness: 2017-01-24 08:12:22.947683Z] Finished run-tests step (success) 00:12:22 INFO - Running post-run listener: _resource_record_post_run 00:12:23 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321380352; Read time: 16; Write time: 161688 00:12:23 INFO - TinderboxPrint: CPU usage
13.0% 00:12:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:12:23 INFO - TinderboxPrint: I/O write bytes / time
321,380,352 / 161,688 00:12:23 INFO - TinderboxPrint: CPU idle
8,247.3 (87.0%) 00:12:23 INFO - TinderboxPrint: CPU user
1,188.0 (12.5%) 00:12:23 INFO - TinderboxPrint: Swap in / out
0 / 0 00:12:23 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100945920; Read time: 0; Write time: 74844 00:12:23 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219508736; Read time: 16; Write time: 86820 00:12:23 INFO - Running post-run listener: _upload_blobber_files 00:12:23 INFO - Blob upload gear active. 00:12:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:12:23 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 00:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:12:23 INFO - (blobuploader) - INFO - Open directory for files ... 00:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:12:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:12:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:27 INFO - (blobuploader) - INFO - Done attempting. 00:12:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:12:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:12:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:27 INFO - (blobuploader) - INFO - Done attempting. 00:12:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:12:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:12:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:28 INFO - (blobuploader) - INFO - Done attempting. 00:12:28 INFO - (blobuploader) - INFO - Iteration through files over. 00:12:28 INFO - Return code: 0 00:12:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:12:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:12:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140666db3bd5c09d760b155c99652e6b49b8d2bd02b2a396c8e9f5f567652b9cc0e808b09c6e600cf5298e1d1d9dfa2e9a29d42ee61b41784a52806fcad445a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b99613f30252eee9f17472cde76db74974a3d061f7f40e83cea718119c2acf0c5b8cc07a3821e7398264241e5780b73a2f1c1308bba14622dc9552dabb43c7b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/672c9e5edbce65107800ec90e63dd9d00de78adae38cedd2794d6c70f40cacd68d3e7ef002d5ef048b8aaf51445613e8580affbbbb01da8b5d624e03d05b2d77"} 00:12:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:12:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:12:28 INFO - Contents: 00:12:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140666db3bd5c09d760b155c99652e6b49b8d2bd02b2a396c8e9f5f567652b9cc0e808b09c6e600cf5298e1d1d9dfa2e9a29d42ee61b41784a52806fcad445a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b99613f30252eee9f17472cde76db74974a3d061f7f40e83cea718119c2acf0c5b8cc07a3821e7398264241e5780b73a2f1c1308bba14622dc9552dabb43c7b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/672c9e5edbce65107800ec90e63dd9d00de78adae38cedd2794d6c70f40cacd68d3e7ef002d5ef048b8aaf51445613e8580affbbbb01da8b5d624e03d05b2d77"} 00:12:28 INFO - Running post-run listener: copy_logs_to_upload_dir 00:12:28 INFO - Copying logs to upload dir... 00:12:28 INFO - mkdir: /builds/slave/test/build/upload/logs 00:12:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.822217 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-24 00:12:28.617818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 00:12:28.621233) ========= 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=1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140666db3bd5c09d760b155c99652e6b49b8d2bd02b2a396c8e9f5f567652b9cc0e808b09c6e600cf5298e1d1d9dfa2e9a29d42ee61b41784a52806fcad445a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b99613f30252eee9f17472cde76db74974a3d061f7f40e83cea718119c2acf0c5b8cc07a3821e7398264241e5780b73a2f1c1308bba14622dc9552dabb43c7b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/672c9e5edbce65107800ec90e63dd9d00de78adae38cedd2794d6c70f40cacd68d3e7ef002d5ef048b8aaf51445613e8580affbbbb01da8b5d624e03d05b2d77"} build_url:https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/Thcrg7fcTDKKUb3gQGb_sA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140666db3bd5c09d760b155c99652e6b49b8d2bd02b2a396c8e9f5f567652b9cc0e808b09c6e600cf5298e1d1d9dfa2e9a29d42ee61b41784a52806fcad445a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b99613f30252eee9f17472cde76db74974a3d061f7f40e83cea718119c2acf0c5b8cc07a3821e7398264241e5780b73a2f1c1308bba14622dc9552dabb43c7b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/672c9e5edbce65107800ec90e63dd9d00de78adae38cedd2794d6c70f40cacd68d3e7ef002d5ef048b8aaf51445613e8580affbbbb01da8b5d624e03d05b2d77"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 00:12:28.651087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 00:12:28.651661) ========= 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=1f5564757af27664ca02d71f000001b0-1485243986.802460-207836499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 00:12:28.735558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 00:12:28.735922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 00:12:28.736203) ========= ========= Total master_lag: 0.18 =========